INFO:klips_debug:ipsec_sadb_init: initialising main table of size 16 (2 ^ 4). INFO:klips_debug:ipsec_SArefSubTable_alloc: allocating 16384 bytes for table 0 of 16. INFO:klips_debug:ipsec_SArefSubTable_alloc: initialising 4096 elements (2 ^ 12) of table 0. INFO:klips_debug:ipsec_saref_freelist_init: initialising 256 elements of FreeList. INFO:klips_info:ipsec_alg_init: KLIPS alg v=0.8.1-0 (EALG_MAX=255, AALG_MAX=251) INFO:klips_info:ipsec_alg_init: calling ipsec_alg_static_init() ERR;pfkey_list_insert_supported returned -1. Loading anyway. ipsec_aes_init(alg_type=15 alg_id=12 name=aes): ret=0 DEBUG:klips_debug: experimental ipsec_alg_AES_MAC not registered [Ok] (auth_id=0) ERR;pfkey_list_insert_supported returned -1. Loading anyway. ipsec_3des_init(alg_type=15 alg_id=3 name=3des): ret=0 INFO:klips_debug:ipsec_sa_get: ipsec_sa SA:unk0:0@, ref:0 reference count incremented. INFO:klips_debug:ipsec_SAref_alloc: SAref requested... head=0, cont=1, tail=0, listsize=256. INFO:klips_debug:ipsec_SAref_alloc: FreeList empty, recycling... INFO:klips_debug:ipsec_SAref_recycle: recycling, continuing from SAref=1 (0p(nil)), table=0, entry=1. INFO:klips_debug:ipsec_SAref_recycle: SArefFreeList refilled. INFO:klips_debug:ipsec_SAref_alloc: allocating SAref=1, table=0, entry=1 of 65536. INFO:ipsec_sa_alloc: allocated 532 bytes for ipsec_sa struct=0p0xABCDABCD ref=0. INFO:klips_debug:ipsec_sa_get: ipsec_sa SA:unk0:0@, ref:1 reference count incremented. INFO:ipsec_sa_alloc: SAref[1]=0xABCDABCD INFO:klips_debug:ipsec_sa_get: ipsec_sa SA:unk0:0@, ref:0 reference count incremented. INFO:klips_debug:ipsec_SAref_alloc: SAref requested... head=2, cont=256, tail=255, listsize=256. INFO:klips_debug:ipsec_SAref_alloc: allocating SAref=2, table=0, entry=2 of 65536. INFO:ipsec_sa_alloc: allocated 532 bytes for ipsec_sa struct=0p0xABCDABCD ref=0. INFO:klips_debug:ipsec_sa_get: ipsec_sa SA:unk0:0@, ref:2 reference count incremented. INFO:ipsec_sa_alloc: SAref[2]=0xABCDABCD INFO:klips_debug:ipsec_sa_get: ipsec_sa SA:esp:12345678@, ref:2 reference count incremented. SA natt: 2 INFO:klips_debug:ipsec_rcv_decap_once: decap (50) from 192.1.2.23 -> 192.1.2.45 INFO:klips_debug:ipsec_sa_getbyid: linked entry in ipsec_sa table for hash=130 of SA:esp.12345678@192.1.2.45 requested. INFO:klips_debug:ipsec_sa_get: ipsec_sa SA:esp:12345678@, ref:2 reference count incremented. INFO:klips_debug:ipsec_rcv: SA:esp.12345678@192.1.2.45, src=192.1.2.23 of pkt agrees with expected SA source address policy. INFO:klips_debug:ipsec_rcv: SA:esp.12345678@192.1.2.45 First SA in group. INFO:klips_debug:ipsec_rcv: packet from 192.1.2.23 received with seq=1 (iv)=0x282c9987cf62f10c iplen=116 esplen=104 sa=esp.12345678@192.1.2.45 INFO:klips_debug:ipsec_rcv: encalg = 3, authalg = 2. INFO:klips_dmp: at ictx, len=88: INFO:klips_debug: @000: 3e e9 ed c3 3f 8e 3b 10 6b a1 a7 2b b1 09 d0 34 INFO:klips_debug: @010: 00 02 00 00 00 00 00 00 b1 53 b1 53 b1 53 b1 53 INFO:klips_debug: @020: b1 53 b1 53 b1 53 b1 53 36 36 36 36 36 36 36 36 INFO:klips_debug: @030: 36 36 36 36 36 36 36 36 36 36 36 36 36 36 36 36 INFO:klips_debug: @040: 36 36 36 36 36 36 36 36 36 36 36 36 36 36 36 36 INFO:klips_debug: @050: 36 36 36 36 36 36 36 36 INFO:klips_dmp: at mac_esp, len=104: INFO:klips_debug: @000: 12 34 56 78 00 00 00 01 28 2c 99 87 cf 62 f1 0c INFO:klips_debug: @010: c3 1b 6e 11 1a a3 2f 2f 05 ea aa d0 2e a7 0a 0a INFO:klips_debug: @020: 5f a9 1b 00 84 79 c5 15 62 13 0c 5c 45 6f 99 0f INFO:klips_debug: @030: bb 07 01 2a 6e 59 46 3f b1 b9 e5 9e 2c 7b 50 7f INFO:klips_debug: @040: 9f 7c d2 76 89 99 30 21 87 29 e9 66 4f ab 9e bd INFO:klips_debug: @050: 34 d6 49 ac d0 cc 34 03 73 10 04 25 69 ce a1 f5 INFO:klips_debug: @060: e2 7c 02 53 8e 8c 4d 75 INFO:klips_dmp: at hash1, len=16: INFO:klips_debug: @000: d6 8d 40 a8 3e 74 15 34 08 85 eb 1f 52 56 7d 1e INFO:klips_dmp: at octx, len=88: INFO:klips_debug: @000: df 34 22 04 0b 3c 66 d4 7c 72 c3 77 48 0f 0e 2e INFO:klips_debug: @010: 00 02 00 00 00 00 00 00 db 39 db 39 db 39 db 39 INFO:klips_debug: @020: db 39 db 39 db 39 db 39 5c 5c 5c 5c 5c 5c 5c 5c INFO:klips_debug: @030: 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c INFO:klips_debug: @040: 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c 5c INFO:klips_debug: @050: 5c 5c 5c 5c 5c 5c 5c 5c INFO:klips_debug:ipsec_rcv: authentication successful. INFO:klips_debug:ipsec_rcv: encalg=3 esphlen=16 INFO:klips_debug:ipsec_alg_esp_encrypt: entering with encalg=3, ixt_e=0xDEADF00D INFO:klips_debug:ipsec_alg_esp_encrypt: calling cbc_encrypt encalg=3 ips_key_e=0xDEADF00D idat=0xDEADF00D ilen=88 iv=0xDEADF00D, encrypt=0 INFO:klips_debug:ipsec_alg_esp_encrypt: returned ret=1 INFO:klips_dmp: at postdecrypt, len=88: INFO:klips_debug: @000: 45 00 00 54 00 00 40 00 3f 01 b8 a6 c0 00 02 01 INFO:klips_debug: @010: c0 00 01 01 08 00 ba f0 6f 00 05 00 23 9b c7 3b INFO:klips_debug: @020: f2 34 01 00 08 09 0a 0b 0c 0d 0e 0f 10 11 12 13 INFO:klips_debug: @030: 14 15 16 17 18 19 1a 1b 1c 1d 1e 1f 20 21 22 23 INFO:klips_debug: @040: 24 25 26 27 28 29 2a 2b 2c 2d 2e 2f 30 31 32 33 INFO:klips_debug: @050: 34 35 36 37 01 02 02 04 INFO:klips_debug:ipsec_rcv: padlen=2, contents: 0x: 0x 0x ... INFO:klips_debug: 00: 01 02 INFO:klips_debug:ipsec_rcv: packet decrypted from 192.1.2.23: next_header = 4, padding = 2 INFO:klips_dmp: at esp postmove, len=108: INFO:klips_debug: @000: 45 00 00 68 f2 77 00 00 40 32 00 00 c0 01 02 17 INFO:klips_debug: @010: c0 01 02 2d 45 00 00 54 00 00 40 00 3f 01 b8 a6 INFO:klips_debug: @020: c0 00 02 01 c0 00 01 01 08 00 ba f0 6f 00 05 00 INFO:klips_debug: @030: 23 9b c7 3b f2 34 01 00 08 09 0a 0b 0c 0d 0e 0f INFO:klips_debug: @040: 10 11 12 13 14 15 16 17 18 19 1a 1b 1c 1d 1e 1f INFO:klips_debug: @050: 20 21 22 23 24 25 26 27 28 29 2a 2b 2c 2d 2e 2f INFO:klips_debug: @060: 30 31 32 33 34 35 36 37 01 02 02 04 INFO:klips_dmp: at esp postpull, len=100: INFO:klips_debug: @000: 45 00 00 54 00 00 40 00 3f 01 b8 a6 c0 00 02 01 INFO:klips_debug: @010: c0 00 01 01 08 00 ba f0 6f 00 05 00 23 9b c7 3b INFO:klips_debug: @020: f2 34 01 00 08 09 0a 0b 0c 0d 0e 0f 10 11 12 13 INFO:klips_debug: @030: 14 15 16 17 18 19 1a 1b 1c 1d 1e 1f 20 21 22 23 INFO:klips_debug: @040: 24 25 26 27 28 29 2a 2b 2c 2d 2e 2f 30 31 32 33 INFO:klips_debug: @050: 34 35 36 37 01 02 02 04 e1 31 44 7c 35 99 7a 77 INFO:klips_debug: @060: 9b 52 e7 34 INFO:klips_debug:ipsec_rcv: trimming to 84. INFO:klips_debug:ipsec_rcv: after , SA:esp.12345678@192.1.2.45: INFO:klips_debug:ipsec_rcv: SA:esp.12345678@192.1.2.45, Another IPSEC header to process. INFO:klips_debug:ipsec_rcv: ESP SA sets skb->nfmark=0x20000. INFO:klips_debug:ipsec_rcv: IPIP tunnel stripped. INFO:klips_debug:ipsec_rcv: IPIP SA sets skb->nfmark=0x30000. INFO:klips_debug:ipsec_rcv: netif_rx() called. INFO:klips_dmp: at netif_rx, len=84: INFO:klips_debug: @000: 45 00 00 54 00 00 40 00 3f 01 b8 a6 c0 00 02 01 INFO:klips_debug: @010: c0 00 01 01 08 00 ba f0 6f 00 05 00 23 9b c7 3b INFO:klips_debug: @020: f2 34 01 00 08 09 0a 0b 0c 0d 0e 0f 10 11 12 13 INFO:klips_debug: @030: 14 15 16 17 18 19 1a 1b 1c 1d 1e 1f 20 21 22 23 INFO:klips_debug: @040: 24 25 26 27 28 29 2a 2b 2c 2d 2e 2f 30 31 32 33 INFO:klips_debug: @050: 34 35 36 37 INFO:klips_dmp: at shouldbe, len=84: INFO:klips_debug: @000: 45 00 00 54 00 00 40 00 3e 01 b9 a6 c0 00 02 01 INFO:klips_debug: @010: c0 00 01 01 08 00 ba f0 6f 00 05 00 23 9b c7 3b INFO:klips_debug: @020: f2 34 01 00 08 09 0a 0b 0c 0d 0e 0f 10 11 12 13 INFO:klips_debug: @030: 14 15 16 17 18 19 1a 1b 1c 1d 1e 1f 20 21 22 23 INFO:klips_debug: @040: 24 25 26 27 28 29 2a 2b 2c 2d 2e 2f 30 31 32 33 INFO:klips_debug: @050: 34 35 36 37 done