freeswan/klips/test/west-icmp-01/spi1-console.txt

   1 Program invoked with PATH/start.sh spi1-in.sh
   2
   3 Starting UML PATH/start.sh
   4 spawn PATH single
   5 tracing thread pid = XXXXX
   6 Linux version XXXX
   7 On node 0 totalpages: 8192
   8 zone(0): 0 pages.
   9 zone(1): 8192 pages.
  10 zone(2): 0 pages.
  11 Kernel command line:
  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
  23 Starting kswapd
  24 VFS: Diskquotas version dquot_6.4.0 initialized
  25 devfs: VERSION Richard Gooch (rgooch@atnf.csiro.au)
  26 devfs: boot_options Q
  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
  31
  32 Netdevice 1 : daemon backend- ethernet address = 10:0:0:64:64:45
  33
  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
  49 Mounted devfs on /dev
  50 INIT: version 2.78 booting
  51 Activating swap...
  52 Calculating module dependancies
  53 done.
  54 Loading modules: LIST
  55
  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:~# enckey=0x4043434545464649494a4a4c4c4f4f515152525454575758
  75 west:~# ipsec klipsdebug --set pfkey
  76 klips_debug:pfkey_x_debug_process: set
  77 klips_debug:pfkey_msg_interp: parsing message type 16 with msg_parser ABCDABCD
  78 klips_debug:pfkey_x_msg_debug_parse: .
  79 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
  80 klips_debug:pfkey_destroy_socket: STUFF
  81 klips_debug:pfkey_remove_socket: .
  82 klips_debug:pfkey_remove_socket: succeeded.
  83 klips_debug:pfkey_destroy_socket: STUFF
  84 klips_debug:pfkey_destroy_socket: STUFF
  85 klips_debug:pfkey_destroy_socket: STUFF
  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_list_remove_socket: removing sock=ABCDABCD
  99 klips_debug:pfkey_release: succeeded.
 100 west:~# ipsec klipsdebug --set verbose
 101 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
 102 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
 103 klips_debug:pfkey_insert_socket: sk=ABCDABCD
 104 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
 105 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
 106 klips_debug:pfkey_sendmsg: .
 107 klips_debug:pfkey_sendmsg: msg sent for parsing.
 108 klips_debug:pfkey_msg_interp: parsing message ver=2, type=16, errno=0, satype=0(UNKNOWN), len=9, res=0, seq=1, pid=987.
 109 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
 110 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
 111 klips_debug:pfkey_msg_interp: processing ext 25 ABCDABCD with processor ABCDABCD
 112 klips_debug:pfkey_x_debug_process: .
 113 klips_debug:pfkey_x_debug_process: set
 114 klips_debug:pfkey_msg_interp: parsing message type 16 with msg_parser ABCDABCD
 115 klips_debug:pfkey_x_msg_debug_parse: .
 116 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
 117 klips_debug:pfkey_destroy_socket: STUFF
 118 klips_debug:pfkey_remove_socket: .
 119 klips_debug:pfkey_remove_socket: succeeded.
 120 klips_debug:pfkey_destroy_socket: STUFF
 121 klips_debug:pfkey_destroy_socket: STUFF
 122 klips_debug:pfkey_destroy_socket: STUFF
 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_list_remove_socket: removing sock=ABCDABCD
 136 klips_debug:pfkey_release: succeeded.
 137 west:~# ipsec spi --af inet --edst 192.1.2.45 --spi 0x12345678 --proto esp --src  192.1.2.23 --esp 3des-md5-96 --enckey $enckey --authkey 0x876587658765876587658 76587658765
 138 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
 139 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
 140 klips_debug:pfkey_insert_socket: sk=ABCDABCD
 141 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
 142 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
 143 klips_debug:pfkey_sendmsg: .
 144 klips_debug:pfkey_sendmsg: msg sent for parsing.
 145 klips_debug:pfkey_msg_interp: parsing message ver=2, type=3, errno=0, satype=3(ESP), len=17, res=0, seq=1, pid=987.
 146 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
 147 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
 148 klips_debug:pfkey_msg_interp: satype 3 lookups to proto=50.
 149 klips_debug:pfkey_msg_interp: processing ext 1 ABCDABCD with processor ABCDABCD
 150 klips_debug:pfkey_sa_process: .
 151 klips_debug:pfkey_msg_interp: processing ext 5 ABCDABCD with processor ABCDABCD
 152 klips_debug:pfkey_address_process:
 153 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.23.
 154 klips_debug:pfkey_address_process: found src address.
 155 klips_debug:pfkey_address_process: successful.
 156 klips_debug:pfkey_msg_interp: processing ext 6 ABCDABCD with processor ABCDABCD
 157 klips_debug:pfkey_address_process:
 158 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.45.
 159 klips_debug:pfkey_address_process: found dst address.
 160 klips_debug:pfkey_address_process: tdb_said.dst set to 192.1.2.45.
 161 klips_debug:pfkey_address_process: successful.
 162 klips_debug:pfkey_msg_interp: processing ext 8 ABCDABCD with processor ABCDABCD
 163 klips_debug:pfkey_key_process: .
 164 klips_debug:pfkey_key_process: success.
 165 klips_debug:pfkey_msg_interp: processing ext 9 ABCDABCD with processor ABCDABCD
 166 klips_debug:pfkey_key_process: .
 167 klips_debug:pfkey_key_process: success.
 168 klips_debug:pfkey_msg_interp: parsing message type 3 with msg_parser ABCDABCD
 169 klips_debug:pfkey_add_parse: .
 170 klips_debug:pfkey_add_parse: existing Tunnel Descriptor Block not found (this is good) for SAesp0x12345678@192.1.2.45, in-bound, allocating.
 171 klips_debug:pfkey_ipsec_sa_init: (pfkey defined) called for SA:esp0x12345678@192.1.2.45
 172 klips_debug:pfkey_ipsec_sa_init: calling init routine of ESP_3DES_HMAC_MD5
 173 klips_debug:pfkey_msg_hdr_build:
 174 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 175 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 176 klips_debug:pfkey_safe_build: error=0
 177 klips_debug:pfkey_safe_build:success.
 178 klips_debug:pfkey_sa_build: spi=12345678 replay=0 sa_state=1 auth=2 encrypt=3 flags=1
 179 klips_debug:pfkey_safe_build: error=0
 180 klips_debug:pfkey_safe_build:success.
 181 klips_debug:pfkey_address_build: exttype=5 proto=0 prefixlen=0
 182 klips_debug:pfkey_address_build: found address family AF_INET.
 183 klips_debug:pfkey_address_build: found address=192.1.2.23:0.
 184 klips_debug:pfkey_address_build: successful.
 185 klips_debug:pfkey_safe_build: error=0
 186 klips_debug:pfkey_safe_build:success.
 187 klips_debug:pfkey_address_build: exttype=6 proto=0 prefixlen=0
 188 klips_debug:pfkey_address_build: found address family AF_INET.
 189 klips_debug:pfkey_address_build: found address=192.1.2.45:0.
 190 klips_debug:pfkey_address_build: successful.
 191 klips_debug:pfkey_safe_build: error=0
 192 klips_debug:pfkey_safe_build:success.
 193 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 80 bytes, &(extensions[0])=ABCDABCD
 194 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[1]=ABCDABCD to=ABCDABCD
 195 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[5]=ABCDABCD to=ABCDABCD
 196 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[6]=ABCDABCD to=ABCDABCD
 197 klips_debug:pfkey_msg_build: extensions permitted=00001c7b, seen=00000063, required=00000063.
 198 klips_debug:pfkey_upmsg: allocating 80 bytes...
 199 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
 200 klips_debug:pfkey_add_parse: sending up add reply message for satype=3(ESP) to socket=ABCDABCD succeeded.
 201 klips_debug:pfkey_add_parse: successful for SA: esp0x12345678@192.1.2.45
 202 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
 203 klips_debug:pfkey_destroy_socket: STUFF
 204 klips_debug:pfkey_remove_socket: .
 205 klips_debug:pfkey_remove_socket: succeeded.
 206 klips_debug:pfkey_destroy_socket: STUFF
 207 klips_debug:pfkey_destroy_socket: STUFF
 208 klips_debug:pfkey_destroy_socket: STUFF
 209 klips_debug:pfkey_destroy_socket: STUFF
 210 klips_debug:pfkey_destroy_socket: STUFF
 211 klips_debug:pfkey_destroy_socket: STUFF
 212 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 213 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 214 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 215 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 216 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 217 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 218 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 219 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 220 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 221 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 222 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 223 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 224 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 225 klips_debug:pfkey_release: succeeded.
 226 west:~# ipsec spi --af inet --edst 192.1.2.45 --spi 0x12345678 --proto tun --src  192.1.2.23 --dst 192.1.2.45 --ip4
 227 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
 228 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
 229 klips_debug:pfkey_insert_socket: sk=ABCDABCD
 230 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
 231 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
 232 klips_debug:pfkey_sendmsg: .
 233 klips_debug:pfkey_sendmsg: msg sent for parsing.
 234 klips_debug:pfkey_msg_interp: parsing message ver=2, type=3, errno=0, satype=9(IPIP), len=10, res=0, seq=1, pid=987.
 235 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
 236 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
 237 klips_debug:pfkey_msg_interp: satype 9 lookups to proto=4.
 238 klips_debug:pfkey_msg_interp: processing ext 1 ABCDABCD with processor ABCDABCD
 239 klips_debug:pfkey_sa_process: .
 240 klips_debug:pfkey_msg_interp: processing ext 5 ABCDABCD with processor ABCDABCD
 241 klips_debug:pfkey_address_process:
 242 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.23.
 243 klips_debug:pfkey_address_process: found src address.
 244 klips_debug:pfkey_address_process: successful.
 245 klips_debug:pfkey_msg_interp: processing ext 6 ABCDABCD with processor ABCDABCD
 246 klips_debug:pfkey_address_process:
 247 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.45.
 248 klips_debug:pfkey_address_process: found dst address.
 249 klips_debug:pfkey_address_process: tdb_said.dst set to 192.1.2.45.
 250 klips_debug:pfkey_address_process: successful.
 251 klips_debug:pfkey_msg_interp: parsing message type 3 with msg_parser ABCDABCD
 252 klips_debug:pfkey_add_parse: .
 253 klips_debug:pfkey_add_parse: existing Tunnel Descriptor Block not found (this is good) for SAtun0x12345678@192.1.2.45, in-bound, allocating.
 254 klips_debug:pfkey_ipsec_sa_init: (pfkey defined) called for SA:tun0x12345678@192.1.2.45
 255 klips_debug:pfkey_ipsec_sa_init: calling init routine of IPIP
 256 klips_debug:pfkey_ipsec_sa_init: (pfkey defined) IPIP tdb set for 192.1.2.23->192.1.2.45.
 257 klips_debug:pfkey_msg_hdr_build:
 258 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 259 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 260 klips_debug:pfkey_safe_build: error=0
 261 klips_debug:pfkey_safe_build:success.
 262 klips_debug:pfkey_sa_build: spi=12345678 replay=0 sa_state=1 auth=0 encrypt=0 flags=1
 263 klips_debug:pfkey_safe_build: error=0
 264 klips_debug:pfkey_safe_build:success.
 265 klips_debug:pfkey_address_build: exttype=5 proto=0 prefixlen=0
 266 klips_debug:pfkey_address_build: found address family AF_INET.
 267 klips_debug:pfkey_address_build: found address=192.1.2.23:0.
 268 klips_debug:pfkey_address_build: successful.
 269 klips_debug:pfkey_safe_build: error=0
 270 klips_debug:pfkey_safe_build:success.
 271 klips_debug:pfkey_address_build: exttype=6 proto=0 prefixlen=0
 272 klips_debug:pfkey_address_build: found address family AF_INET.
 273 klips_debug:pfkey_address_build: found address=192.1.2.45:0.
 274 klips_debug:pfkey_address_build: successful.
 275 klips_debug:pfkey_safe_build: error=0
 276 klips_debug:pfkey_safe_build:success.
 277 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 80 bytes, &(extensions[0])=ABCDABCD
 278 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[1]=ABCDABCD to=ABCDABCD
 279 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[5]=ABCDABCD to=ABCDABCD
 280 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[6]=ABCDABCD to=ABCDABCD
 281 klips_debug:pfkey_msg_build: extensions permitted=00001c7b, seen=00000063, required=00000063.
 282 klips_debug:pfkey_upmsg: allocating 80 bytes...
 283 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
 284 klips_debug:pfkey_add_parse: sending up add reply message for satype=9(IPIP) to socket=ABCDABCD succeeded.
 285 klips_debug:pfkey_add_parse: successful for SA: tun0x12345678@192.1.2.45
 286 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
 287 klips_debug:pfkey_destroy_socket: STUFF
 288 klips_debug:pfkey_remove_socket: .
 289 klips_debug:pfkey_remove_socket: succeeded.
 290 klips_debug:pfkey_destroy_socket: STUFF
 291 klips_debug:pfkey_destroy_socket: STUFF
 292 klips_debug:pfkey_destroy_socket: STUFF
 293 klips_debug:pfkey_destroy_socket: STUFF
 294 klips_debug:pfkey_destroy_socket: STUFF
 295 klips_debug:pfkey_destroy_socket: STUFF
 296 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 297 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 298 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 299 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 300 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 301 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 302 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 303 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 304 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 305 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 306 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 307 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 308 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 309 klips_debug:pfkey_release: succeeded.
 310 west:~# ipsec spigrp inet 192.1.2.45 0x12345678 tun inet 192.1.2.45 0x12345678 e sp
 311 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
 312 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
 313 klips_debug:pfkey_insert_socket: sk=ABCDABCD
 314 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
 315 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
 316 klips_debug:pfkey_sendmsg: .
 317 klips_debug:pfkey_sendmsg: msg sent for parsing.
 318 klips_debug:pfkey_msg_interp: parsing message ver=2, type=13, errno=0, satype=9(IPIP), len=13, res=0, seq=1, pid=987.
 319 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
 320 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
 321 klips_debug:pfkey_msg_interp: satype 9 lookups to proto=4.
 322 klips_debug:pfkey_msg_interp: processing ext 1 ABCDABCD with processor ABCDABCD
 323 klips_debug:pfkey_sa_process: .
 324 klips_debug:pfkey_msg_interp: processing ext 6 ABCDABCD with processor ABCDABCD
 325 klips_debug:pfkey_address_process:
 326 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.45.
 327 klips_debug:pfkey_address_process: found dst address.
 328 klips_debug:pfkey_address_process: tdb_said.dst set to 192.1.2.45.
 329 klips_debug:pfkey_address_process: successful.
 330 klips_debug:pfkey_msg_interp: processing ext 18 ABCDABCD with processor ABCDABCD
 331 klips_debug:pfkey_x_satype_process: .
 332 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
 333 klips_debug:pfkey_x_satype_process: protocol==50 decoded from satype==3(ESP).
 334 klips_debug:pfkey_msg_interp: processing ext 19 ABCDABCD with processor ABCDABCD
 335 klips_debug:pfkey_sa_process: .
 336 klips_debug:pfkey_alloc_ipsec_sa: tdb struct already allocated
 337 klips_debug:pfkey_msg_interp: processing ext 20 ABCDABCD with processor ABCDABCD
 338 klips_debug:pfkey_address_process:
 339 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.45.
 340 klips_debug:pfkey_address_process: found 2nd dst address.
 341 klips_debug:pfkey_alloc_ipsec_sa: tdb struct already allocated
 342 klips_debug:pfkey_address_process: tdb_said.dst set to 192.1.2.45.
 343 klips_debug:pfkey_address_process: successful.
 344 klips_debug:pfkey_msg_interp: parsing message type 13 with msg_parser ABCDABCD
 345 klips_debug:pfkey_x_grpsa_parse: .
 346 klips_debug:pfkey_msg_hdr_build:
 347 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 348 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 349 klips_debug:pfkey_safe_build: error=0
 350 klips_debug:pfkey_safe_build:success.
 351 klips_debug:pfkey_sa_build: spi=12345678 replay=0 sa_state=0 auth=0 encrypt=0 flags=0
 352 klips_debug:pfkey_safe_build: error=0
 353 klips_debug:pfkey_safe_build:success.
 354 klips_debug:pfkey_address_build: exttype=6 proto=0 prefixlen=0
 355 klips_debug:pfkey_address_build: found address family AF_INET.
 356 klips_debug:pfkey_address_build: found address=192.1.2.45:0.
 357 klips_debug:pfkey_address_build: successful.
 358 klips_debug:pfkey_safe_build: error=0
 359 klips_debug:pfkey_safe_build:success.
 360 klips_debug:pfkey_x_satype_build:
 361 klips_debug:pfkey_safe_build: error=0
 362 klips_debug:pfkey_safe_build:success.
 363 klips_debug:pfkey_sa_build: spi=12345678 replay=0 sa_state=0 auth=0 encrypt=0 flags=0
 364 klips_debug:pfkey_safe_build: error=0
 365 klips_debug:pfkey_safe_build:success.
 366 klips_debug:pfkey_address_build: exttype=20 proto=0 prefixlen=0
 367 klips_debug:pfkey_address_build: found address family AF_INET.
 368 klips_debug:pfkey_address_build: found address=192.1.2.45:0.
 369 klips_debug:pfkey_address_build: successful.
 370 klips_debug:pfkey_safe_build: error=0
 371 klips_debug:pfkey_safe_build:success.
 372 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 104 bytes, &(extensions[0])=ABCDABCD
 373 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[1]=ABCDABCD to=ABCDABCD
 374 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[6]=ABCDABCD to=ABCDABCD
 375 klips_debug:pfkey_msg_build: copying 8 bytes from extensions[18]=ABCDABCD to=ABCDABCD
 376 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[19]=ABCDABCD to=ABCDABCD
 377 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[20]=ABCDABCD to=ABCDABCD
 378 klips_debug:pfkey_msg_build: extensions permitted=001c0043, seen=001c0043, required=00000043.
 379 klips_debug:pfkey_upmsg: allocating 104 bytes...
 380 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
 381 klips_debug:pfkey_x_grpsa_parse: sending up x_grpsa reply message for satype=9(IPIP) to socket=ABCDABCD succeeded.
 382 klips_debug:pfkey_x_grpsa_parse: succeeded in sending x_grpsa reply message.
 383 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
 384 klips_debug:pfkey_destroy_socket: STUFF
 385 klips_debug:pfkey_remove_socket: .
 386 klips_debug:pfkey_remove_socket: succeeded.
 387 klips_debug:pfkey_destroy_socket: STUFF
 388 klips_debug:pfkey_destroy_socket: STUFF
 389 klips_debug:pfkey_destroy_socket: STUFF
 390 klips_debug:pfkey_destroy_socket: STUFF
 391 klips_debug:pfkey_destroy_socket: STUFF
 392 klips_debug:pfkey_destroy_socket: STUFF
 393 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 394 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 395 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 396 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 397 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 398 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 399 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 400 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 401 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 402 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 403 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 404 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 405 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 406 klips_debug:pfkey_release: succeeded.
 407 west:~# ipsec eroute --add --eraf inet --src 192.0.2.0/24 --dst 192.0.1.0/24 --s aid tun0x12345678@192.1.2.45
 408 klips_debug:pfkey_create: sock=ABCDABCD type:3 state:1 flags:0 protocol:2
 409 klips_debug:pfkey_create: sock->fasync_list=00000000 sk->sleep=ABCDABCD
 410 klips_debug:pfkey_insert_socket: sk=ABCDABCD
 411 klips_debug:pfkey_list_insert_socket: socketp=ABCDABCD
 412 klips_debug:pfkey_create: Socket sock=ABCDABCD sk=ABCDABCD initialised.
 413 klips_debug:pfkey_sendmsg: .
 414 klips_debug:pfkey_sendmsg: msg sent for parsing.
 415 klips_debug:pfkey_msg_interp: parsing message ver=2, type=14, errno=0, satype=9(IPIP), len=22, res=0, seq=1, pid=987.
 416 klips_debug:pfkey_alloc_ipsec_sa: allocated tdb struct=ABDCABCD
 417 klips_debug:pfkey_msg_interp: allocated extr->tdb=ABCDABCD
 418 klips_debug:pfkey_msg_interp: satype 9 lookups to proto=4.
 419 klips_debug:pfkey_msg_interp: processing ext 1 ABCDABCD with processor ABCDABCD
 420 klips_debug:pfkey_sa_process: .
 421 klips_debug:pfkey_msg_interp: processing ext 5 ABCDABCD with processor ABCDABCD
 422 klips_debug:pfkey_address_process:
 423 klips_debug:pfkey_address_process: found address family=2, AF_INET, 0.0.0.0.
 424 klips_debug:pfkey_address_process: found src address.
 425 klips_debug:pfkey_address_process: successful.
 426 klips_debug:pfkey_msg_interp: processing ext 6 ABCDABCD with processor ABCDABCD
 427 klips_debug:pfkey_address_process:
 428 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.1.2.45.
 429 klips_debug:pfkey_address_process: found dst address.
 430 klips_debug:pfkey_address_process: tdb_said.dst set to 192.1.2.45.
 431 klips_debug:pfkey_address_process: successful.
 432 klips_debug:pfkey_msg_interp: processing ext 21 ABCDABCD with processor ABCDABCD
 433 klips_debug:pfkey_address_process:
 434 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.0.2.0.
 435 klips_debug:pfkey_address_process: found src flow address.
 436 klips_debug:pfkey_alloc_eroute: allocated eroute struct=ABCDABCD
 437 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.2.0/0->0.0.0.0/0
 438 klips_debug:pfkey_address_process: successful.
 439 klips_debug:pfkey_msg_interp: processing ext 22 ABCDABCD with processor ABCDABCD
 440 klips_debug:pfkey_address_process:
 441 klips_debug:pfkey_address_process: found address family=2, AF_INET, 192.0.1.0.
 442 klips_debug:pfkey_address_process: found dst flow address.
 443 klips_debug:pfkey_alloc_eroute: eroute struct already allocated
 444 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.2.0/0->192.0.1.0/0
 445 klips_debug:pfkey_address_process: successful.
 446 klips_debug:pfkey_msg_interp: processing ext 23 ABCDABCD with processor ABCDABCD
 447 klips_debug:pfkey_address_process:
 448 klips_debug:pfkey_address_process: found address family=2, AF_INET, 255.255.255.0.
 449 klips_debug:pfkey_address_process: found src mask address.
 450 klips_debug:pfkey_alloc_eroute: eroute struct already allocated
 451 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.2.0/24->192.0.1.0/0
 452 klips_debug:pfkey_address_process: successful.
 453 klips_debug:pfkey_msg_interp: processing ext 24 ABCDABCD with processor ABCDABCD
 454 klips_debug:pfkey_address_process:
 455 klips_debug:pfkey_address_process: found address family=2, AF_INET, 255.255.255.0.
 456 klips_debug:pfkey_address_process: found dst mask address.
 457 klips_debug:pfkey_alloc_eroute: eroute struct already allocated
 458 klips_debug:pfkey_address_parse: extr->eroute set to 192.0.2.0/24->192.0.1.0/24
 459 klips_debug:pfkey_address_process: successful.
 460 klips_debug:pfkey_msg_interp: parsing message type 14 with msg_parser ABCDABCD
 461 klips_debug:pfkey_x_addflow_parse: .
 462 klips_debug:pfkey_x_addflow_parse: calling breakeroute and/or makeroute for 192.0.2.0/24->192.0.1.0/24
 463 klips_debug:pfkey_x_addflow_parse: calling makeroute.
 464 klips_debug:pfkey_x_addflow_parse: makeroute call successful.
 465 klips_debug:pfkey_msg_hdr_build:
 466 klips_debug:pfkey_msg_hdr_build: on_entry &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 467 klips_debug:pfkey_msg_hdr_build: on_exit &pfkey_ext=ABCDABCD pfkey_ext=ABCDABCD *pfkey_ext=ABCDABCD
 468 klips_debug:pfkey_safe_build: error=0
 469 klips_debug:pfkey_safe_build:success.
 470 klips_debug:pfkey_sa_build: spi=12345678 replay=0 sa_state=0 auth=0 encrypt=0 flags=0
 471 klips_debug:pfkey_safe_build: error=0
 472 klips_debug:pfkey_safe_build:success.
 473 klips_debug:pfkey_address_build: exttype=5 proto=0 prefixlen=0
 474 klips_debug:pfkey_address_build: found address family AF_INET.
 475 klips_debug:pfkey_address_build: found address=0.0.0.0:0.
 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_address_build: exttype=6 proto=0 prefixlen=0
 480 klips_debug:pfkey_address_build: found address family AF_INET.
 481 klips_debug:pfkey_address_build: found address=192.1.2.45:0.
 482 klips_debug:pfkey_address_build: successful.
 483 klips_debug:pfkey_safe_build: error=0
 484 klips_debug:pfkey_safe_build:success.
 485 klips_debug:pfkey_address_build: exttype=21 proto=0 prefixlen=0
 486 klips_debug:pfkey_address_build: found address family AF_INET.
 487 klips_debug:pfkey_address_build: found address=192.0.2.0:0.
 488 klips_debug:pfkey_address_build: successful.
 489 klips_debug:pfkey_safe_build: error=0
 490 klips_debug:pfkey_safe_build:success.
 491 klips_debug:pfkey_address_build: exttype=22 proto=0 prefixlen=0
 492 klips_debug:pfkey_address_build: found address family AF_INET.
 493 klips_debug:pfkey_address_build: found address=192.0.1.0:0.
 494 klips_debug:pfkey_address_build: successful.
 495 klips_debug:pfkey_safe_build: error=0
 496 klips_debug:pfkey_safe_build:success.
 497 klips_debug:pfkey_address_build: exttype=23 proto=0 prefixlen=0
 498 klips_debug:pfkey_address_build: found address family AF_INET.
 499 klips_debug:pfkey_address_build: found address=255.255.255.0:0.
 500 klips_debug:pfkey_address_build: successful.
 501 klips_debug:pfkey_safe_build: error=0
 502 klips_debug:pfkey_safe_build:success.
 503 klips_debug:pfkey_address_build: exttype=24 proto=0 prefixlen=0
 504 klips_debug:pfkey_address_build: found address family AF_INET.
 505 klips_debug:pfkey_address_build: found address=255.255.255.0:0.
 506 klips_debug:pfkey_address_build: successful.
 507 klips_debug:pfkey_safe_build: error=0
 508 klips_debug:pfkey_safe_build:success.
 509 klips_debug:pfkey_msg_build: pfkey_msg=ABCDABCD allocated 176 bytes, &(extensions[0])=ABCDABCD
 510 klips_debug:pfkey_msg_build: copying 16 bytes from extensions[1]=ABCDABCD to=ABCDABCD
 511 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[5]=ABCDABCD to=ABCDABCD
 512 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[6]=ABCDABCD to=ABCDABCD
 513 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[21]=ABCDABCD to=ABCDABCD
 514 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[22]=ABCDABCD to=ABCDABCD
 515 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[23]=ABCDABCD to=ABCDABCD
 516 klips_debug:pfkey_msg_build: copying 24 bytes from extensions[24]=ABCDABCD to=ABCDABCD
 517 klips_debug:pfkey_msg_build: extensions permitted=01e00063, seen=01e00063, required=01e00043.
 518 klips_debug:pfkey_upmsg: allocating 176 bytes...
 519 klips_debug:pfkey_upmsg: ...allocated at ABCDABCD
 520 klips_debug:pfkey_x_addflow_parse: sending up x_addflow reply message for satype=9(IPIP) (proto=4) to socket=ABCDABCD succeeded.
 521 klips_debug:pfkey_x_addflow_parse: extr->tdb cleaned up and freed.
 522 klips_debug:pfkey_release: sock=ABCDABCD sk=ABCDABCD
 523 klips_debug:pfkey_destroy_socket: STUFF
 524 klips_debug:pfkey_remove_socket: .
 525 klips_debug:pfkey_remove_socket: succeeded.
 526 klips_debug:pfkey_destroy_socket: STUFF
 527 klips_debug:pfkey_destroy_socket: STUFF
 528 klips_debug:pfkey_destroy_socket: STUFF
 529 klips_debug:pfkey_destroy_socket: STUFF
 530 klips_debug:pfkey_destroy_socket: STUFF
 531 klips_debug:pfkey_destroy_socket: STUFF
 532 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 533 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 534 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 535 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 536 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 537 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 538 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 539 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 540 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 541 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 542 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 543 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 544 klips_debug:pfkey_list_remove_socket: removing sock=ABCDABCD
 545 klips_debug:pfkey_release: succeeded.
 546 west:~# ipsec tncfg --attach --virtual ipsec0 --physical eth1
 547 west:~# ifconfig ipsec0 inet 192.1.2.45 netmask 0xffffff00 broadcast 192.1.2.255  up
 548 west:~# ipsec look
 549 west NOW
 550 192.0.2.0/24       -> 192.0.1.0/24       => tun0x12345678@192.1.2.45 esp0x12345678@192.1.2.45  (0)
 551 ipsec0->eth1 mtu=16260(1500)->1500
 552 esp0x12345678@192.1.2.45 ESP_3DES_HMAC_MD5: dir=in  src=192.1.2.23 iv_bits=64bits iv=0xABCDABCDABCDABCD alen=128 aklen=128 eklen=192 life(c,s,h)=
 553 tun0x12345678@192.1.2.45 IPIP: dir=in  src=192.1.2.23 life(c,s,h)=
 554 Destination     Gateway         Genmask         Flags   MSS Window  irtt Iface
 555 west:~# route add -host 192.0.2.1 gw 192.1.2.23 dev ipsec0
 556 west:~# nbd: module cleaned up.
 557