1 Program invoked with PATH/start.sh spi1.sh
3 Starting UML PATH/start.sh
5 tracing thread pid = XXXXX
7 On node 0 totalpages: 8192
12 Calibrating delay loop... XXXX bogomips
13 Memory: 32244k available
14 Dentry-cache hash table entries: 4096 (order: 3, 32768 bytes)
15 Inode-cache hash table entries: 2048 (order: 2, 16384 bytes)
16 Mount-cache hash table entries: 512 (order: 0, 4096 bytes)
17 Buffer-cache hash table entries: 1024 (order: 0, 4096 bytes)
18 Page-cache hash table entries: 8192 (order: 3, 32768 bytes)
19 POSIX conformance testing by UNIFIX
20 Linux NET4.0 for Linux 2.4
21 Based upon Swansea University Computer Society NET3.039
22 Initializing RT netlink socket
24 VFS: Diskquotas version dquot_6.4.0 initialized
25 devfs: VERSION Richard Gooch (rgooch@atnf.csiro.au)
27 pty: 256 Unix98 ptys configured
28 block: slots and queues
29 RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
30 Netdevice 0 : daemon backend- ethernet address = 10:0:0:ab:cd:ff
32 Netdevice 1 : daemon backend- ethernet address = 10:0:0:64:64:45
34 SLIP: version 0.8.4-NET3.019-NEWTTY (dynamic channels, max=256).
35 loop: loaded (max 8 devices)
36 PPP generic driver version 2.4.1
37 Universal TUN/TAP device driver 1.4 (C)1999-2001 Maxim Krasnyansky
38 NET4: Linux TCP/IP 1.0 for NET4.0
39 IP Protocols: ICMP, UDP, TCP
40 IP: routing cache hash table of 512 buckets, 4Kbytes
41 TCP: Hash tables configured (established 2048 bind 2048)
42 IPv4 over IPv4 tunneling driver
43 GRE over IPv4 tunneling driver
44 klips_info:ipsec_init: KLIPS startup, FreeS/WAN IPSec version: XXXX
45 NET4: Unix domain sockets 1.0/SMP for Linux NET4.0.
46 Initializing stdio console driver
47 Initializing software serial port version 1
48 mconsole initialized on PATH
50 INIT: version 2.78 booting
52 Calculating module dependancies
56 Checking all file systems...
57 Parallelizing fsck version 1.18 (11-Nov-1999)
58 Setting kernel variables.
59 Mounting local filesystems...
60 /dev/ubd/1 on /usr/share type hostfs (ro,/usr/share)
61 /dev/shm on /tmp type tmpfs (rw)
62 /dev/shm on /var/run type tmpfs (rw)
63 devpts on /dev/pts type devpts (rw,mode=0622)
64 Enabling packet forwarding: done.
65 Configuring network interfaces: done.
66 Cleaning: /tmp /var/lock /var/run.
67 Initializing random number generator... done.
68 Recovering nvi editor sessions... done.
69 Give root password for maintenance
70 (or type Control-D for normal startup):
71 west:~# TZ=GMT export TZ
72 west:~# ipsec spi --clear
73 west:~# ipsec eroute --clear
74 west:~# ipsec klipsdebug --set pfkey
75 klips_debug:pfkey_x_debug_process: set
76 klips_debug:pfkey_msg_interp: parsing message type 16 with msg_parser ABCDABCD
77 klips_debug:pfkey_x_msg_debug_parse: .
78 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
79 klips_debug:pfkey_destroy_socket: STUFF
80 klips_debug:pfkey_remove_socket: .
81 klips_debug:pfkey_remove_socket: succeeded.
82 klips_debug:pfkey_destroy_socket: STUFF
83 klips_debug:pfkey_destroy_socket: STUFF
84 klips_debug:pfkey_destroy_socket: STUFF
85 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
86 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
87 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
88 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
89 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
90 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
91 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
92 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
93 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
94 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
95 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
96 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
97 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
98 klips_debug:pfkey_release: succeeded.
99 west:~# ipsec klipsdebug --set verbose
100 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
101 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
102 klips_debug:pfkey_insert_socket: sk=ABCDABCD
103 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
104 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
105 klips_debug:pfkey_sendmsg: .
106 klips_debug:pfkey_sendmsg: msg sent for parsing.
107 klips_debug:pfkey_msg_interp: parsing message ver=2, type=16, errno=0, satype=0(UNKNOWN), len=9, res=0, seq=1, pid=987.
108 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
109 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
110 klips_debug:pfkey_msg_interp: processing ext 25 ABCDABCD with processor ABCDABCD
111 klips_debug:pfkey_x_debug_process: .
112 klips_debug:pfkey_x_debug_process: set
113 klips_debug:pfkey_msg_interp: parsing message type 16 with msg_parser ABCDABCD
114 klips_debug:pfkey_x_msg_debug_parse: .
115 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
116 klips_debug:pfkey_destroy_socket: STUFF
117 klips_debug:pfkey_remove_socket: .
118 klips_debug:pfkey_remove_socket: succeeded.
119 klips_debug:pfkey_destroy_socket: STUFF
120 klips_debug:pfkey_destroy_socket: STUFF
121 klips_debug:pfkey_destroy_socket: STUFF
122 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
123 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
124 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
125 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
126 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
127 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
128 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
129 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
130 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
131 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
132 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
133 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
134 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
135 klips_debug:pfkey_release: succeeded.
136 west:~# ipsec eroute --add --eraf inet --src 192.0.1.0/24 --dst 192.0.2.0/24 --s aid %trap
137 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
138 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
139 klips_debug:pfkey_insert_socket: sk=ABCDABCD
140 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
141 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
142 klips_debug:pfkey_sendmsg: .
143 klips_debug:pfkey_sendmsg: msg sent for parsing.
144 klips_debug:pfkey_msg_interp: parsing message ver=2, type=14, errno=0, satype=11(INT), len=22, res=0, seq=1, pid=987.
145 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
146 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
147 klips_debug:pfkey_msg_interp: satype 11 lookups to proto=61.
148 klips_debug:pfkey_msg_interp: processing ext 1 ABCDABCD with processor ABCDABCD
149 klips_debug:pfkey_sa_process: .
150 klips_debug:pfkey_msg_interp: processing ext 5 ABCDABCD with processor ABCDABCD
151 klips_debug:pfkey_address_process:
152 klips_debug:pfkey_address_process: found address family=2, AF_INET, 0.0.0.0.
153 klips_debug:pfkey_address_process: found src address.
154 klips_debug:pfkey_address_process: successful.
155 klips_debug:pfkey_msg_interp: processing ext 6 ABCDABCD with processor ABCDABCD
156 klips_debug:pfkey_address_process:
157 klips_debug:pfkey_address_process: found address family=2, AF_INET, 0.0.0.0.
158 klips_debug:pfkey_address_process: found dst address.
159 klips_debug:pfkey_address_process: tdb_said.dst set to 0.0.0.0.
160 klips_debug:pfkey_address_process: successful.
161 klips_debug:pfkey_msg_interp: processing ext 21 ABCDABCD with processor ABCDABCD
162 klips_debug:pfkey_address_process:
163 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.0.1.0.
164 klips_debug:pfkey_address_process: found src flow address.
165 klips_debug:pfkey_alloc_eroute: allocated eroute struct=ABCDABCD
166 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.1.0/0->0.0.0.0/0
167 klips_debug:pfkey_address_process: successful.
168 klips_debug:pfkey_msg_interp: processing ext 22 ABCDABCD with processor ABCDABCD
169 klips_debug:pfkey_address_process:
170 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.0.2.0.
171 klips_debug:pfkey_address_process: found dst flow address.
172 klips_debug:pfkey_alloc_eroute: eroute struct already allocated
173 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.1.0/0->192.0.2.0/0
174 klips_debug:pfkey_address_process: successful.
175 klips_debug:pfkey_msg_interp: processing ext 23 ABCDABCD with processor ABCDABCD
176 klips_debug:pfkey_address_process:
177 klips_debug:pfkey_address_process: found address family=2, AF_INET, 255.255.255.0.
178 klips_debug:pfkey_address_process: found src mask address.
179 klips_debug:pfkey_alloc_eroute: eroute struct already allocated
180 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.1.0/24->192.0.2.0/0
181 klips_debug:pfkey_address_process: successful.
182 klips_debug:pfkey_msg_interp: processing ext 24 ABCDABCD with processor ABCDABCD
183 klips_debug:pfkey_address_process:
184 klips_debug:pfkey_address_process: found address family=2, AF_INET, 255.255.255.0.
185 klips_debug:pfkey_address_process: found dst mask address.
186 klips_debug:pfkey_alloc_eroute: eroute struct already allocated
187 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.1.0/24->192.0.2.0/24
188 klips_debug:pfkey_address_process: successful.
189 klips_debug:pfkey_msg_interp: parsing message type 14 with msg_parser ABCDABCD
190 klips_debug:pfkey_x_addflow_parse: .
191 klips_debug:pfkey_x_addflow_parse: calling breakeroute and/or makeroute for 192.0.1.0/24->192.0.2.0/24
192 klips_debug:pfkey_x_addflow_parse: calling makeroute.
193 klips_debug:pfkey_x_addflow_parse: makeroute call successful.
194 klips_debug:pfkey_msg_hdr_build:
195 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
196 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
197 klips_debug:pfkey_safe_build: error=0
198 klips_debug:pfkey_safe_build:success.
199 klips_debug:pfkey_sa_build: spi=00000104 replay=0 sa_state=0 auth=0 encrypt=0 flags=0
200 klips_debug:pfkey_safe_build: error=0
201 klips_debug:pfkey_safe_build:success.
202 klips_debug:pfkey_address_build: exttype=5 proto=0 prefixlen=0
203 klips_debug:pfkey_address_build: found address family AF_INET.
204 klips_debug:pfkey_address_build: found address=0.0.0.0:0.
205 klips_debug:pfkey_address_build: successful.
206 klips_debug:pfkey_safe_build: error=0
207 klips_debug:pfkey_safe_build:success.
208 klips_debug:pfkey_address_build: exttype=6 proto=0 prefixlen=0
209 klips_debug:pfkey_address_build: found address family AF_INET.
210 klips_debug:pfkey_address_build: found address=0.0.0.0:0.
211 klips_debug:pfkey_address_build: successful.
212 klips_debug:pfkey_safe_build: error=0
213 klips_debug:pfkey_safe_build:success.
214 klips_debug:pfkey_address_build: exttype=21 proto=0 prefixlen=0
215 klips_debug:pfkey_address_build: found address family AF_INET.
216 klips_debug:pfkey_address_build: found address=192.0.1.0:0.
217 klips_debug:pfkey_address_build: successful.
218 klips_debug:pfkey_safe_build: error=0
219 klips_debug:pfkey_safe_build:success.
220 klips_debug:pfkey_address_build: exttype=22 proto=0 prefixlen=0
221 klips_debug:pfkey_address_build: found address family AF_INET.
222 klips_debug:pfkey_address_build: found address=192.0.2.0:0.
223 klips_debug:pfkey_address_build: successful.
224 klips_debug:pfkey_safe_build: error=0
225 klips_debug:pfkey_safe_build:success.
226 klips_debug:pfkey_address_build: exttype=23 proto=0 prefixlen=0
227 klips_debug:pfkey_address_build: found address family AF_INET.
228 klips_debug:pfkey_address_build: found address=255.255.255.0:0.
229 klips_debug:pfkey_address_build: successful.
230 klips_debug:pfkey_safe_build: error=0
231 klips_debug:pfkey_safe_build:success.
232 klips_debug:pfkey_address_build: exttype=24 proto=0 prefixlen=0
233 klips_debug:pfkey_address_build: found address family AF_INET.
234 klips_debug:pfkey_address_build: found address=255.255.255.0:0.
235 klips_debug:pfkey_address_build: successful.
236 klips_debug:pfkey_safe_build: error=0
237 klips_debug:pfkey_safe_build:success.
238 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 176 bytes, &(extensions[0])=ABCDABCD
239 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[1]=ABCDABCD to=ABCDABCD
240 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[5]=ABCDABCD to=ABCDABCD
241 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[6]=ABCDABCD to=ABCDABCD
242 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[21]=ABCDABCD to=ABCDABCD
243 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[22]=ABCDABCD to=ABCDABCD
244 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[23]=ABCDABCD to=ABCDABCD
245 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[24]=ABCDABCD to=ABCDABCD
246 klips_debug:pfkey_msg_build: extensions permitted=01e00063, seen=01e00063, required=01e00043.
247 klips_debug:pfkey_upmsg: allocating 176 bytes...
248 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
249 klips_debug:pfkey_x_addflow_parse: sending up x_addflow reply message for satype=11(INT) (proto=61) to socket=ABCDABCD succeeded.
250 klips_debug:pfkey_x_addflow_parse: extr->tdb cleaned up and freed.
251 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
252 klips_debug:pfkey_destroy_socket: STUFF
253 klips_debug:pfkey_remove_socket: .
254 klips_debug:pfkey_remove_socket: succeeded.
255 klips_debug:pfkey_destroy_socket: STUFF
256 klips_debug:pfkey_destroy_socket: STUFF
257 klips_debug:pfkey_destroy_socket: STUFF
258 klips_debug:pfkey_destroy_socket: STUFF
259 klips_debug:pfkey_destroy_socket: STUFF
260 klips_debug:pfkey_destroy_socket: STUFF
261 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
262 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
263 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
264 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
265 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
266 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
267 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
268 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
269 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
270 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
271 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
272 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
273 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
274 klips_debug:pfkey_release: succeeded.
275 west:~# ipsec tncfg --attach --virtual ipsec0 --physical eth1
276 west:~# ifconfig ipsec0 inet 192.1.2.45 netmask 0xffffff00 broadcast 192.1.2.255 up
277 west:~# arp -s 192.1.2.23 10:00:00:64:64:45
278 west:~# arp -s 192.1.2.254 10:00:00:64:64:45
281 192.0.1.0/24 -> 192.0.2.0/24 => %trap (0)
282 ipsec0->eth1 mtu=16260(1500)->1500
283 Destination Gateway Genmask Flags MSS Window irtt Iface
284 west:~# route add -host 192.0.2.1 gw 192.1.2.23 dev ipsec0
286 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
287 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
288 klips_debug:pfkey_insert_socket: sk=ABCDABCD
289 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
290 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
291 klips_debug:pfkey_sendmsg: .
292 klips_debug:pfkey_sendmsg: msg sent for parsing.
293 klips_debug:pfkey_msg_interp: parsing message ver=2, type=7, errno=0, satype=2(AH), len=2, res=0, seq=1, pid=987.
294 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
295 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
296 klips_debug:pfkey_msg_interp: parsing message type 7 with msg_parser ABCDABCD
297 klips_debug:pfkey_register_parse: .
298 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
299 klips_debug:pfkey_register_parse: SATYPE=02(AH) successfully registered by KMd (pid=130).
300 klips_debug:pfkey_register_parse: pfkey_supported_list[2]=a0884480
301 klips_debug:pfkey_register_parse: checking supported=a0884480
302 klips_debug:pfkey_register_parse: adding auth alg.
303 klips_debug:pfkey_register_parse: checking supported=a0884460
304 klips_debug:pfkey_register_parse: adding auth alg.
305 klips_debug:pfkey_register_parse: adding auth=ABCDABCD
306 klips_debug:pfkey_register_parse: found satype=2(AH) exttype=14 id=3 ivlen=0 minbits=160 maxbits=160.
307 klips_debug:pfkey_register_parse: adding auth=ABCDABCD
308 klips_debug:pfkey_register_parse: found satype=2(AH) exttype=14 id=2 ivlen=0 minbits=128 maxbits=128.
309 klips_debug:pfkey_msg_hdr_build:
310 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
311 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
312 klips_debug:pfkey_safe_build: error=0
313 klips_debug:pfkey_safe_build:success.
314 klips_debug:pfkey_safe_build: error=0
315 klips_debug:pfkey_safe_build:success.
316 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 40 bytes, &(extensions[0])=ABCDABCD
317 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[14]=ABCDABCD to=ABCDABCD
318 klips_debug:pfkey_msg_build: extensions permitted=0000c001, seen=00004001, required=00000001.
319 klips_debug:pfkey_upmsg: allocating 40 bytes...
320 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
321 klips_debug:pfkey_register_parse: sending up register reply message for satype=2(AH) to socket=ABCDABCD succeeded.
322 klips_debug:pfkey_sendmsg: .
323 klips_debug:pfkey_sendmsg: msg sent for parsing.
324 klips_debug:pfkey_msg_interp: parsing message ver=2, type=7, errno=0, satype=3(ESP), len=2, res=0, seq=2, pid=987.
325 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
326 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
327 klips_debug:pfkey_msg_interp: parsing message type 7 with msg_parser ABCDABCD
328 klips_debug:pfkey_register_parse: .
329 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
330 klips_debug:pfkey_register_parse: SATYPE=03(ESP) successfully registered by KMd (pid=130).
331 klips_debug:pfkey_register_parse: pfkey_supported_list[3]=a08844e0
332 klips_debug:pfkey_register_parse: checking supported=a08844e0
333 klips_debug:pfkey_register_parse: adding encrypt alg.
334 klips_debug:pfkey_register_parse: checking supported=a08844c0
335 klips_debug:pfkey_register_parse: adding auth alg.
336 klips_debug:pfkey_register_parse: checking supported=a08844a0
337 klips_debug:pfkey_register_parse: adding auth alg.
338 klips_debug:pfkey_register_parse: adding encrypt=ABCDABCD
339 klips_debug:pfkey_register_parse: found satype=3(ESP) exttype=15 id=3 ivlen=128 minbits=168 maxbits=168.
340 klips_debug:pfkey_register_parse: adding auth=ABCDABCD
341 klips_debug:pfkey_register_parse: found satype=3(ESP) exttype=14 id=3 ivlen=0 minbits=160 maxbits=160.
342 klips_debug:pfkey_register_parse: adding auth=ABCDABCD
343 klips_debug:pfkey_register_parse: found satype=3(ESP) exttype=14 id=2 ivlen=0 minbits=128 maxbits=128.
344 klips_debug:pfkey_msg_hdr_build:
345 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
346 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
347 klips_debug:pfkey_safe_build: error=0
348 klips_debug:pfkey_safe_build:success.
349 klips_debug:pfkey_safe_build: error=0
350 klips_debug:pfkey_safe_build:success.
351 klips_debug:pfkey_safe_build: error=0
352 klips_debug:pfkey_safe_build:success.
353 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 56 bytes, &(extensions[0])=ABCDABCD
354 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[14]=ABCDABCD to=ABCDABCD
355 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[15]=ABCDABCD to=ABCDABCD
356 klips_debug:pfkey_msg_build: extensions permitted=0000c001, seen=0000c001, required=00000001.
357 klips_debug:pfkey_upmsg: allocating 56 bytes...
358 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
359 klips_debug:pfkey_register_parse: sending up register reply message for satype=3(ESP) to socket=ABCDABCD succeeded.
360 klips_debug:pfkey_sendmsg: .
361 klips_debug:pfkey_sendmsg: msg sent for parsing.
362 klips_debug:pfkey_msg_interp: parsing message ver=2, type=7, errno=0, satype=9(IPIP), len=2, res=0, seq=3, pid=987.
363 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
364 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
365 klips_debug:pfkey_msg_interp: parsing message type 7 with msg_parser ABCDABCD
366 klips_debug:pfkey_register_parse: .
367 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
368 klips_debug:pfkey_register_parse: SATYPE=09(IPIP) successfully registered by KMd (pid=130).
369 klips_debug:pfkey_register_parse: pfkey_supported_list[9]=a0884520
370 klips_debug:pfkey_register_parse: checking supported=a0884520
371 klips_debug:pfkey_register_parse: adding encrypt alg.
372 klips_debug:pfkey_register_parse: adding encrypt=ABCDABCD
373 klips_debug:pfkey_register_parse: found satype=9(IPIP) exttype=15 id=1 ivlen=0 minbits=32 maxbits=32.
374 klips_debug:pfkey_msg_hdr_build:
375 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
376 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
377 klips_debug:pfkey_safe_build: error=0
378 klips_debug:pfkey_safe_build:success.
379 klips_debug:pfkey_safe_build: error=0
380 klips_debug:pfkey_safe_build:success.
381 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 32 bytes, &(extensions[0])=ABCDABCD
382 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[15]=ABCDABCD to=ABCDABCD
383 klips_debug:pfkey_msg_build: extensions permitted=0000c001, seen=00008001, required=00000001.
384 klips_debug:pfkey_upmsg: allocating 32 bytes...
385 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
386 klips_debug:pfkey_register_parse: sending up register reply message for satype=9(IPIP) to socket=ABCDABCD succeeded.
387 klips_debug:pfkey_sendmsg: .
388 klips_debug:pfkey_sendmsg: msg sent for parsing.
389 klips_debug:pfkey_msg_interp: parsing message ver=2, type=7, errno=0, satype=10(COMP), len=2, res=0, seq=4, pid=987.
390 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
391 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
392 klips_debug:pfkey_msg_interp: parsing message type 7 with msg_parser ABCDABCD
393 klips_debug:pfkey_register_parse: .
394 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
395 klips_debug:pfkey_register_parse: SATYPE=10(COMP) successfully registered by KMd (pid=130).
396 klips_debug:pfkey_register_parse: pfkey_supported_list[10]=a0884500
397 klips_debug:pfkey_register_parse: checking supported=a0884500
398 klips_debug:pfkey_register_parse: adding encrypt alg.
399 klips_debug:pfkey_register_parse: adding encrypt=ABCDABCD
400 klips_debug:pfkey_register_parse: found satype=10(COMP) exttype=15 id=2 ivlen=0 minbits=1 maxbits=1.
401 klips_debug:pfkey_msg_hdr_build:
402 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
403 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
404 klips_debug:pfkey_safe_build: error=0
405 klips_debug:pfkey_safe_build:success.
406 klips_debug:pfkey_safe_build: error=0
407 klips_debug:pfkey_safe_build:success.
408 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 32 bytes, &(extensions[0])=ABCDABCD
409 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[15]=ABCDABCD to=ABCDABCD
410 klips_debug:pfkey_msg_build: extensions permitted=0000c001, seen=00008001, required=00000001.
411 klips_debug:pfkey_upmsg: allocating 32 bytes...
412 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
413 klips_debug:pfkey_register_parse: sending up register reply message for satype=10(COMP) to socket=ABCDABCD succeeded.
414 klips_debug:pfkey_recvmsg: sock=ABCDABCD sk=ABCDABCD msg=ABCDABCD size=256.
416 pfkey v2 msg. type=7 seq=1 len=5 pid=130 errno=0 satype=2
417 pfkey_lib_debug:pfkey_msg_parse: parsing message ver=2, type=7(register), errno=0, satype=2(AH), len=5, res=0, seq=1, pid=987.
418 pfkey_lib_debug:pfkey_msg_parse: remain=3, ext_type=14(supported-auth), ext_len=3.
419 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, required=00000001.
420 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=14 remain=3.
421 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 14 0xABCDABCD with parser pfkey_supported_parse.
422 pfkey_lib_debug:pfkey_msg_parse: Extension 14 parsed.
423 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, seen=00004001, required=00000001.
424 pf_key: parseable PF_KEY message.
425 klips_debug:pfkey_recvmsg: sock=ABCDABCD sk=ABCDABCD msg=ABCDABCD size=256.
427 pfkey v2 msg. type=7 seq=2 len=7 pid=130 errno=0 satype=3
428 pfkey_lib_debug:pfkey_msg_parse: parsing message ver=2, type=7(register), errno=0, satype=3(ESP), len=7, res=0, seq=2, pid=987.
429 pfkey_lib_debug:pfkey_msg_parse: remain=5, ext_type=14(supported-auth), ext_len=3.
430 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, required=00000001.
431 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=14 remain=5.
432 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 14 0xABCDABCD with parser pfkey_supported_parse.
433 pfkey_lib_debug:pfkey_msg_parse: Extension 14 parsed.
434 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=15 remain=2.
435 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 15 0xABCDABCD with parser pfkey_supported_parse.
436 pfkey_lib_debug:pfkey_msg_parse: Extension 15 parsed.
437 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, seen=0000c001, required=00000001.
438 pf_key: parseable PF_KEY message.
439 klips_debug:pfkey_recvmsg: sock=ABCDABCD sk=ABCDABCD msg=ABCDABCD size=256.
441 pfkey v2 msg. type=7 seq=3 len=4 pid=130 errno=0 satype=9
442 pfkey_lib_debug:pfkey_msg_parse: parsing message ver=2, type=7(register), errno=0, satype=9(IPIP), len=4, res=0, seq=3, pid=987.
443 pfkey_lib_debug:pfkey_msg_parse: remain=2, ext_type=15(supported-cipher), ext_len=2.
444 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, required=00000001.
445 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=15 remain=2.
446 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 15 0xABCDABCD with parser pfkey_supported_parse.
447 pfkey_lib_debug:pfkey_msg_parse: Extension 15 parsed.
448 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, seen=00008001, required=00000001.
449 pf_key: parseable PF_KEY message.
450 klips_debug:pfkey_recvmsg: sock=ABCDABCD sk=ABCDABCD msg=ABCDABCD size=256.
452 pfkey v2 msg. type=7 seq=4 len=4 pid=130 errno=0 satype=10
453 pfkey_lib_debug:pfkey_msg_parse: parsing message ver=2, type=7(register), errno=0, satype=10(COMP), len=4, res=0, seq=4, pid=987.
454 pfkey_lib_debug:pfkey_msg_parse: remain=2, ext_type=15(supported-cipher), ext_len=2.
455 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, required=00000001.
456 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=15 remain=2.
457 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 15 0xABCDABCD with parser pfkey_supported_parse.
458 pfkey_lib_debug:pfkey_msg_parse: Extension 15 parsed.
459 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=0000c001, seen=00008001, required=00000001.
460 pf_key: parseable PF_KEY message.
461 klips_debug:pfkey_recvmsg: sock=ABCDABCD sk=ABCDABCD msg=ABCDABCD size=256.
462 klips_debug:pfkey_msg_hdr_build:
463 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
464 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
465 klips_debug:pfkey_safe_build: error=0
466 klips_debug:pfkey_safe_build:success.
467 klips_debug:pfkey_address_build: exttype=5 proto=17 prefixlen=0
468 klips_debug:pfkey_address_build: found address family AF_INET.
469 klips_debug:pfkey_address_build: found address=192.0.1.2:500.
470 klips_debug:pfkey_address_build: successful.
471 klips_debug:pfkey_safe_build: error=0
472 klips_debug:pfkey_safe_build:success.
473 klips_debug:pfkey_address_build: exttype=6 proto=17 prefixlen=0
474 klips_debug:pfkey_address_build: found address family AF_INET.
475 klips_debug:pfkey_address_build: found address=192.0.2.1:500.
476 klips_debug:pfkey_address_build: successful.
477 klips_debug:pfkey_safe_build: error=0
478 klips_debug:pfkey_safe_build:success.
479 klips_debug:pfkey_prop_build:
480 klips_debug:pfkey_safe_build: error=0
481 klips_debug:pfkey_safe_build:success.
482 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 232 bytes, &(extensions[0])=ABCDABCD
483 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[5]=ABCDABCD to=ABCDABCD
484 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[6]=ABCDABCD to=ABCDABCD
485 klips_debug:pfkey_msg_build: copying 168 bytes from extensions[13]=ABCDABCD to=ABCDABCD
486 klips_debug:pfkey_msg_build: extensions permitted=00003ce1, seen=00002061, required=00002061.
487 klips_debug:pfkey_upmsg: allocating 232 bytes...
488 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
489 klips_debug:pfkey_acquire: sending up acquire message for satype=3(ESP) to socket=a267f720 succeeded.
490 klips_debug:ipsec_tunnel_start_xmit: calling breakeroute and makeroute for 192.0.1.2/32->192.0.2.1/32 HOLD eroute.
491 klips_debug:ipsec_tunnel_start_xmit: breakeroute should have failed. first=00000000, last=00000000
492 klips_debug:ipsec_tunnel_start_xmit: HOLD makeroute call successful.
494 pfkey v2 msg. type=6 seq=1 len=29 pid=0 errno=0 satype=3
495 pfkey_lib_debug:pfkey_msg_parse: parsing message ver=2, type=6(acquire), errno=0, satype=3(ESP), len=29, res=0, seq=1, pid=987.
496 pfkey_lib_debug:pfkey_msg_parse: remain=27, ext_type=5(source-address), ext_len=3.
497 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=00003ce1, required=00002061.
498 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=5 remain=27.
499 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 5 0xABCDABCD with parser pfkey_address_parse.
500 pfkey_lib_debug:pfkey_address_parse: found address family=2, AF_INET.
501 pfkey_lib_debug:pfkey_address_parse: found address=192.0.1.2.
502 pfkey_lib_debug:pfkey_msg_parse: Extension 5 parsed.
503 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=6 remain=24.
504 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 6 0xABCDABCD with parser pfkey_address_parse.
505 pfkey_lib_debug:pfkey_address_parse: found address family=2, AF_INET.
506 pfkey_lib_debug:pfkey_address_parse: found address=192.0.2.1.
507 pfkey_lib_debug:pfkey_msg_parse: Extension 6 parsed.
508 pfkey_lib_debug:pfkey_msg_parse: parsing ext type=13 remain=21.
509 pfkey_lib_debug:pfkey_msg_parse: About to parse extension 13 0xABCDABCD with parser pfkey_prop_parse.
510 pfkey_lib_debug:pfkey_msg_parse: Extension 13 parsed.
511 pfkey_lib_debug:pfkey_msg_parse: extensions permitted=00003ce1, seen=00002061, required=00002061.
512 pf_key: parseable PF_KEY message.
513 klips_debug:pfkey_recvmsg: sock=ABCDABCD sk=ABCDABCD msg=ABCDABCD size=256.
514 nbd: module cleaned up.