2012:08:20-18:52:36 astaro pluto[5146]: | encrypting using 3DES_CBC 2012:08:20-18:52:36 astaro pluto[5146]: | next IV: 05 3d 11 84 c9 07 7e fb 2012:08:20-18:52:36 astaro pluto[5146]: | emitting length of ISAKMP Message: 68 2012:08:20-18:52:36 astaro pluto[5146]: | sending 68 bytes for ISAKMP notify through eth2 to 84.154.25.59:500: 2012:08:20-18:52:36 astaro pluto[5146]: | c6 50 b1 44 e4 81 51 3a cc 33 3c 33 07 2f d1 5b 2012:08:20-18:52:36 astaro pluto[5146]: | 08 10 05 01 9e 49 f9 f3 00 00 00 44 5a b5 ab 19 2012:08:20-18:52:36 astaro pluto[5146]: | 55 59 5b 26 d7 4a dd d3 a1 12 41 97 05 1e 4a e3 2012:08:20-18:52:36 astaro pluto[5146]: | 04 bd 08 4f d5 97 e2 a6 42 84 51 e0 05 3d 11 84 2012:08:20-18:52:36 astaro pluto[5146]: | c9 07 7e fb 2012:08:20-18:52:36 astaro pluto[5146]: | next event EVENT_DPD in 16 seconds for #53 2012:08:20-18:52:55 astaro pluto[5146]: | 2012:08:20-18:52:55 astaro pluto[5146]: | *received 292 bytes from XX.XXX.XX.XX:500 on eth2 2012:08:20-18:52:55 astaro pluto[5146]: | ac d2 fb 14 6f 2b 23 b9 c5 61 40 c7 f3 53 95 73 2012:08:20-18:52:55 astaro pluto[5146]: | 08 10 20 01 e4 e5 11 af 00 00 01 24 11 16 be 80 2012:08:20-18:52:55 astaro pluto[5146]: | b6 b2 6e 70 6b d0 0c 49 b4 a0 b0 a3 bf a1 ec 18 2012:08:20-18:52:55 astaro pluto[5146]: | c7 27 ce 8c 47 27 c2 a1 59 e6 d9 e1 e1 f3 09 e4 2012:08:20-18:52:55 astaro pluto[5146]: | 5c 9c 71 e0 c0 7d 33 f7 f9 43 10 88 ed ce 83 9b 2012:08:20-18:52:55 astaro pluto[5146]: | be ba 90 d4 ca c5 0f 44 7e 0b 37 70 7f 97 b3 f0 2012:08:20-18:52:55 astaro pluto[5146]: | 09 b5 19 dd d0 46 22 c0 7e e4 a1 87 1e f0 98 9d 2012:08:20-18:52:55 astaro pluto[5146]: | db 80 d6 82 e3 7b 8d e5 89 7a fc 47 69 c4 76 d1 2012:08:20-18:52:55 astaro pluto[5146]: | f5 f6 78 45 ab d8 79 d0 26 f1 eb 8f 78 cf e1 fa 2012:08:20-18:52:55 astaro pluto[5146]: | 71 ac 91 1b 8a 38 17 6f 86 d8 61 e9 7a 15 3e ba 2012:08:20-18:52:55 astaro pluto[5146]: | 6f bd 0d 94 be 8e c5 ae b7 29 47 54 6f f5 71 73 2012:08:20-18:52:55 astaro pluto[5146]: | 96 63 bd b8 16 9f 9b 70 d2 a1 75 21 26 35 f9 9d 2012:08:20-18:52:55 astaro pluto[5146]: | 89 69 db 1d 56 93 f3 48 43 f1 4a 1c 16 64 d5 db 2012:08:20-18:52:55 astaro pluto[5146]: | e6 8d 6a 5e 5e 28 8e 99 0e bb 70 1a 48 d8 36 a0 2012:08:20-18:52:55 astaro pluto[5146]: | f8 29 66 9b 92 e3 41 09 9a 4a 20 10 ee 45 84 cf 2012:08:20-18:52:55 astaro pluto[5146]: | 70 ad ed 7b c8 df 1b 98 c7 4b dc 7e 23 98 22 15 2012:08:20-18:52:55 astaro pluto[5146]: | e8 5a 4d 5e 78 6d 40 c2 20 c2 2b 5a 91 48 e6 26 2012:08:20-18:52:55 astaro pluto[5146]: | 1b af 44 fe 4e 66 1f 07 aa d5 6f f4 90 de 30 c7 2012:08:20-18:52:55 astaro pluto[5146]: | 49 ac 68 d8 2012:08:20-18:52:55 astaro pluto[5146]: | **parse ISAKMP Message: 2012:08:20-18:52:55 astaro pluto[5146]: | initiator cookie: 2012:08:20-18:52:55 astaro pluto[5146]: | ac d2 fb 14 6f 2b 23 b9 2012:08:20-18:52:55 astaro pluto[5146]: | responder cookie: 2012:08:20-18:52:55 astaro pluto[5146]: | c5 61 40 c7 f3 53 95 73 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_HASH 2012:08:20-18:52:55 astaro pluto[5146]: | ISAKMP version: ISAKMP Version 1.0 2012:08:20-18:52:55 astaro pluto[5146]: | exchange type: ISAKMP_XCHG_QUICK 2012:08:20-18:52:55 astaro pluto[5146]: | flags: ISAKMP_FLAG_ENCRYPTION 2012:08:20-18:52:55 astaro pluto[5146]: | message ID: e4 e5 11 af 2012:08:20-18:52:55 astaro pluto[5146]: | length: 292 2012:08:20-18:52:55 astaro pluto[5146]: | ICOOKIE: ac d2 fb 14 6f 2b 23 b9 2012:08:20-18:52:55 astaro pluto[5146]: | RCOOKIE: c5 61 40 c7 f3 53 95 73 2012:08:20-18:52:55 astaro pluto[5146]: | peer: 54 9a 19 3b 2012:08:20-18:52:55 astaro pluto[5146]: | state hash entry 8 2012:08:20-18:52:55 astaro pluto[5146]: | state object not found 2012:08:20-18:52:55 astaro pluto[5146]: | ICOOKIE: ac d2 fb 14 6f 2b 23 b9 2012:08:20-18:52:55 astaro pluto[5146]: | RCOOKIE: c5 61 40 c7 f3 53 95 73 2012:08:20-18:52:55 astaro pluto[5146]: | peer: 54 9a 19 3b 2012:08:20-18:52:55 astaro pluto[5146]: | state hash entry 8 2012:08:20-18:52:55 astaro pluto[5146]: | state object #57 found, in STATE_MAIN_R3 2012:08:20-18:52:55 astaro pluto[5146]: | last Phase 1 IV: 35 94 21 94 bf a8 dc 8a 2012:08:20-18:52:55 astaro pluto[5146]: | computed Phase 2 IV: 2012:08:20-18:52:55 astaro pluto[5146]: | 54 04 6b 51 a5 8a b8 f4 f1 98 e1 d2 8c b9 5d 36 2012:08:20-18:52:55 astaro pluto[5146]: | a8 67 bc 5b 2012:08:20-18:52:55 astaro pluto[5146]: | received encrypted packet from XX.XXX.XX.XX:500 2012:08:20-18:52:55 astaro pluto[5146]: | decrypting 264 bytes using algorithm 3DES_CBC 2012:08:20-18:52:55 astaro pluto[5146]: | decrypted: 2012:08:20-18:52:55 astaro pluto[5146]: | 01 00 00 18 d3 bb 60 2e dd ef 2b 1b 75 fd 03 52 2012:08:20-18:52:55 astaro pluto[5146]: | 00 16 19 8a 56 ca 1b 31 0a 00 00 34 00 00 00 01 2012:08:20-18:52:55 astaro pluto[5146]: | 00 00 00 01 00 00 00 28 01 03 04 01 9d 6d 52 3e 2012:08:20-18:52:55 astaro pluto[5146]: | 00 00 00 1c 01 03 00 00 80 05 00 02 80 03 00 02 2012:08:20-18:52:55 astaro pluto[5146]: | 80 01 00 01 80 02 0e 10 80 04 00 01 04 00 00 14 2012:08:20-18:52:55 astaro pluto[5146]: | 67 cf b8 f1 42 a7 8b 9c 6a cb e8 c2 1a e8 09 28 2012:08:20-18:52:55 astaro pluto[5146]: | 05 00 00 84 e6 00 e9 b2 8d 59 a3 d0 5a 29 6e f5 2012:08:20-18:52:55 astaro pluto[5146]: | 9f 05 22 73 ff c9 ce 8a e1 6c 19 d7 37 76 d9 bb 2012:08:20-18:52:55 astaro pluto[5146]: | d0 a6 b6 55 84 4e ae 49 11 16 41 47 f1 9f ce bb 2012:08:20-18:52:55 astaro pluto[5146]: | 19 9e 5c 5a ab 20 4b b1 51 88 94 86 5b 5d d3 f1 2012:08:20-18:52:55 astaro pluto[5146]: | 51 ce 1a 25 50 8b cc af 0c e1 a2 89 65 34 a2 29 2012:08:20-18:52:55 astaro pluto[5146]: | ab a0 72 a2 84 63 90 80 1f 81 4c 5c dc bf ac 4a 2012:08:20-18:52:55 astaro pluto[5146]: | cc a0 ce 02 3e c4 36 79 5e 0a 72 15 16 44 62 c6 2012:08:20-18:52:55 astaro pluto[5146]: | ba 55 31 d7 c7 aa 33 7a 57 3e 4c 0e c0 64 aa b6 2012:08:20-18:52:55 astaro pluto[5146]: | 9c a5 f0 a3 05 00 00 10 04 00 00 00 c0 a8 14 00 2012:08:20-18:52:55 astaro pluto[5146]: | ff ff ff 00 00 00 00 10 04 00 00 00 c0 a8 01 00 2012:08:20-18:52:55 astaro pluto[5146]: | ff ff ff 00 00 00 00 00 2012:08:20-18:52:55 astaro pluto[5146]: | ***parse ISAKMP Hash Payload: 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_SA 2012:08:20-18:52:55 astaro pluto[5146]: | length: 24 2012:08:20-18:52:55 astaro pluto[5146]: | ***parse ISAKMP Security Association Payload: 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_NONCE 2012:08:20-18:52:55 astaro pluto[5146]: | length: 52 2012:08:20-18:52:55 astaro pluto[5146]: | DOI: ISAKMP_DOI_IPSEC 2012:08:20-18:52:55 astaro pluto[5146]: | ***parse ISAKMP Nonce Payload: 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_KE 2012:08:20-18:52:55 astaro pluto[5146]: | length: 20 2012:08:20-18:52:55 astaro pluto[5146]: | ***parse ISAKMP Key Exchange Payload: 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_ID 2012:08:20-18:52:55 astaro pluto[5146]: | length: 132 2012:08:20-18:52:55 astaro pluto[5146]: | ***parse ISAKMP Identification Payload (IPsec DOI): 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_ID 2012:08:20-18:52:55 astaro pluto[5146]: | length: 16 2012:08:20-18:52:55 astaro pluto[5146]: | ID type: ID_IPV4_ADDR_SUBNET 2012:08:20-18:52:55 astaro pluto[5146]: | Protocol ID: 0 2012:08:20-18:52:55 astaro pluto[5146]: | port: 0 2012:08:20-18:52:55 astaro pluto[5146]: | ***parse ISAKMP Identification Payload (IPsec DOI): 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_NONE 2012:08:20-18:52:55 astaro pluto[5146]: | length: 16 2012:08:20-18:52:55 astaro pluto[5146]: | ID type: ID_IPV4_ADDR_SUBNET 2012:08:20-18:52:55 astaro pluto[5146]: | Protocol ID: 0 2012:08:20-18:52:55 astaro pluto[5146]: | port: 0 2012:08:20-18:52:55 astaro pluto[5146]: | removing 4 bytes of padding 2012:08:20-18:52:55 astaro pluto[5146]: | next IV: 90 de 30 c7 49 ac 68 d8 2012:08:20-18:52:55 astaro pluto[5146]: | HASH(1) computed: 2012:08:20-18:52:55 astaro pluto[5146]: | d3 bb 60 2e dd ef 2b 1b 75 fd 03 52 00 16 19 8a 2012:08:20-18:52:55 astaro pluto[5146]: | 56 ca 1b 31 2012:08:20-18:52:55 astaro pluto[5146]: | peer client is subnet 192.168.20.0/24 2012:08:20-18:52:55 astaro pluto[5146]: | peer client protocol/port is 0/0 2012:08:20-18:52:55 astaro pluto[5146]: | our client is subnet 192.168.1.0/24 2012:08:20-18:52:55 astaro pluto[5146]: | our client protocol/port is 0/0 2012:08:20-18:52:55 astaro pluto[5146]: "S_AVM Gateways"[34] XX.XXX.XX.XX #57: cannot respond to IPsec SA request because no connection is known for 192.168.1.0/24===YYY.YY.YYY.YY[YYY.YY.YYY.YY]...XX.XXX.XX.XX[XXXXXX.dyndns.org]===192.168.20.0/24 2012:08:20-18:52:55 astaro pluto[5146]: "S_AVM Gateways"[34] XX.XXX.XX.XX #57: sending encrypted notification INVALID_ID_INFORMATION to XX.XXX.XX.XX:500 2012:08:20-18:52:55 astaro pluto[5146]: | **emit ISAKMP Message: 2012:08:20-18:52:55 astaro pluto[5146]: | initiator cookie: 2012:08:20-18:52:55 astaro pluto[5146]: | ac d2 fb 14 6f 2b 23 b9 2012:08:20-18:52:55 astaro pluto[5146]: | responder cookie: 2012:08:20-18:52:55 astaro pluto[5146]: | c5 61 40 c7 f3 53 95 73 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_HASH 2012:08:20-18:52:55 astaro pluto[5146]: | ISAKMP version: ISAKMP Version 1.0 2012:08:20-18:52:55 astaro pluto[5146]: | exchange type: ISAKMP_XCHG_INFO 2012:08:20-18:52:55 astaro pluto[5146]: | flags: ISAKMP_FLAG_ENCRYPTION 2012:08:20-18:52:55 astaro pluto[5146]: | message ID: 43 e3 31 2f 2012:08:20-18:52:55 astaro pluto[5146]: | ***emit ISAKMP Hash Payload: 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_N 2012:08:20-18:52:55 astaro pluto[5146]: | emitting 20 zero bytes of HASH into ISAKMP Hash Payload 2012:08:20-18:52:55 astaro pluto[5146]: | emitting length of ISAKMP Hash Payload: 24 2012:08:20-18:52:55 astaro pluto[5146]: | ***emit ISAKMP Notification Payload: 2012:08:20-18:52:55 astaro pluto[5146]: | next payload type: ISAKMP_NEXT_NONE 2012:08:20-18:52:55 astaro pluto[5146]: | DOI: ISAKMP_DOI_IPSEC 2012:08:20-18:52:55 astaro pluto[5146]: | protocol ID: 1 2012:08:20-18:52:55 astaro pluto[5146]: | SPI size: 0 2012:08:20-18:52:55 astaro pluto[5146]: | Notify Message Type: INVALID_ID_INFORMATION 2012:08:20-18:52:55 astaro pluto[5146]: | emitting 0 raw bytes of spi into ISAKMP Notification Payload 2012:08:20-18:52:55 astaro pluto[5146]: | spi 2012:08:20-18:52:55 astaro pluto[5146]: | emitting length of ISAKMP Notification Payload: 12 2012:08:20-18:52:55 astaro pluto[5146]: | HASH computed: 2012:08:20-18:52:55 astaro pluto[5146]: | ca 46 06 e3 67 9a e9 9b 00 bd 55 2e eb aa 33 d8 2012:08:20-18:52:55 astaro pluto[5146]: | 5d 92 60 51 2012:08:20-18:52:55 astaro pluto[5146]: | last Phase 1 IV: 35 94 21 94 bf a8 dc 8a 2012:08:20-18:52:55 astaro pluto[5146]: | computed Phase 2 IV: 2012:08:20-18:52:55 astaro pluto[5146]: | f3 b4 36 ae 92 85 4b 9c 6b 5c 93 59 dd 95 31 67 2012:08:20-18:52:55 astaro pluto[5146]: | 6b 10 3c eb 2012:08:20-18:52:55 astaro pluto[5146]: | encrypting: 2012:08:20-18:52:55 astaro pluto[5146]: | 0b 00 00 18 ca 46 06 e3 67 9a e9 9b 00 bd 55 2e 2012:08:20-18:52:55 astaro pluto[5146]: | eb aa 33 d8 5d 92 60 51 00 00 00 0c 00 00 00 01 2012:08:20-18:52:55 astaro pluto[5146]: | 01 00 00 12 2012:08:20-18:52:55 astaro pluto[5146]: | emitting 4 zero bytes of encryption padding into ISAKMP Message 2012:08:20-18:52:55 astaro pluto[5146]: | encrypting using 3DES_CBC 2012:08:20-18:52:55 astaro pluto[5146]: | next IV: d1 d3 a8 3b b1 8e 36 e3 2012:08:20-18:52:55 astaro pluto[5146]: | emitting length of ISAKMP Message: 68 2012:08:20-18:52:55 astaro pluto[5146]: | sending 68 bytes for ISAKMP notify through eth2 to 84.154.25.59:500: 2012:08:20-18:52:55 astaro pluto[5146]: | ac d2 fb 14 6f 2b 23 b9 c5 61 40 c7 f3 53 95 73 2012:08:20-18:52:55 astaro pluto[5146]: | 08 10 05 01 43 e3 31 2f 00 00 00 44 a4 e4 91 84 2012:08:20-18:52:55 astaro pluto[5146]: | 2e 76 ac 09 16 bc eb 38 76 5d be a1 a1 ea e4 f5 2012:08:20-18:52:55 astaro pluto[5146]: | 89 f2 9d 51 60 ea 52 c4 8c 27 96 dd d1 d3 a8 3b 2012:08:20-18:52:55 astaro pluto[5146]: | b1 8e 36 e3 2012:08:20-18:52:55 astaro pluto[5146]: | state transition function for STATE_QUICK_R0 failed: INVALID_ID_INFORMATION 2012:08:20-18:52:55 astaro pluto[5146]: | next event EVENT_DPD in 15 seconds for #57