Project

General

Profile

Bug #3163 ยป dhcp6c_debug.log

Wouter Snels, 08/31/2013 04:15 AM

 
1
Aug/31/2013 09:59:50: get_duid: extracted an existing DUID from /var/db/dhcp6c_duid: 00:01:00:01:194
2
Aug/31/2013 09:59:50: dhcp6_ctl_authinit: failed to open /usr/local/etc/dhcp6cctlkey: No such file y
3
Aug/31/2013 09:59:50: client6_init: failed initialize control message authentication
4
Aug/31/2013 09:59:50: client6_init: skip opening control port
5
Aug/31/2013 09:59:50: cfdebug_print: <3>[interface] (9)
6
Aug/31/2013 09:59:50: cfdebug_print: <5>[pppoe0] (6)
7
Aug/31/2013 09:59:50: cfdebug_print: <3>begin of closure [{] (1)
8
Aug/31/2013 09:59:50: cfdebug_print: <3>[send] (4)
9
Aug/31/2013 09:59:50: cfdebug_print: <3>[ia-na] (5)
10
Aug/31/2013 09:59:50: cfdebug_print: <3>[0] (1)
11
Aug/31/2013 09:59:50: cfdebug_print: <3>end of sentence [;] (1)
12
Aug/31/2013 09:59:50: cfdebug_print: <3>comment [# request stateful address] (26)
13
Aug/31/2013 09:59:50: cfdebug_print: <3>[send] (4)
14
Aug/31/2013 09:59:50: cfdebug_print: <3>[ia-pd] (5)
15
Aug/31/2013 09:59:50: cfdebug_print: <3>[0] (1)
16
Aug/31/2013 09:59:50: cfdebug_print: <3>end of sentence [;] (1)
17
Aug/31/2013 09:59:50: cfdebug_print: <3>comment [# request prefix delegation] (27)
18
Aug/31/2013 09:59:50: cfdebug_print: <3>[request] (7)
19
Aug/31/2013 09:59:50: cfdebug_print: <3>[domain-name-servers] (19)
20
Aug/31/2013 09:59:50: cfdebug_print: <3>end of sentence [;] (1)
21
Aug/31/2013 09:59:50: cfdebug_print: <3>[request] (7)
22
Aug/31/2013 09:59:50: cfdebug_print: <3>[domain-name] (11)
23
Aug/31/2013 09:59:50: cfdebug_print: <3>end of sentence [;] (1)
24
Aug/31/2013 09:59:50: cfdebug_print: <3>[script] (6)
25
Aug/31/2013 09:59:50: cfdebug_print: <3>["/var/etc/dhcp6c_wan_script.sh"] (31)
26
Aug/31/2013 09:59:50: cfdebug_print: <3>end of sentence [;] (1)
27
Aug/31/2013 09:59:50: cfdebug_print: <3>comment [# we'd like some nameservers please] (35)
28
Aug/31/2013 09:59:50: cfdebug_print: <3>end of closure [}] (1)
29
Aug/31/2013 09:59:50: cfdebug_print: <3>end of sentence [;] (1)
30
Aug/31/2013 09:59:50: cfdebug_print: <3>[id-assoc] (8)
31
Aug/31/2013 09:59:50: cfdebug_print: <13>[na] (2)
32
Aug/31/2013 09:59:52: cfdebug_print: <13>[0] (1)
33
Aug/31/2013 09:59:52: cfdebug_print: <13>begin of closure [{] (1)
34
Aug/31/2013 09:59:52: cfdebug_print: <3>end of closure [}] (1)
35
Aug/31/2013 09:59:52: cfdebug_print: <3>end of sentence [;] (1)
36
Aug/31/2013 09:59:52: cfdebug_print: <3>[id-assoc] (8)
37
Aug/31/2013 09:59:52: cfdebug_print: <13>[pd] (2)
38
Aug/31/2013 09:59:52: cfdebug_print: <13>[0] (1)
39
Aug/31/2013 09:59:52: cfdebug_print: <13>begin of closure [{] (1)
40
Aug/31/2013 09:59:52: cfdebug_print: <3>end of closure [}] (1)
41
Aug/31/2013 09:59:52: cfdebug_print: <3>end of sentence [;] (1)
42
Aug/31/2013 09:59:52: configure_pool: called
43
Aug/31/2013 09:59:52: clear_poolconf: called
44
Aug/31/2013 09:59:52: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=383
45
Aug/31/2013 09:59:52: client6_send: a new XID (48a457) is generated
46
Aug/31/2013 09:59:52: copy_option: set client ID (len 14)
47
Aug/31/2013 09:59:52: copyout_option: set identity association
48
Aug/31/2013 09:59:52: copy_option: set elapsed time (len 2)
49
Aug/31/2013 09:59:52: copy_option: set option request (len 4)
50
Aug/31/2013 09:59:52: copyout_option: set IA_PD
51
Aug/31/2013 09:59:52: client6_send: send solicit to ff02::1:2%pppoe0
52
Aug/31/2013 09:59:52: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=18
53
Aug/31/2013 09:59:52: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
54
Aug/31/2013 09:59:52: dhcp6_get_options: get DHCP option server ID, len 10
55
Aug/31/2013 09:59:52:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
56
Aug/31/2013 09:59:52: dhcp6_get_options: get DHCP option client ID, len 14
57
Aug/31/2013 09:59:52:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
58
Aug/31/2013 09:59:52: dhcp6_get_options: get DHCP option IA_PD, len 41
59
Aug/31/2013 09:59:52:   IA_PD: ID=0, T1=302400, T2=483840
60
Aug/31/2013 09:59:52: copyin_option: get DHCP option IA_PD prefix, len 25
61
Aug/31/2013 09:59:52: copyin_option:   IA_PD prefix: 2a02:578:xxxx::/48 pltime=604800 vltime=2592000
62
Aug/31/2013 09:59:52: dhcp6_get_options: get DHCP option identity association, len 31
63
Aug/31/2013 09:59:52:   IA_NA: ID=0, T1=0, T2=0
64
Aug/31/2013 09:59:52: copyin_option: get DHCP option status code, len 15
65
Aug/31/2013 09:59:54:   status code: no addresses
66
Aug/31/2013 09:59:54: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
67
Aug/31/2013 09:59:54: dhcp6_timer_rest: a timer must be expired, but not yet
68
Aug/31/2013 09:59:54: client6_recvadvert: reset timer for pppoe0 to 0.000000
69
Aug/31/2013 09:59:54: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
70
Aug/31/2013 09:59:54: client6_send: a new XID (b99dcf) is generated
71
Aug/31/2013 09:59:54: copy_option: set client ID (len 14)
72
Aug/31/2013 09:59:54: copy_option: set server ID (len 10)
73
Aug/31/2013 09:59:54: copyout_option: set status code
74
Aug/31/2013 09:59:54: copyout_option: set identity association
75
Aug/31/2013 09:59:54: copy_option: set elapsed time (len 2)
76
Aug/31/2013 09:59:54: copy_option: set option request (len 4)
77
Aug/31/2013 09:59:54: copyout_option: set IA_PD prefix
78
Aug/31/2013 09:59:54: copyout_option: set IA_PD
79
Aug/31/2013 09:59:54: client6_send: send request to ff02::1:2%pppoe0
80
Aug/31/2013 09:59:54: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=97
81
Aug/31/2013 09:59:54: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
82
Aug/31/2013 09:59:54: dhcp6_get_options: get DHCP option server ID, len 10
83
Aug/31/2013 09:59:54:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
84
Aug/31/2013 09:59:54: dhcp6_get_options: get DHCP option client ID, len 14
85
Aug/31/2013 09:59:54:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
86
Aug/31/2013 09:59:54: dhcp6_get_options: get DHCP option IA_PD, len 41
87
Aug/31/2013 09:59:54:   IA_PD: ID=0, T1=302400, T2=483840
88
Aug/31/2013 09:59:54: copyin_option: get DHCP option IA_PD prefix, len 25
89
Aug/31/2013 09:59:54: copyin_option:   IA_PD prefix: 2a02:578:xxxx::/48 pltime=604800 vltime=2592000
90
Aug/31/2013 09:59:54: dhcp6_get_options: get DHCP option identity association, len 31
91
Aug/31/2013 09:59:54:   IA_NA: ID=0, T1=0, T2=0
92
Aug/31/2013 09:59:54: copyin_option: get DHCP option status code, len 15
93
Aug/31/2013 09:59:54:   status code: no addresses
94
Aug/31/2013 09:59:54: get_ia: make an IA: PD-0
95
Aug/31/2013 09:59:54: update_prefix: create a prefix 2a02:578:xxxx::/48 pltime=604800, vltime=259200
96
Aug/31/2013 09:59:54: get_ia: make an IA: NA-0
97
Aug/31/2013 09:59:57: update_ia: status code for NA-0: no addresses
98
Aug/31/2013 09:59:57: update_ia: IA NA-0 is invalidated
99
Aug/31/2013 09:59:57: remove_ia: remove an IA: NA-0
100
Aug/31/2013 09:59:57: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=915
101
Aug/31/2013 09:59:57: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
102
Aug/31/2013 09:59:59: client6_script: script "/var/etc/dhcp6c_wan_script.sh" terminated
103
Aug/31/2013 09:59:59: dhcp6_remove_event: removing an event on pppoe0, state=REQUEST
104
Aug/31/2013 09:59:59: dhcp6_remove_event: removing server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
105
Aug/31/2013 09:59:59: client6_recvreply: got an expected reply, sleeping.
106
Aug/31/2013 09:59:59: client6_send: a new XID (d57169) is generated
107
Aug/31/2013 09:59:59: copy_option: set client ID (len 14)
108
Aug/31/2013 09:59:59: copyout_option: set identity association
109
Aug/31/2013 09:59:59: copy_option: set elapsed time (len 2)
110
Aug/31/2013 09:59:59: copy_option: set option request (len 4)
111
Aug/31/2013 09:59:59: client6_send: send solicit to ff02::1:2%pppoe0
112
Aug/31/2013 09:59:59: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=19
113
Aug/31/2013 09:59:59: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
114
Aug/31/2013 09:59:59: dhcp6_get_options: get DHCP option server ID, len 10
115
Aug/31/2013 09:59:59:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
116
Aug/31/2013 09:59:59: dhcp6_get_options: get DHCP option client ID, len 14
117
Aug/31/2013 09:59:59:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
118
Aug/31/2013 09:59:59: dhcp6_get_options: get DHCP option identity association, len 31
119
Aug/31/2013 09:59:59:   IA_NA: ID=0, T1=0, T2=0
120
Aug/31/2013 09:59:59: copyin_option: get DHCP option status code, len 15
121
Aug/31/2013 09:59:59:   status code: no addresses
122
Aug/31/2013 09:59:59: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
123
Aug/31/2013 09:59:59: client6_recvadvert: reset timer for pppoe0 to 0.707652
124
Aug/31/2013 10:00:00: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
125
Aug/31/2013 10:00:00: client6_send: a new XID (c9a209) is generated
126
Aug/31/2013 10:00:00: copy_option: set client ID (len 14)
127
Aug/31/2013 10:00:00: copy_option: set server ID (len 10)
128
Aug/31/2013 10:00:00: copyout_option: set status code
129
Aug/31/2013 10:00:00: copyout_option: set identity association
130
Aug/31/2013 10:00:00: copy_option: set elapsed time (len 2)
131
Aug/31/2013 10:00:00: copy_option: set option request (len 4)
132
Aug/31/2013 10:00:00: client6_send: send request to ff02::1:2%pppoe0
133
Aug/31/2013 10:00:00: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=93
134
Aug/31/2013 10:00:00: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
135
Aug/31/2013 10:00:00: dhcp6_get_options: get DHCP option server ID, len 10
136
Aug/31/2013 10:00:00:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
137
Aug/31/2013 10:00:00: dhcp6_get_options: get DHCP option client ID, len 14
138
Aug/31/2013 10:00:00:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
139
Aug/31/2013 10:00:00: dhcp6_get_options: get DHCP option identity association, len 31
140
Aug/31/2013 10:00:00:   IA_NA: ID=0, T1=0, T2=0
141
Aug/31/2013 10:00:00: copyin_option: get DHCP option status code, len 15
142
Aug/31/2013 10:00:00:   status code: no addresses
143
Aug/31/2013 10:00:00: get_ia: make an IA: NA-0
144
Aug/31/2013 10:00:02: update_ia: status code for NA-0: no addresses
145
Aug/31/2013 10:00:02: update_ia: IA NA-0 is invalidated
146
Aug/31/2013 10:00:02: remove_ia: remove an IA: NA-0
147
Aug/31/2013 10:00:02: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=386
148
Aug/31/2013 10:00:02: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
149
Aug/31/2013 10:00:06: client6_script: script "/var/etc/dhcp6c_wan_script.sh" terminated
150
Aug/31/2013 10:00:06: dhcp6_remove_event: removing an event on pppoe0, state=REQUEST
151
Aug/31/2013 10:00:06: dhcp6_remove_event: removing server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
152
Aug/31/2013 10:00:06: client6_recvreply: got an expected reply, sleeping.
153
Aug/31/2013 10:00:06: client6_send: a new XID (38f03b) is generated
154
Aug/31/2013 10:00:06: copy_option: set client ID (len 14)
155
Aug/31/2013 10:00:06: copyout_option: set identity association
156
Aug/31/2013 10:00:06: copy_option: set elapsed time (len 2)
157
Aug/31/2013 10:00:06: copy_option: set option request (len 4)
158
Aug/31/2013 10:00:06: client6_send: send solicit to ff02::1:2%pppoe0
159
Aug/31/2013 10:00:06: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=19
160
Aug/31/2013 10:00:06: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
161
Aug/31/2013 10:00:06: dhcp6_get_options: get DHCP option server ID, len 10
162
Aug/31/2013 10:00:06:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
163
Aug/31/2013 10:00:06: dhcp6_get_options: get DHCP option client ID, len 14
164
Aug/31/2013 10:00:06:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
165
Aug/31/2013 10:00:06: dhcp6_get_options: get DHCP option identity association, len 31
166
Aug/31/2013 10:00:06:   IA_NA: ID=0, T1=0, T2=0
167
Aug/31/2013 10:00:06: copyin_option: get DHCP option status code, len 15
168
Aug/31/2013 10:00:06:   status code: no addresses
169
Aug/31/2013 10:00:06: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
170
Aug/31/2013 10:00:06: client6_recvadvert: reset timer for pppoe0 to 0.990419
171
Aug/31/2013 10:00:07: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
172
Aug/31/2013 10:00:07: client6_send: a new XID (be79fb) is generated
173
Aug/31/2013 10:00:07: copy_option: set client ID (len 14)
174
Aug/31/2013 10:00:07: copy_option: set server ID (len 10)
175
Aug/31/2013 10:00:07: copyout_option: set status code
176
Aug/31/2013 10:00:07: copyout_option: set identity association
177
Aug/31/2013 10:00:07: copy_option: set elapsed time (len 2)
178
Aug/31/2013 10:00:07: copy_option: set option request (len 4)
179
Aug/31/2013 10:00:07: client6_send: send request to ff02::1:2%pppoe0
180
Aug/31/2013 10:00:07: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=94
181
Aug/31/2013 10:00:07: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
182
Aug/31/2013 10:00:07: dhcp6_get_options: get DHCP option server ID, len 10
183
Aug/31/2013 10:00:07:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
184
Aug/31/2013 10:00:07: dhcp6_get_options: get DHCP option client ID, len 14
185
Aug/31/2013 10:00:07:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
186
Aug/31/2013 10:00:07: dhcp6_get_options: get DHCP option identity association, len 31
187
Aug/31/2013 10:00:09:   IA_NA: ID=0, T1=0, T2=0
188
Aug/31/2013 10:00:09: copyin_option: get DHCP option status code, len 15
189
Aug/31/2013 10:00:09:   status code: no addresses
190
Aug/31/2013 10:00:09: get_ia: make an IA: NA-0
191
Aug/31/2013 10:00:09: update_ia: status code for NA-0: no addresses
192
Aug/31/2013 10:00:09: update_ia: IA NA-0 is invalidated
193
Aug/31/2013 10:00:09: remove_ia: remove an IA: NA-0
194
Aug/31/2013 10:00:09: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=421
195
Aug/31/2013 10:00:09: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
196
Aug/31/2013 10:00:11: client6_script: script "/var/etc/dhcp6c_wan_script.sh" terminated
197
Aug/31/2013 10:00:11: dhcp6_remove_event: removing an event on pppoe0, state=REQUEST
198
Aug/31/2013 10:00:11: dhcp6_remove_event: removing server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
199
Aug/31/2013 10:00:11: client6_recvreply: got an expected reply, sleeping.
200
Aug/31/2013 10:00:11: client6_send: a new XID (dcdb71) is generated
201
Aug/31/2013 10:00:11: copy_option: set client ID (len 14)
202
Aug/31/2013 10:00:11: copyout_option: set identity association
203
Aug/31/2013 10:00:11: copy_option: set elapsed time (len 2)
204
Aug/31/2013 10:00:11: copy_option: set option request (len 4)
205
Aug/31/2013 10:00:11: client6_send: send solicit to ff02::1:2%pppoe0
206
Aug/31/2013 10:00:11: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=16
207
Aug/31/2013 10:00:11: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
208
Aug/31/2013 10:00:11: dhcp6_get_options: get DHCP option server ID, len 10
209
Aug/31/2013 10:00:11:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
210
Aug/31/2013 10:00:11: dhcp6_get_options: get DHCP option client ID, len 14
211
Aug/31/2013 10:00:11:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
212
Aug/31/2013 10:00:11: dhcp6_get_options: get DHCP option identity association, len 31
213
Aug/31/2013 10:00:11:   IA_NA: ID=0, T1=0, T2=0
214
Aug/31/2013 10:00:11: copyin_option: get DHCP option status code, len 15
215
Aug/31/2013 10:00:11:   status code: no addresses
216
Aug/31/2013 10:00:11: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
217
Aug/31/2013 10:00:11: client6_recvadvert: reset timer for pppoe0 to 0.982936
218
Aug/31/2013 10:00:12: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
219
Aug/31/2013 10:00:12: client6_send: a new XID (e86cc) is generated
220
Aug/31/2013 10:00:12: copy_option: set client ID (len 14)
221
Aug/31/2013 10:00:12: copy_option: set server ID (len 10)
222
Aug/31/2013 10:00:12: copyout_option: set status code
223
Aug/31/2013 10:00:12: copyout_option: set identity association
224
Aug/31/2013 10:00:12: copy_option: set elapsed time (len 2)
225
Aug/31/2013 10:00:12: copy_option: set option request (len 4)
226
Aug/31/2013 10:00:12: client6_send: send request to ff02::1:2%pppoe0
227
Aug/31/2013 10:00:12: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=92
228
Aug/31/2013 10:00:12: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
229
Aug/31/2013 10:00:12: dhcp6_get_options: get DHCP option server ID, len 10
230
Aug/31/2013 10:00:12:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
231
Aug/31/2013 10:00:12: dhcp6_get_options: get DHCP option client ID, len 14
232
Aug/31/2013 10:00:12:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
233
Aug/31/2013 10:00:12: dhcp6_get_options: get DHCP option identity association, len 31
234
Aug/31/2013 10:00:13:   IA_NA: ID=0, T1=0, T2=0
235
Aug/31/2013 10:00:13: copyin_option: get DHCP option status code, len 15
236
Aug/31/2013 10:00:13:   status code: no addresses
237
Aug/31/2013 10:00:13: get_ia: make an IA: NA-0
238
Aug/31/2013 10:00:13: update_ia: status code for NA-0: no addresses
239
Aug/31/2013 10:00:13: update_ia: IA NA-0 is invalidated
240
Aug/31/2013 10:00:13: remove_ia: remove an IA: NA-0
241
Aug/31/2013 10:00:13: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=690
242
Aug/31/2013 10:00:13: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
243
Aug/31/2013 10:00:15: client6_script: script "/var/etc/dhcp6c_wan_script.sh" terminated
244
Aug/31/2013 10:00:15: dhcp6_remove_event: removing an event on pppoe0, state=REQUEST
245
Aug/31/2013 10:00:15: dhcp6_remove_event: removing server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
246
Aug/31/2013 10:00:15: client6_recvreply: got an expected reply, sleeping.
247
Aug/31/2013 10:00:15: client6_send: a new XID (873f90) is generated
248
Aug/31/2013 10:00:15: copy_option: set client ID (len 14)
249
Aug/31/2013 10:00:15: copyout_option: set identity association
250
Aug/31/2013 10:00:15: copy_option: set elapsed time (len 2)
251
Aug/31/2013 10:00:15: copy_option: set option request (len 4)
252
Aug/31/2013 10:00:15: client6_send: send solicit to ff02::1:2%pppoe0
253
Aug/31/2013 10:00:15: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=16
254
Aug/31/2013 10:00:15: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
255
Aug/31/2013 10:00:15: dhcp6_get_options: get DHCP option server ID, len 10
256
Aug/31/2013 10:00:15:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
257
Aug/31/2013 10:00:15: dhcp6_get_options: get DHCP option client ID, len 14
258
Aug/31/2013 10:00:15:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
259
Aug/31/2013 10:00:15: dhcp6_get_options: get DHCP option identity association, len 31
260
Aug/31/2013 10:00:15:   IA_NA: ID=0, T1=0, T2=0
261
Aug/31/2013 10:00:15: copyin_option: get DHCP option status code, len 15
262
Aug/31/2013 10:00:15:   status code: no addresses
263
Aug/31/2013 10:00:15: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
264
Aug/31/2013 10:00:15: client6_recvadvert: reset timer for pppoe0 to 0.990550
265
Aug/31/2013 10:00:16: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
266
Aug/31/2013 10:00:16: client6_send: a new XID (19b7b6) is generated
267
Aug/31/2013 10:00:16: copy_option: set client ID (len 14)
268
Aug/31/2013 10:00:16: copy_option: set server ID (len 10)
269
Aug/31/2013 10:00:16: copyout_option: set status code
270
Aug/31/2013 10:00:16: copyout_option: set identity association
271
Aug/31/2013 10:00:16: copy_option: set elapsed time (len 2)
272
Aug/31/2013 10:00:16: copy_option: set option request (len 4)
273
Aug/31/2013 10:00:16: client6_send: send request to ff02::1:2%pppoe0
274
Aug/31/2013 10:00:16: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=16
275
Aug/31/2013 10:00:16: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
276
Aug/31/2013 10:00:16: dhcp6_get_options: get DHCP option server ID, len 10
277
Aug/31/2013 10:00:16:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
278
Aug/31/2013 10:00:16: dhcp6_get_options: get DHCP option client ID, len 14
279
Aug/31/2013 10:00:16:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
280
Aug/31/2013 10:00:16: dhcp6_get_options: get DHCP option identity association, len 31
281
Aug/31/2013 10:00:18:   IA_NA: ID=0, T1=0, T2=0
282
Aug/31/2013 10:00:18: copyin_option: get DHCP option status code, len 15
283
Aug/31/2013 10:00:18:   status code: no addresses
284
Aug/31/2013 10:00:18: get_ia: make an IA: NA-0
285
Aug/31/2013 10:00:18: update_ia: status code for NA-0: no addresses
286
Aug/31/2013 10:00:18: update_ia: IA NA-0 is invalidated
287
Aug/31/2013 10:00:18: remove_ia: remove an IA: NA-0
288
Aug/31/2013 10:00:18: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=926
289
Aug/31/2013 10:00:18: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
290
Killed
291
Aug/31/2013 10:00:21: client6_script: script "/var/etc/dhcp6c_wan_script.sh" terminated
292
Aug/31/2013 10:00:21: dhcp6_remove_event: removing an event on pppoe0, state=REQUEST
293
Aug/31/2013 10:00:21: dhcp6_remove_event: removing server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
294
Aug/31/2013 10:00:21: client6_recvreply: got an expected reply, sleeping.
295
Aug/31/2013 10:00:21: client6_send: a new XID (7fa188) is generated
296
Aug/31/2013 10:00:21: copy_option: set client ID (len 14)
297
Aug/31/2013 10:00:21: copyout_option: set identity association
298
Aug/31/2013 10:00:21: copy_option: set elapsed time (len 2)
299
Aug/31/2013 10:00:21: copy_option: set option request (len 4)
300
Aug/31/2013 10:00:21: client6_send: send solicit to ff02::1:2%pppoe0
301
Aug/31/2013 10:00:21: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=14
302
Aug/31/2013 10:00:21: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
303
Aug/31/2013 10:00:21: dhcp6_get_options: get DHCP option server ID, len 10
304
Aug/31/2013 10:00:21:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
305
Aug/31/2013 10:00:21: dhcp6_get_options: get DHCP option client ID, len 14
306
Aug/31/2013 10:00:21:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
307
Aug/31/2013 10:00:21: dhcp6_get_options: get DHCP option identity association, len 31
308
Aug/31/2013 10:00:21:   IA_NA: ID=0, T1=0, T2=0
309
Aug/31/2013 10:00:21: copyin_option: get DHCP option status code, len 15
310
Aug/31/2013 10:00:21:   status code: no addresses
311
Aug/31/2013 10:00:21: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
312
Aug/31/2013 10:00:21: client6_recvadvert: reset timer for pppoe0 to 0.990935
313
Aug/31/2013 10:00:22: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
314
Aug/31/2013 10:00:22: client6_send: a new XID (71a406) is generated
315
Aug/31/2013 10:00:22: copy_option: set client ID (len 14)
316
Aug/31/2013 10:00:22: copy_option: set server ID (len 10)
317
Aug/31/2013 10:00:22: copyout_option: set status code
318
Aug/31/2013 10:00:22: copyout_option: set identity association
319
Aug/31/2013 10:00:22: copy_option: set elapsed time (len 2)
320
Aug/31/2013 10:00:22: copy_option: set option request (len 4)
321
Aug/31/2013 10:00:22: client6_send: send request to ff02::1:2%pppoe0
322
Aug/31/2013 10:00:22: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=12
323
Aug/31/2013 10:00:22: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
324
Aug/31/2013 10:00:22: dhcp6_get_options: get DHCP option server ID, len 10
325
Aug/31/2013 10:00:22:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
326
Aug/31/2013 10:00:22: dhcp6_get_options: get DHCP option client ID, len 14
327
Aug/31/2013 10:00:22:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
328
Aug/31/2013 10:00:22: dhcp6_get_options: get DHCP option identity association, len 31
329
Aug/31/2013 10:00:24:   IA_NA: ID=0, T1=0, T2=0
330
Aug/31/2013 10:00:24: copyin_option: get DHCP option status code, len 15
331
Aug/31/2013 10:00:24:   status code: no addresses
332
Aug/31/2013 10:00:24: get_ia: make an IA: NA-0
333
Aug/31/2013 10:00:24: update_ia: status code for NA-0: no addresses
334
Aug/31/2013 10:00:24: update_ia: IA NA-0 is invalidated
335
Aug/31/2013 10:00:24: remove_ia: remove an IA: NA-0
336
Aug/31/2013 10:00:24: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=172
337
Aug/31/2013 10:00:24: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
338
Killed
339
Aug/31/2013 10:00:26: client6_script: script "/var/etc/dhcp6c_wan_script.sh" terminated
340
Aug/31/2013 10:00:26: dhcp6_remove_event: removing an event on pppoe0, state=REQUEST
341
Aug/31/2013 10:00:26: dhcp6_remove_event: removing server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
342
Aug/31/2013 10:00:26: client6_recvreply: got an expected reply, sleeping.
343
Aug/31/2013 10:00:26: client6_send: a new XID (997385) is generated
344
Aug/31/2013 10:00:26: copy_option: set client ID (len 14)
345
Aug/31/2013 10:00:26: copyout_option: set identity association
346
Aug/31/2013 10:00:26: copy_option: set elapsed time (len 2)
347
Aug/31/2013 10:00:26: copy_option: set option request (len 4)
348
Aug/31/2013 10:00:26: client6_send: send solicit to ff02::1:2%pppoe0
349
Aug/31/2013 10:00:26: dhcp6_reset_timer: reset a timer on pppoe0, state=SOLICIT, timeo=0, retrans=13
350
Aug/31/2013 10:00:26: client6_recv: receive advertise from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
351
Aug/31/2013 10:00:26: dhcp6_get_options: get DHCP option server ID, len 10
352
Aug/31/2013 10:00:26:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
353
Aug/31/2013 10:00:26: dhcp6_get_options: get DHCP option client ID, len 14
354
Aug/31/2013 10:00:26:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
355
Aug/31/2013 10:00:26: dhcp6_get_options: get DHCP option identity association, len 31
356
Aug/31/2013 10:00:26:   IA_NA: ID=0, T1=0, T2=0
357
Aug/31/2013 10:00:26: copyin_option: get DHCP option status code, len 15
358
Aug/31/2013 10:00:26:   status code: no addresses
359
Aug/31/2013 10:00:26: client6_recvadvert: server ID: 00:03:00:01:00:xx:xx:xx:xx:xx, pref=-1
360
Aug/31/2013 10:00:26: client6_recvadvert: reset timer for pppoe0 to 0.990835
361
Aug/31/2013 10:00:27: select_server: picked a server (ID: 00:03:00:01:00:xx:xx:xx:xx:xx)
362
Aug/31/2013 10:00:27: client6_send: a new XID (8ffcca) is generated
363
Aug/31/2013 10:00:27: copy_option: set client ID (len 14)
364
Aug/31/2013 10:00:27: copy_option: set server ID (len 10)
365
Aug/31/2013 10:00:27: copyout_option: set status code
366
Aug/31/2013 10:00:27: copyout_option: set identity association
367
Aug/31/2013 10:00:27: copy_option: set elapsed time (len 2)
368
Aug/31/2013 10:00:27: copy_option: set option request (len 4)
369
Aug/31/2013 10:00:27: client6_send: send request to ff02::1:2%pppoe0
370
Aug/31/2013 10:00:27: dhcp6_reset_timer: reset a timer on pppoe0, state=REQUEST, timeo=0, retrans=11
371
Aug/31/2013 10:00:27: client6_recv: receive reply from fe80::207:xxxx:xxxx:xxxx%pppoe0 on pppoe0
372
Aug/31/2013 10:00:27: dhcp6_get_options: get DHCP option server ID, len 10
373
Aug/31/2013 10:00:27:   DUID: 00:03:00:01:00:xx:xx:xx:xx:xx
374
Aug/31/2013 10:00:27: dhcp6_get_options: get DHCP option client ID, len 14
375
Aug/31/2013 10:00:27:   DUID: 00:01:00:01:19:xx:xx:xx:xx:xx:xx:xx:xx:xx
376
Aug/31/2013 10:00:27: dhcp6_get_options: get DHCP option identity association, len 31
377
Aug/31/2013 10:00:29:   IA_NA: ID=0, T1=0, T2=0
378
Aug/31/2013 10:00:29: copyin_option: get DHCP option status code, len 15
379
Aug/31/2013 10:00:29:   status code: no addresses
380
Aug/31/2013 10:00:29: get_ia: make an IA: NA-0
381
Aug/31/2013 10:00:29: update_ia: status code for NA-0: no addresses
382
Aug/31/2013 10:00:29: update_ia: IA NA-0 is invalidated
383
Aug/31/2013 10:00:29: remove_ia: remove an IA: NA-0
384
Aug/31/2013 10:00:29: dhcp6_reset_timer: reset a timer on pppoe0, state=INIT, timeo=0, retrans=368
385
Aug/31/2013 10:00:29: client6_recvreply: executes /var/etc/dhcp6c_wan_script.sh
    (1-1/1)