[Openswan Users] Ipsec auto --up {tunnelname} hangs
Peter McGill
petermcgill at goco.net
Fri Jun 20 11:57:37 EDT 2008
Greg,
auto=up is not a valid parameter in ipsec.conf and will default to auto=ignore.
If you want the connection to start automatically use auto=start.
If you want the connection added (ready to answer) use auto=add.
Then it will answer incoming connect requests.
Note that auto=ignore will not accept incoming connection requests.
Granted this shouldn't cause a hang, but it will cause connection failure.
Peter McGill
IT Systems Analyst
Gra Ham Energy Limited
________________________________
From: users-bounces at openswan.org [mailto:users-bounces at openswan.org] On Behalf Of Greg Scott
Sent: June 20, 2008 4:27 AM
To: Paul Wouters; users at lists.openswan.org
Subject: Re: [Openswan Users] Ipsec auto --up {tunnelname} hangs
> You should run with plutodebug= and see why it is hanging instead.
>
> Paul
I can now reproduce the problem at will. I can make ipsec auto --up hang any time I want.
The left side has 2 tunnels - one with auto=up in the conn description, the other with auto=ignore. I make the right side
hang by doing ipsec auto --up on the right side without bringing up the 2nd tunnel on the left side. I can reproduce the problem
any time I want - but I have to do it in the middle of the night so it doesn't effect any production users.
I turned on plutodebug=all and pasted in relevant output from /var/log/secure below. Holy moley, does plutodebug=all log a
bunch of stuff! I also grabbed a copy of the relevant portion of /var/log/secure and I am attaching to this email. The attachment
is the same text as pasted in below - I am pasting below in case the list strips out the attachment.
- Greg
Jun 20 03:01:08 lme-fw pluto[11919]: | *time to handle event
Jun 20 03:01:08 lme-fw pluto[11919]: | handling event EVENT_PENDING_PHASE2
Jun 20 03:01:08 lme-fw pluto[11919]: | event after this is EVENT_SA_REPLACE in 2053 seconds
Jun 20 03:01:08 lme-fw pluto[11919]: | inserting event EVENT_PENDING_PHASE2, timeout in 120 seconds
Jun 20 03:01:08 lme-fw pluto[11919]: | pending review: connection "JanesvilleCheetah-Everywhere" checked
Jun 20 03:01:08 lme-fw pluto[11919]: | pending review: connection "Rochester-Everywhere" checked
Jun 20 03:01:08 lme-fw pluto[11919]: | pending review: connection "Columbia-Everywhere" checked
Jun 20 03:01:08 lme-fw pluto[11919]: | pending review: connection "Wichita-Everywhere" checked
Jun 20 03:01:08 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 120 seconds
Jun 20 03:02:17 lme-fw pluto[11919]: |
Jun 20 03:02:17 lme-fw pluto[11919]: | *received whack message
Jun 20 03:02:17 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 51 seconds
Jun 20 03:02:17 lme-fw pluto[11919]: |
Jun 20 03:02:17 lme-fw pluto[11919]: | *received whack message
Jun 20 03:02:17 lme-fw pluto[11919]: | unreference key: 0x9b3efd0 @hq.local cnt 1--
Jun 20 03:02:17 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 51 seconds
Jun 20 03:02:17 lme-fw pluto[11919]: |
Jun 20 03:02:17 lme-fw pluto[11919]: | *received whack message
Jun 20 03:02:17 lme-fw pluto[11919]: | Added new connection JanesvillePNT-Everywhere with policy RSASIG+ENCRYPT+TUNNEL+PFS
Jun 20 03:02:17 lme-fw pluto[11919]: | counting wild cards for @janesvillepnt.local is 0
Jun 20 03:02:17 lme-fw pluto[11919]: | counting wild cards for @hq.local is 0
Jun 20 03:02:17 lme-fw pluto[11919]: | find_host_pair: comparing to 12.24.248.50:500 209.125.151.194:500
Jun 20 03:02:17 lme-fw pluto[11919]: | find_host_pair: comparing to 12.24.248.50:500 67.77.61.191:500
Jun 20 03:02:17 lme-fw pluto[11919]: | find_host_pair: comparing to 12.24.248.50:500 71.39.202.145:500
Jun 20 03:02:17 lme-fw pluto[11919]: | find_host_pair: comparing to 12.24.248.50:500 99.135.79.74:500
Jun 20 03:02:17 lme-fw pluto[11919]: | connect_to_host_pair: 12.24.248.50:500 99.135.79.74:500 ->
hp:JanesvilleCheetah-Everywhere
Jun 20 03:02:17 lme-fw pluto[11919]: added connection description "JanesvillePNT-Everywhere"
Jun 20 03:02:17 lme-fw pluto[11919]: |
192.168.0.0/16===12.24.248.50[@hq.local]---12.24.248.49...99.135.79.78---99.135.79.74[@janesvillepnt.local]===172.20.2.0/24
Jun 20 03:02:17 lme-fw pluto[11919]: | ike_life: 3600s; ipsec_life: 28800s; rekey_margin: 540s; rekey_fuzz: 100%;
keyingtries: 0; policy: RSASIG+ENCRYPT+TUNNEL+PFS
Jun 20 03:02:17 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 51 seconds
Jun 20 03:02:17 lme-fw pluto[11919]: |
Jun 20 03:02:17 lme-fw pluto[11919]: | *received whack message
Jun 20 03:02:17 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:17 lme-fw pluto[11919]: | empty esp_info, returning empty
Jun 20 03:02:17 lme-fw pluto[11919]: | creating state object #9 at 0x9b4ce78
Jun 20 03:02:17 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:17 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | RCOOKIE: 00 00 00 00 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | state hash entry 6
Jun 20 03:02:17 lme-fw pluto[11919]: | inserting event EVENT_SO_DISCARD, timeout in 0 seconds for #9
Jun 20 03:02:17 lme-fw pluto[11919]: | Queuing pending Quick Mode with 99.135.79.74 "JanesvillePNT-Everywhere"
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: initiating Main Mode
Jun 20 03:02:17 lme-fw pluto[11919]: | **emit ISAKMP Message:
Jun 20 03:02:17 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 00 00 00 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_SA
Jun 20 03:02:17 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:17 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_IDPROT
Jun 20 03:02:17 lme-fw pluto[11919]: | flags: none
Jun 20 03:02:17 lme-fw pluto[11919]: | message ID: 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | no IKE algorithms for this connection
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Security Association Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_VID
Jun 20 03:02:17 lme-fw pluto[11919]: | DOI: ISAKMP_DOI_IPSEC
Jun 20 03:02:17 lme-fw pluto[11919]: | ****emit IPsec DOI SIT:
Jun 20 03:02:17 lme-fw pluto[11919]: | IPsec DOI SIT: SIT_IDENTITY_ONLY
Jun 20 03:02:17 lme-fw pluto[11919]: | out_sa pcn: 0 has 1 valid proposals
Jun 20 03:02:17 lme-fw pluto[11919]: | out_sa pcn: 0 pn: 0<1 valid_count: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | ****emit ISAKMP Proposal Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | proposal number: 0
Jun 20 03:02:17 lme-fw pluto[11919]: | protocol ID: PROTO_ISAKMP
Jun 20 03:02:17 lme-fw pluto[11919]: | SPI size: 0
Jun 20 03:02:17 lme-fw pluto[11919]: | number of transforms: 4
Jun 20 03:02:17 lme-fw pluto[11919]: | *****emit ISAKMP Transform Payload (ISAKMP):
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_T
Jun 20 03:02:17 lme-fw pluto[11919]: | transform number: 0
Jun 20 03:02:17 lme-fw pluto[11919]: | transform ID: KEY_IKE
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_TYPE
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_LIFE_SECONDS]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_DURATION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3600
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_ENCRYPTION_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_3DES_CBC]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_HASH_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_MD5]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_AUTHENTICATION_METHOD
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3
Jun 20 03:02:17 lme-fw pluto[11919]: | [3 is OAKLEY_RSA_SIG]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_GROUP_DESCRIPTION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_GROUP_MODP1536]
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Transform Payload (ISAKMP): 32
Jun 20 03:02:17 lme-fw pluto[11919]: | *****emit ISAKMP Transform Payload (ISAKMP):
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_T
Jun 20 03:02:17 lme-fw pluto[11919]: | transform number: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | transform ID: KEY_IKE
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_TYPE
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_LIFE_SECONDS]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_DURATION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3600
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_ENCRYPTION_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_3DES_CBC]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_HASH_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 2
Jun 20 03:02:17 lme-fw pluto[11919]: | [2 is OAKLEY_SHA1]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_AUTHENTICATION_METHOD
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3
Jun 20 03:02:17 lme-fw pluto[11919]: | [3 is OAKLEY_RSA_SIG]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_GROUP_DESCRIPTION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_GROUP_MODP1536]
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Transform Payload (ISAKMP): 32
Jun 20 03:02:17 lme-fw pluto[11919]: | *****emit ISAKMP Transform Payload (ISAKMP):
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_T
Jun 20 03:02:17 lme-fw pluto[11919]: | transform number: 2
Jun 20 03:02:17 lme-fw pluto[11919]: | transform ID: KEY_IKE
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_TYPE
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_LIFE_SECONDS]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_DURATION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3600
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_ENCRYPTION_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_3DES_CBC]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_HASH_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 2
Jun 20 03:02:17 lme-fw pluto[11919]: | [2 is OAKLEY_SHA1]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_AUTHENTICATION_METHOD
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3
Jun 20 03:02:17 lme-fw pluto[11919]: | [3 is OAKLEY_RSA_SIG]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_GROUP_DESCRIPTION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 2
Jun 20 03:02:17 lme-fw pluto[11919]: | [2 is OAKLEY_GROUP_MODP1024]
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Transform Payload (ISAKMP): 32
Jun 20 03:02:17 lme-fw pluto[11919]: | *****emit ISAKMP Transform Payload (ISAKMP):
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | transform number: 3
Jun 20 03:02:17 lme-fw pluto[11919]: | transform ID: KEY_IKE
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_TYPE
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_LIFE_SECONDS]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_DURATION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3600
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_ENCRYPTION_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_3DES_CBC]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_HASH_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_MD5]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_AUTHENTICATION_METHOD
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3
Jun 20 03:02:17 lme-fw pluto[11919]: | [3 is OAKLEY_RSA_SIG]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******emit ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_GROUP_DESCRIPTION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 2
Jun 20 03:02:17 lme-fw pluto[11919]: | [2 is OAKLEY_GROUP_MODP1024]
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Transform Payload (ISAKMP): 32
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Proposal Payload: 136
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Security Association Payload: 148
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 12 raw bytes of Vendor ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | Vendor ID 4f 45 6e 4d 43 75 7f 78 4f 70 40 63
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 16
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of V_ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | V_ID af ca d7 13 68 a1 f1 c9 6b 86 96 fc 77 57 01 00
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | nat traversal enabled: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | nat add vid. port: 1 nonike: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | out_vendorid(): sending [RFC 3947]
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of V_ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | V_ID 4a 13 1c 81 07 03 58 45 5c 57 28 f2 0e 95 45 2f
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | out_vendorid(): sending [draft-ietf-ipsec-nat-t-ike-03]
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of V_ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | V_ID 7d 94 19 a6 53 10 ca 6f 2c 17 9d 92 15 52 9d 56
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | out_vendorid(): sending [draft-ietf-ipsec-nat-t-ike-02]
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of V_ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | V_ID cd 60 46 43 35 df 21 f8 7c fd b2 fc 68 b6 a4 48
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | out_vendorid(): sending [draft-ietf-ipsec-nat-t-ike-02_n]
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of V_ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | V_ID 90 cb 80 91 3e bb 69 6e 08 63 81 b5 ec 42 7b 1f
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | out_vendorid(): sending [draft-ietf-ipsec-nat-t-ike-00]
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of V_ID into ISAKMP Vendor ID Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | V_ID 44 85 15 2d 18 b6 bb cd 0b e8 a8 46 95 79 dd cc
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Vendor ID Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Message: 312
Jun 20 03:02:17 lme-fw pluto[11919]: | sending 312 bytes for main_outI1 through eth0:500 to 99.135.79.74:500:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 00 00 00 00 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | 01 10 02 00 00 00 00 00 00 00 01 38 0d 00 00 94
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 00 00 01 00 00 00 01 00 00 00 88 00 01 00 04
Jun 20 03:02:17 lme-fw pluto[11919]: | 03 00 00 20 00 01 00 00 80 0b 00 01 80 0c 0e 10
Jun 20 03:02:17 lme-fw pluto[11919]: | 80 01 00 05 80 02 00 01 80 03 00 03 80 04 00 05
Jun 20 03:02:17 lme-fw pluto[11919]: | 03 00 00 20 01 01 00 00 80 0b 00 01 80 0c 0e 10
Jun 20 03:02:17 lme-fw pluto[11919]: | 80 01 00 05 80 02 00 02 80 03 00 03 80 04 00 05
Jun 20 03:02:17 lme-fw pluto[11919]: | 03 00 00 20 02 01 00 00 80 0b 00 01 80 0c 0e 10
Jun 20 03:02:17 lme-fw pluto[11919]: | 80 01 00 05 80 02 00 02 80 03 00 03 80 04 00 02
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 00 00 20 03 01 00 00 80 0b 00 01 80 0c 0e 10
Jun 20 03:02:17 lme-fw pluto[11919]: | 80 01 00 05 80 02 00 01 80 03 00 03 80 04 00 02
Jun 20 03:02:17 lme-fw pluto[11919]: | 0d 00 00 10 4f 45 6e 4d 43 75 7f 78 4f 70 40 63
Jun 20 03:02:17 lme-fw pluto[11919]: | 0d 00 00 14 af ca d7 13 68 a1 f1 c9 6b 86 96 fc
Jun 20 03:02:17 lme-fw pluto[11919]: | 77 57 01 00 0d 00 00 14 4a 13 1c 81 07 03 58 45
Jun 20 03:02:17 lme-fw pluto[11919]: | 5c 57 28 f2 0e 95 45 2f 0d 00 00 14 7d 94 19 a6
Jun 20 03:02:17 lme-fw pluto[11919]: | 53 10 ca 6f 2c 17 9d 92 15 52 9d 56 0d 00 00 14
Jun 20 03:02:17 lme-fw pluto[11919]: | cd 60 46 43 35 df 21 f8 7c fd b2 fc 68 b6 a4 48
Jun 20 03:02:17 lme-fw pluto[11919]: | 0d 00 00 14 90 cb 80 91 3e bb 69 6e 08 63 81 b5
Jun 20 03:02:17 lme-fw pluto[11919]: | ec 42 7b 1f 00 00 00 14 44 85 15 2d 18 b6 bb cd
Jun 20 03:02:17 lme-fw pluto[11919]: | 0b e8 a8 46 95 79 dd cc
Jun 20 03:02:17 lme-fw pluto[11919]: | inserting event EVENT_RETRANSMIT, timeout in 10 seconds for #9
Jun 20 03:02:17 lme-fw pluto[11919]: | next event EVENT_RETRANSMIT in 10 seconds for #9
Jun 20 03:02:17 lme-fw pluto[11919]: |
Jun 20 03:02:17 lme-fw pluto[11919]: | *received 136 bytes from 99.135.79.74:500 on eth0 (port=500)
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | 01 10 02 00 00 00 00 00 00 00 00 88 0d 00 00 34
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 00 00 01 00 00 00 01 00 00 00 28 00 01 00 01
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 00 00 20 00 01 00 00 80 0b 00 01 80 0c 0e 10
Jun 20 03:02:17 lme-fw pluto[11919]: | 80 01 00 05 80 02 00 01 80 03 00 03 80 04 00 05
Jun 20 03:02:17 lme-fw pluto[11919]: | 0d 00 00 10 4f 45 5f 5d 7b 76 4b 67 43 6f 4f 49
Jun 20 03:02:17 lme-fw pluto[11919]: | 0d 00 00 14 af ca d7 13 68 a1 f1 c9 6b 86 96 fc
Jun 20 03:02:17 lme-fw pluto[11919]: | 77 57 01 00 00 00 00 14 4a 13 1c 81 07 03 58 45
Jun 20 03:02:17 lme-fw pluto[11919]: | 5c 57 28 f2 0e 95 45 2f
Jun 20 03:02:17 lme-fw pluto[11919]: | **parse ISAKMP Message:
Jun 20 03:02:17 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_SA
Jun 20 03:02:17 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:17 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_IDPROT
Jun 20 03:02:17 lme-fw pluto[11919]: | flags: none
Jun 20 03:02:17 lme-fw pluto[11919]: | message ID: 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 136
Jun 20 03:02:17 lme-fw pluto[11919]: | processing packet with exchange type=ISAKMP_XCHG_IDPROT (2)
Jun 20 03:02:17 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | RCOOKIE: 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | state hash entry 11
Jun 20 03:02:17 lme-fw pluto[11919]: | state object not found
Jun 20 03:02:17 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | RCOOKIE: 00 00 00 00 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | state hash entry 6
Jun 20 03:02:17 lme-fw pluto[11919]: | peer and cookies match on #9, provided msgid 00000000 vs 00000000
Jun 20 03:02:17 lme-fw pluto[11919]: | state object #9 found, in STATE_MAIN_I1
Jun 20 03:02:17 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP Security Association Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_VID
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 52
Jun 20 03:02:17 lme-fw pluto[11919]: | DOI: ISAKMP_DOI_IPSEC
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_VID
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 16
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_VID
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP Vendor ID Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 20
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: ignoring unknown Vendor ID payload
[4f455f5d7b764b67436f4f49]
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: received Vendor ID payload [Dead Peer Detection]
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: received Vendor ID payload [RFC 3947] method set to=110
Jun 20 03:02:17 lme-fw pluto[11919]: | ****parse IPsec DOI SIT:
Jun 20 03:02:17 lme-fw pluto[11919]: | IPsec DOI SIT: SIT_IDENTITY_ONLY
Jun 20 03:02:17 lme-fw pluto[11919]: | ****parse ISAKMP Proposal Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 40
Jun 20 03:02:17 lme-fw pluto[11919]: | proposal number: 0
Jun 20 03:02:17 lme-fw pluto[11919]: | protocol ID: PROTO_ISAKMP
Jun 20 03:02:17 lme-fw pluto[11919]: | SPI size: 0
Jun 20 03:02:17 lme-fw pluto[11919]: | number of transforms: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | *****parse ISAKMP Transform Payload (ISAKMP):
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 32
Jun 20 03:02:17 lme-fw pluto[11919]: | transform number: 0
Jun 20 03:02:17 lme-fw pluto[11919]: | transform ID: KEY_IKE
Jun 20 03:02:17 lme-fw pluto[11919]: | ******parse ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_TYPE
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_LIFE_SECONDS]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******parse ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_LIFE_DURATION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3600
Jun 20 03:02:17 lme-fw pluto[11919]: | ******parse ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_ENCRYPTION_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_3DES_CBC]
Jun 20 03:02:17 lme-fw pluto[11919]: | ike_alg_enc_ok(ealg=5,key_len=0): blocksize=8, keyminlen=192, keydeflen=192,
keymaxlen=192, ret=1
Jun 20 03:02:17 lme-fw pluto[11919]: | ******parse ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_HASH_ALGORITHM
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | [1 is OAKLEY_MD5]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******parse ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_AUTHENTICATION_METHOD
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 3
Jun 20 03:02:17 lme-fw pluto[11919]: | [3 is OAKLEY_RSA_SIG]
Jun 20 03:02:17 lme-fw pluto[11919]: | ******parse ISAKMP Oakley attribute:
Jun 20 03:02:17 lme-fw pluto[11919]: | af+type: OAKLEY_GROUP_DESCRIPTION
Jun 20 03:02:17 lme-fw pluto[11919]: | length/value: 5
Jun 20 03:02:17 lme-fw pluto[11919]: | [5 is OAKLEY_GROUP_MODP1536]
Jun 20 03:02:17 lme-fw pluto[11919]: | Oakley Transform 0 accepted
Jun 20 03:02:17 lme-fw pluto[11919]: | sender checking NAT-t: 1 and 110
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: enabling possible NAT-traversal with method 3
Jun 20 03:02:17 lme-fw pluto[11919]: | 0: w->pcw_dead: 0 w->pcw_work: 0 cnt: 1
Jun 20 03:02:17 lme-fw pluto[11919]: | asking helper 0 to do build_kenonce op on seq: 9
Jun 20 03:02:17 lme-fw pluto[11919]: | inserting event EVENT_CRYPTO_FAILED, timeout in 300 seconds for #9
Jun 20 03:02:17 lme-fw pluto[11934]: ! helper -1 doing build_kenonce op id: 9
Jun 20 03:02:17 lme-fw pluto[11919]: | complete state transition with STF_SUSPEND
Jun 20 03:02:17 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 51 seconds
Jun 20 03:02:17 lme-fw pluto[11934]: ! Local DH secret:
Jun 20 03:02:17 lme-fw pluto[11934]: ! 16 5e 89 f9 d9 af 9d 74 ea 89 46 1e 03 97 7c 5e
Jun 20 03:02:17 lme-fw pluto[11934]: ! e9 0f b8 23 82 ca 9f 63 18 be ee 5e 17 02 f4 de
Jun 20 03:02:17 lme-fw pluto[11934]: ! Public DH value sent:
Jun 20 03:02:17 lme-fw pluto[11934]: ! 15 0d b7 9a 3f aa 3b d6 98 24 6a 8b 10 95 64 73
Jun 20 03:02:17 lme-fw pluto[11934]: ! 31 0e 28 0c be fc 99 93 8e 00 7a 2b 54 15 e0 a4
Jun 20 03:02:17 lme-fw pluto[11934]: ! 66 58 80 a6 2b 55 2b 3b da 72 5d 08 2b 71 7b 10
Jun 20 03:02:17 lme-fw pluto[11934]: ! da 58 74 77 ae e7 ae e9 5f 58 db 73 a2 e0 24 d4
Jun 20 03:02:17 lme-fw pluto[11934]: ! 2c c6 64 26 e2 90 37 e5 86 cc fd 96 97 e3 93 16
Jun 20 03:02:17 lme-fw pluto[11934]: ! 59 47 46 d4 38 03 17 d4 8c e4 9a 68 82 89 3f 49
Jun 20 03:02:17 lme-fw pluto[11934]: ! 01 b9 5e a2 fa 7c 84 97 85 03 55 0d 0f 24 1b 86
Jun 20 03:02:17 lme-fw pluto[11934]: ! ef 2d 01 48 c1 cb ac 1c 29 65 79 f8 de 35 41 8d
Jun 20 03:02:17 lme-fw pluto[11934]: ! f7 4e d2 75 21 ba 16 d3 95 db 2e 59 dd 69 b7 6c
Jun 20 03:02:17 lme-fw pluto[11934]: ! 96 99 7f 46 6a ca e0 66 cd 91 10 52 fa 5f 1c cf
Jun 20 03:02:17 lme-fw pluto[11934]: ! 0a d4 06 c4 6e 9e 98 cd 9b 26 3f 39 f1 b0 49 60
Jun 20 03:02:17 lme-fw pluto[11934]: ! 45 5e 12 76 05 bf 4a 8d 1f ac e6 e7 25 88 3a aa
Jun 20 03:02:17 lme-fw pluto[11934]: ! Generated nonce:
Jun 20 03:02:17 lme-fw pluto[11934]: ! fe ac 91 fe df 3d 17 ec 74 a0 1f 05 5d c6 1c d4
Jun 20 03:02:17 lme-fw pluto[11919]: | helper 0 has work (cnt now 0)
Jun 20 03:02:17 lme-fw pluto[11919]: | helper 0 replies to sequence 9
Jun 20 03:02:17 lme-fw pluto[11919]: | calling callback function 0x60e460
Jun 20 03:02:17 lme-fw pluto[11919]: | main inR1_outI2: calculated ke+nonce, sending I2
Jun 20 03:02:17 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:17 lme-fw pluto[11919]: | **emit ISAKMP Message:
Jun 20 03:02:17 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_KE
Jun 20 03:02:17 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:17 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_IDPROT
Jun 20 03:02:17 lme-fw pluto[11919]: | flags: none
Jun 20 03:02:17 lme-fw pluto[11919]: | message ID: 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Key Exchange Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONCE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 192 raw bytes of keyex value into ISAKMP Key Exchange Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | keyex value 15 0d b7 9a 3f aa 3b d6 98 24 6a 8b 10 95 64 73
Jun 20 03:02:17 lme-fw pluto[11919]: | 31 0e 28 0c be fc 99 93 8e 00 7a 2b 54 15 e0 a4
Jun 20 03:02:17 lme-fw pluto[11919]: | 66 58 80 a6 2b 55 2b 3b da 72 5d 08 2b 71 7b 10
Jun 20 03:02:17 lme-fw pluto[11919]: | da 58 74 77 ae e7 ae e9 5f 58 db 73 a2 e0 24 d4
Jun 20 03:02:17 lme-fw pluto[11919]: | 2c c6 64 26 e2 90 37 e5 86 cc fd 96 97 e3 93 16
Jun 20 03:02:17 lme-fw pluto[11919]: | 59 47 46 d4 38 03 17 d4 8c e4 9a 68 82 89 3f 49
Jun 20 03:02:17 lme-fw pluto[11919]: | 01 b9 5e a2 fa 7c 84 97 85 03 55 0d 0f 24 1b 86
Jun 20 03:02:17 lme-fw pluto[11919]: | ef 2d 01 48 c1 cb ac 1c 29 65 79 f8 de 35 41 8d
Jun 20 03:02:17 lme-fw pluto[11919]: | f7 4e d2 75 21 ba 16 d3 95 db 2e 59 dd 69 b7 6c
Jun 20 03:02:17 lme-fw pluto[11919]: | 96 99 7f 46 6a ca e0 66 cd 91 10 52 fa 5f 1c cf
Jun 20 03:02:17 lme-fw pluto[11919]: | 0a d4 06 c4 6e 9e 98 cd 9b 26 3f 39 f1 b0 49 60
Jun 20 03:02:17 lme-fw pluto[11919]: | 45 5e 12 76 05 bf 4a 8d 1f ac e6 e7 25 88 3a aa
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Key Exchange Payload: 196
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP Nonce Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of Ni into ISAKMP Nonce Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | Ni fe ac 91 fe df 3d 17 ec 74 a0 1f 05 5d c6 1c d4
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Nonce Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | sending NATD payloads
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: hasher=0x69b140(16)
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: icookie=
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: rcookie=
Jun 20 03:02:17 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: ip= 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: port=500
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: hash= 13 f0 68 d4 d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP NAT-D Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NAT-D
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of NAT-D into ISAKMP NAT-D Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | NAT-D 13 f0 68 d4 d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP NAT-D Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: hasher=0x69b140(16)
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: icookie=
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: rcookie=
Jun 20 03:02:17 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: ip= 0c 18 f8 32
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: port=500
Jun 20 03:02:17 lme-fw pluto[11919]: | _natd_hash: hash= 19 4e 0d ba 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:17 lme-fw pluto[11919]: | ***emit ISAKMP NAT-D Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting 16 raw bytes of NAT-D into ISAKMP NAT-D Payload
Jun 20 03:02:17 lme-fw pluto[11919]: | NAT-D 19 4e 0d ba 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP NAT-D Payload: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | emitting length of ISAKMP Message: 284
Jun 20 03:02:17 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | RCOOKIE: 00 00 00 00 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | state hash entry 6
Jun 20 03:02:17 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | RCOOKIE: 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | state hash entry 11
Jun 20 03:02:17 lme-fw pluto[11919]: | complete state transition with STF_OK
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: transition from state STATE_MAIN_I1 to state
STATE_MAIN_I2
Jun 20 03:02:17 lme-fw pluto[11919]: | sending reply packet to 99.135.79.74:500 (from port=500)
Jun 20 03:02:17 lme-fw pluto[11919]: | sending 284 bytes for STATE_MAIN_I1 through eth0:500 to 99.135.79.74:500:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 10 02 00 00 00 00 00 00 00 01 1c 0a 00 00 c4
Jun 20 03:02:17 lme-fw pluto[11919]: | 15 0d b7 9a 3f aa 3b d6 98 24 6a 8b 10 95 64 73
Jun 20 03:02:17 lme-fw pluto[11919]: | 31 0e 28 0c be fc 99 93 8e 00 7a 2b 54 15 e0 a4
Jun 20 03:02:17 lme-fw pluto[11919]: | 66 58 80 a6 2b 55 2b 3b da 72 5d 08 2b 71 7b 10
Jun 20 03:02:17 lme-fw pluto[11919]: | da 58 74 77 ae e7 ae e9 5f 58 db 73 a2 e0 24 d4
Jun 20 03:02:17 lme-fw pluto[11919]: | 2c c6 64 26 e2 90 37 e5 86 cc fd 96 97 e3 93 16
Jun 20 03:02:17 lme-fw pluto[11919]: | 59 47 46 d4 38 03 17 d4 8c e4 9a 68 82 89 3f 49
Jun 20 03:02:17 lme-fw pluto[11919]: | 01 b9 5e a2 fa 7c 84 97 85 03 55 0d 0f 24 1b 86
Jun 20 03:02:17 lme-fw pluto[11919]: | ef 2d 01 48 c1 cb ac 1c 29 65 79 f8 de 35 41 8d
Jun 20 03:02:17 lme-fw pluto[11919]: | f7 4e d2 75 21 ba 16 d3 95 db 2e 59 dd 69 b7 6c
Jun 20 03:02:17 lme-fw pluto[11919]: | 96 99 7f 46 6a ca e0 66 cd 91 10 52 fa 5f 1c cf
Jun 20 03:02:17 lme-fw pluto[11919]: | 0a d4 06 c4 6e 9e 98 cd 9b 26 3f 39 f1 b0 49 60
Jun 20 03:02:17 lme-fw pluto[11919]: | 45 5e 12 76 05 bf 4a 8d 1f ac e6 e7 25 88 3a aa
Jun 20 03:02:17 lme-fw pluto[11919]: | 14 00 00 14 fe ac 91 fe df 3d 17 ec 74 a0 1f 05
Jun 20 03:02:17 lme-fw pluto[11919]: | 5d c6 1c d4 14 00 00 14 13 f0 68 d4 d8 45 81 fd
Jun 20 03:02:17 lme-fw pluto[11919]: | 87 d6 ab 41 4d a2 51 24 00 00 00 14 19 4e 0d ba
Jun 20 03:02:17 lme-fw pluto[11919]: | 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:17 lme-fw pluto[11919]: | inserting event EVENT_RETRANSMIT, timeout in 10 seconds for #9
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: STATE_MAIN_I2: sent MI2, expecting MR2
Jun 20 03:02:17 lme-fw pluto[11919]: | modecfg pull: noquirk policy:push not-client
Jun 20 03:02:17 lme-fw pluto[11919]: | phase 1 is done, looking for phase 1 to unpend
Jun 20 03:02:17 lme-fw pluto[11919]: | next event EVENT_RETRANSMIT in 10 seconds for #9
Jun 20 03:02:17 lme-fw pluto[11919]: |
Jun 20 03:02:17 lme-fw pluto[11919]: | *received 284 bytes from 99.135.79.74:500 on eth0 (port=500)
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 10 02 00 00 00 00 00 00 00 01 1c 0a 00 00 c4
Jun 20 03:02:17 lme-fw pluto[11919]: | 3b e0 40 17 0a 36 c1 5b 52 b2 f0 3b c9 9f bb 64
Jun 20 03:02:17 lme-fw pluto[11919]: | 85 68 46 c1 ec e0 68 35 9f 0c 0a 12 d5 86 51 47
Jun 20 03:02:17 lme-fw pluto[11919]: | d8 15 f9 57 32 28 89 bd 5f 1b 49 75 b7 6b 7c 06
Jun 20 03:02:17 lme-fw pluto[11919]: | a1 ce 0f b9 7a 15 3c 3f a0 ef 65 12 f3 14 59 a7
Jun 20 03:02:17 lme-fw pluto[11919]: | eb 60 37 73 84 fc 7e 86 9a 17 7c f2 93 d6 ca f5
Jun 20 03:02:17 lme-fw pluto[11919]: | 08 6c 8a 2a f2 76 eb 4d a4 b9 a1 f9 a8 15 88 46
Jun 20 03:02:17 lme-fw pluto[11919]: | 35 e1 d1 fd 65 98 10 d5 bf 06 a4 e9 55 ee d7 fa
Jun 20 03:02:17 lme-fw pluto[11919]: | 17 c1 e2 55 af 70 6d 44 83 e8 9a e8 68 ed 84 9b
Jun 20 03:02:17 lme-fw pluto[11919]: | fe 9e 6a 6f 27 39 48 0e e0 cd 8b 15 30 0b eb d1
Jun 20 03:02:17 lme-fw pluto[11919]: | b7 fd d4 5d 66 62 b0 5e 71 09 50 e7 ec a1 65 6d
Jun 20 03:02:17 lme-fw pluto[11919]: | ed ef 24 a7 ca e1 71 a9 02 77 92 a0 e1 36 bc 31
Jun 20 03:02:17 lme-fw pluto[11919]: | b4 ae 33 e6 87 db 89 d7 ec 95 e3 d5 74 cc af 22
Jun 20 03:02:17 lme-fw pluto[11919]: | 14 00 00 14 1e c9 26 a3 27 01 c4 41 fa 79 a8 dd
Jun 20 03:02:17 lme-fw pluto[11919]: | 6c 7f 12 8d 14 00 00 14 19 4e 0d ba 89 6f 9c 7d
Jun 20 03:02:17 lme-fw pluto[11919]: | c9 1e 01 7b 71 4a ae e4 00 00 00 14 13 f0 68 d4
Jun 20 03:02:17 lme-fw pluto[11919]: | d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:17 lme-fw pluto[11919]: | **parse ISAKMP Message:
Jun 20 03:02:17 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_KE
Jun 20 03:02:17 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:17 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_IDPROT
Jun 20 03:02:17 lme-fw pluto[11919]: | flags: none
Jun 20 03:02:17 lme-fw pluto[11919]: | message ID: 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 284
Jun 20 03:02:17 lme-fw pluto[11919]: | processing packet with exchange type=ISAKMP_XCHG_IDPROT (2)
Jun 20 03:02:17 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | RCOOKIE: 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:17 lme-fw pluto[11919]: | state hash entry 11
Jun 20 03:02:17 lme-fw pluto[11919]: | peer and cookies match on #9, provided msgid 00000000 vs 00000000
Jun 20 03:02:17 lme-fw pluto[11919]: | state object #9 found, in STATE_MAIN_I2
Jun 20 03:02:17 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP Key Exchange Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONCE
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 196
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP Nonce Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NAT-D
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP NAT-D Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NAT-D
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | ***parse ISAKMP NAT-D Payload:
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | length: 20
Jun 20 03:02:17 lme-fw pluto[11919]: | **emit ISAKMP Message:
Jun 20 03:02:17 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:17 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:17 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:17 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_ID
Jun 20 03:02:17 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:17 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_IDPROT
Jun 20 03:02:17 lme-fw pluto[11919]: | flags: ISAKMP_FLAG_ENCRYPTION
Jun 20 03:02:17 lme-fw pluto[11919]: | message ID: 00 00 00 00
Jun 20 03:02:17 lme-fw pluto[11919]: | DH public value received:
Jun 20 03:02:17 lme-fw pluto[11919]: | 3b e0 40 17 0a 36 c1 5b 52 b2 f0 3b c9 9f bb 64
Jun 20 03:02:17 lme-fw pluto[11919]: | 85 68 46 c1 ec e0 68 35 9f 0c 0a 12 d5 86 51 47
Jun 20 03:02:17 lme-fw pluto[11919]: | d8 15 f9 57 32 28 89 bd 5f 1b 49 75 b7 6b 7c 06
Jun 20 03:02:17 lme-fw pluto[11919]: | a1 ce 0f b9 7a 15 3c 3f a0 ef 65 12 f3 14 59 a7
Jun 20 03:02:17 lme-fw pluto[11919]: | eb 60 37 73 84 fc 7e 86 9a 17 7c f2 93 d6 ca f5
Jun 20 03:02:17 lme-fw pluto[11919]: | 08 6c 8a 2a f2 76 eb 4d a4 b9 a1 f9 a8 15 88 46
Jun 20 03:02:17 lme-fw pluto[11919]: | 35 e1 d1 fd 65 98 10 d5 bf 06 a4 e9 55 ee d7 fa
Jun 20 03:02:17 lme-fw pluto[11919]: | 17 c1 e2 55 af 70 6d 44 83 e8 9a e8 68 ed 84 9b
Jun 20 03:02:17 lme-fw pluto[11919]: | fe 9e 6a 6f 27 39 48 0e e0 cd 8b 15 30 0b eb d1
Jun 20 03:02:17 lme-fw pluto[11919]: | b7 fd d4 5d 66 62 b0 5e 71 09 50 e7 ec a1 65 6d
Jun 20 03:02:17 lme-fw pluto[11919]: | ed ef 24 a7 ca e1 71 a9 02 77 92 a0 e1 36 bc 31
Jun 20 03:02:17 lme-fw pluto[11919]: | b4 ae 33 e6 87 db 89 d7 ec 95 e3 d5 74 cc af 22
Jun 20 03:02:17 lme-fw pluto[11919]: | thinking about whether to send my certificate:
Jun 20 03:02:17 lme-fw pluto[11919]: | I have RSA key: OAKLEY_RSA_SIG cert.type: CERT_NONE
Jun 20 03:02:17 lme-fw pluto[11919]: | sendcert: CERT_ALWAYSSEND and I did not get a certificate request
Jun 20 03:02:17 lme-fw pluto[11919]: | so do not send cert.
Jun 20 03:02:17 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: I did not send a certificate because I do not have one.
Jun 20 03:02:17 lme-fw pluto[11919]: | I am not sending a certificate request
Jun 20 03:02:17 lme-fw pluto[11919]: | started looking for secret for @hq.local->@janesvillepnt.local of kind PPK_PSK
Jun 20 03:02:17 lme-fw pluto[11919]: | actually looking for secret for @hq.local->@janesvillepnt.local of kind PPK_PSK
Jun 20 03:02:17 lme-fw pluto[11919]: | concluding with best_match=0 best=(nil) (lineno=-1)
Jun 20 03:02:17 lme-fw pluto[11919]: | calc_dh_shared(): time elapsed (OAKLEY_GROUP_MODP1536): 14302 usec
Jun 20 03:02:17 lme-fw pluto[11919]: | DH shared secret:
Jun 20 03:02:17 lme-fw pluto[11919]: | 4e 1f 92 14 27 af 29 a9 26 84 eb 3b 54 57 0f ad
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 aa ab a5 1d 6d 0d e4 2a 4b c3 99 96 b2 29 f7
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 d3 08 8b 0f ab af c6 b4 3c b4 0e f5 31 82 7c
Jun 20 03:02:17 lme-fw pluto[11919]: | d6 b7 ba dc ac 8a 46 06 ed a3 d2 46 af 2c 21 63
Jun 20 03:02:17 lme-fw pluto[11919]: | 24 ff 40 34 57 ac 23 53 4a d3 29 d2 92 99 3f d2
Jun 20 03:02:17 lme-fw pluto[11919]: | f0 48 e8 f7 57 a8 36 fa a5 06 06 99 f5 ed 23 e7
Jun 20 03:02:17 lme-fw pluto[11919]: | 30 45 a5 c2 05 a6 ad aa cb 24 1c d8 be 72 87 ab
Jun 20 03:02:17 lme-fw pluto[11919]: | 25 32 12 18 8a 34 c9 8f d9 b9 25 22 77 02 02 d6
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 ee 1f 1b be b6 a1 38 24 17 64 50 7e 23 d8 0f
Jun 20 03:02:17 lme-fw pluto[11919]: | e4 af e8 5a b4 fa 75 ac 19 27 1a 99 b7 50 d5 9a
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 8b a3 4c 01 fa cb e7 06 31 83 2c 26 b1 bf 42
Jun 20 03:02:17 lme-fw pluto[11919]: | 40 0d ff 8c 8b de 08 bd bf bb bf 89 82 c2 13 88
Jun 20 03:02:17 lme-fw pluto[11919]: | skeyid inputs (digi+NI+NR+shared) hasher: oakley_md5
Jun 20 03:02:17 lme-fw pluto[11919]: | shared: 4e 1f 92 14 27 af 29 a9 26 84 eb 3b 54 57 0f ad
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 aa ab a5 1d 6d 0d e4 2a 4b c3 99 96 b2 29 f7
Jun 20 03:02:17 lme-fw pluto[11919]: | 00 d3 08 8b 0f ab af c6 b4 3c b4 0e f5 31 82 7c
Jun 20 03:02:17 lme-fw pluto[11919]: | d6 b7 ba dc ac 8a 46 06 ed a3 d2 46 af 2c 21 63
Jun 20 03:02:17 lme-fw pluto[11919]: | 24 ff 40 34 57 ac 23 53 4a d3 29 d2 92 99 3f d2
Jun 20 03:02:17 lme-fw pluto[11919]: | f0 48 e8 f7 57 a8 36 fa a5 06 06 99 f5 ed 23 e7
Jun 20 03:02:17 lme-fw pluto[11919]: | 30 45 a5 c2 05 a6 ad aa cb 24 1c d8 be 72 87 ab
Jun 20 03:02:17 lme-fw pluto[11919]: | 25 32 12 18 8a 34 c9 8f d9 b9 25 22 77 02 02 d6
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 ee 1f 1b be b6 a1 38 24 17 64 50 7e 23 d8 0f
Jun 20 03:02:17 lme-fw pluto[11919]: | e4 af e8 5a b4 fa 75 ac 19 27 1a 99 b7 50 d5 9a
Jun 20 03:02:17 lme-fw pluto[11919]: | 04 8b a3 4c 01 fa cb e7 06 31 83 2c 26 b1 bf 42
Jun 20 03:02:17 lme-fw pluto[11919]: | 40 0d ff 8c 8b de 08 bd bf bb bf 89 82 c2 13 88
Jun 20 03:02:17 lme-fw pluto[11919]: | ni: fe ac 91 fe df 3d 17 ec 74 a0 1f 05 5d c6 1c d4
Jun 20 03:02:17 lme-fw pluto[11919]: | nr: 1e c9 26 a3 27 01 c4 41 fa 79 a8 dd 6c 7f 12 8d
Jun 20 03:02:17 lme-fw pluto[11919]: | keyid: 0d 23 26 62 b1 31 13 b0 84 f7 cf 0e a1 5c af d7
Jun 20 03:02:17 lme-fw pluto[11919]: | DH_i: 15 0d b7 9a 3f aa 3b d6 98 24 6a 8b 10 95 64 73
Jun 20 03:02:17 lme-fw pluto[11919]: | 31 0e 28 0c be fc 99 93 8e 00 7a 2b 54 15 e0 a4
Jun 20 03:02:17 lme-fw pluto[11919]: | 66 58 80 a6 2b 55 2b 3b da 72 5d 08 2b 71 7b 10
Jun 20 03:02:17 lme-fw pluto[11919]: | da 58 74 77 ae e7 ae e9 5f 58 db 73 a2 e0 24 d4
Jun 20 03:02:17 lme-fw pluto[11919]: | 2c c6 64 26 e2 90 37 e5 86 cc fd 96 97 e3 93 16
Jun 20 03:02:17 lme-fw pluto[11919]: | 59 47 46 d4 38 03 17 d4 8c e4 9a 68 82 89 3f 49
Jun 20 03:02:17 lme-fw pluto[11919]: | 01 b9 5e a2 fa 7c 84 97 85 03 55 0d 0f 24 1b 86
Jun 20 03:02:17 lme-fw pluto[11919]: | ef 2d 01 48 c1 cb ac 1c 29 65 79 f8 de 35 41 8d
Jun 20 03:02:17 lme-fw pluto[11919]: | f7 4e d2 75 21 ba 16 d3 95 db 2e 59 dd 69 b7 6c
Jun 20 03:02:17 lme-fw pluto[11919]: | 96 99 7f 46 6a ca e0 66 cd 91 10 52 fa 5f 1c cf
Jun 20 03:02:17 lme-fw pluto[11919]: | 0a d4 06 c4 6e 9e 98 cd 9b 26 3f 39 f1 b0 49 60
Jun 20 03:02:17 lme-fw pluto[11919]: | 45 5e 12 76 05 bf 4a 8d 1f ac e6 e7 25 88 3a aa
Jun 20 03:02:17 lme-fw pluto[11919]: | DH_r: 3b e0 40 17 0a 36 c1 5b 52 b2 f0 3b c9 9f bb 64
Jun 20 03:02:17 lme-fw pluto[11919]: | 85 68 46 c1 ec e0 68 35 9f 0c 0a 12 d5 86 51 47
Jun 20 03:02:17 lme-fw pluto[11919]: | d8 15 f9 57 32 28 89 bd 5f 1b 49 75 b7 6b 7c 06
Jun 20 03:02:17 lme-fw pluto[11919]: | a1 ce 0f b9 7a 15 3c 3f a0 ef 65 12 f3 14 59 a7
Jun 20 03:02:17 lme-fw pluto[11919]: | eb 60 37 73 84 fc 7e 86 9a 17 7c f2 93 d6 ca f5
Jun 20 03:02:17 lme-fw pluto[11919]: | 08 6c 8a 2a f2 76 eb 4d a4 b9 a1 f9 a8 15 88 46
Jun 20 03:02:17 lme-fw pluto[11919]: | 35 e1 d1 fd 65 98 10 d5 bf 06 a4 e9 55 ee d7 fa
Jun 20 03:02:17 lme-fw pluto[11919]: | 17 c1 e2 55 af 70 6d 44 83 e8 9a e8 68 ed 84 9b
Jun 20 03:02:17 lme-fw pluto[11919]: | fe 9e 6a 6f 27 39 48 0e e0 cd 8b 15 30 0b eb d1
Jun 20 03:02:17 lme-fw pluto[11919]: | b7 fd d4 5d 66 62 b0 5e 71 09 50 e7 ec a1 65 6d
Jun 20 03:02:17 lme-fw pluto[11919]: | ed ef 24 a7 ca e1 71 a9 02 77 92 a0 e1 36 bc 31
Jun 20 03:02:17 lme-fw pluto[11919]: | b4 ae 33 e6 87 db 89 d7 ec 95 e3 d5 74 cc af 22
Jun 20 03:02:17 lme-fw pluto[11919]: | Skeyid: 0d 23 26 62 b1 31 13 b0 84 f7 cf 0e a1 5c af d7
Jun 20 03:02:17 lme-fw pluto[11919]: | Skeyid_d: 20 8e be bf e1 e6 88 6c 93 d8 a4 7b 2e 60 59 f6
Jun 20 03:02:18 lme-fw pluto[11919]: | Skeyid_a: a3 8a b3 66 6a 36 8d 9c a9 79 f9 9e fd 1d 8f b7
Jun 20 03:02:18 lme-fw pluto[11919]: | Skeyid_e: b0 c5 3f 03 e8 3d e8 da f9 fb bd 83 e9 59 8c 18
Jun 20 03:02:18 lme-fw pluto[11919]: | enc key: 95 fa b7 ab ba fc af ea e4 2f ec d5 8d 34 2f 46
Jun 20 03:02:18 lme-fw pluto[11919]: | 4d e1 64 5f 24 f9 51 58
Jun 20 03:02:18 lme-fw pluto[11919]: | IV: bb 44 46 a8 02 a6 d0 5f cd 88 60 cf ac ba a0 22
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: hasher=0x69b140(16)
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: icookie=
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: rcookie=
Jun 20 03:02:18 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: ip= 0c 18 f8 32
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: port=500
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: hash= 19 4e 0d ba 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: hasher=0x69b140(16)
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: icookie=
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: rcookie=
Jun 20 03:02:18 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: ip= 63 87 4f 4a
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: port=500
Jun 20 03:02:18 lme-fw pluto[11919]: | _natd_hash: hash= 13 f0 68 d4 d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:18 lme-fw pluto[11919]: | NAT_TRAVERSAL hash=0 (me:0) (him:0)
Jun 20 03:02:18 lme-fw pluto[11919]: | expected NAT-D(me): 19 4e 0d ba 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:18 lme-fw pluto[11919]: | expected NAT-D(him):
Jun 20 03:02:18 lme-fw pluto[11919]: | 13 f0 68 d4 d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:18 lme-fw pluto[11919]: | received NAT-D: 19 4e 0d ba 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:18 lme-fw pluto[11919]: | NAT_TRAVERSAL hash=1 (me:1) (him:0)
Jun 20 03:02:18 lme-fw pluto[11919]: | expected NAT-D(me): 19 4e 0d ba 89 6f 9c 7d c9 1e 01 7b 71 4a ae e4
Jun 20 03:02:18 lme-fw pluto[11919]: | expected NAT-D(him):
Jun 20 03:02:18 lme-fw pluto[11919]: | 13 f0 68 d4 d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:18 lme-fw pluto[11919]: | received NAT-D: 13 f0 68 d4 d8 45 81 fd 87 d6 ab 41 4d a2 51 24
Jun 20 03:02:18 lme-fw pluto[11919]: | NAT_TRAVERSAL hash=2 (me:1) (him:1)
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: NAT-Traversal: Result using 3: no NAT detected
Jun 20 03:02:18 lme-fw pluto[11919]: | inserting event EVENT_NAT_T_KEEPALIVE, timeout in 20 seconds
Jun 20 03:02:18 lme-fw pluto[11919]: | ***emit ISAKMP Identification Payload (IPsec DOI):
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_SIG
Jun 20 03:02:18 lme-fw pluto[11919]: | ID type: ID_FQDN
Jun 20 03:02:18 lme-fw pluto[11919]: | Protocol ID: 0
Jun 20 03:02:18 lme-fw pluto[11919]: | port: 0
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting 8 raw bytes of my identity into ISAKMP Identification Payload (IPsec DOI)
Jun 20 03:02:18 lme-fw pluto[11919]: | my identity 68 71 2e 6c 6f 63 61 6c
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting length of ISAKMP Identification Payload (IPsec DOI): 16
Jun 20 03:02:18 lme-fw pluto[11919]: | hashing 144 bytes of SA
Jun 20 03:02:18 lme-fw pluto[11919]: | started looking for secret for @hq.local->@janesvillepnt.local of kind PPK_RSA
Jun 20 03:02:18 lme-fw pluto[11919]: | actually looking for secret for @hq.local->@janesvillepnt.local of kind PPK_RSA
Jun 20 03:02:18 lme-fw pluto[11919]: | best_match 0>1 best=0x9b40fe0 (line=1)
Jun 20 03:02:18 lme-fw pluto[11919]: | concluding with best_match=1 best=0x9b40fe0 (lineno=1)
Jun 20 03:02:18 lme-fw pluto[11919]: | signing hash with RSA Key *AQNb9diwR
Jun 20 03:02:18 lme-fw pluto[11919]: | ***emit ISAKMP Signature Payload:
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting 274 raw bytes of SIG_I into ISAKMP Signature Payload
Jun 20 03:02:18 lme-fw pluto[11919]: | SIG_I 4e 9c 8b ac 74 0a 50 4b 89 7e 2b 92 be 29 29 29
Jun 20 03:02:18 lme-fw pluto[11919]: | 29 73 fc 54 71 15 c0 4c c3 a4 af f3 b6 63 55 82
Jun 20 03:02:18 lme-fw pluto[11919]: | 7f f3 ee 72 05 8f d0 92 27 7b eb b0 38 a2 7e c5
Jun 20 03:02:18 lme-fw pluto[11919]: | 40 55 c3 8f 9a 3f de 5c 31 45 6c c7 03 36 69 cc
Jun 20 03:02:18 lme-fw pluto[11919]: | 24 45 e4 44 1d 4a 3c 07 3f e0 e7 c5 f1 bf 0b b9
Jun 20 03:02:18 lme-fw pluto[11919]: | 1d fb 1b 88 03 c5 38 bb 71 97 2f 0e fc 1c ab 41
Jun 20 03:02:18 lme-fw pluto[11919]: | 52 64 2f 4d b2 60 26 ce fb 0b 72 a9 92 75 09 a4
Jun 20 03:02:18 lme-fw pluto[11919]: | 07 8a 91 db 94 a7 d0 17 03 f4 63 3f aa c2 d1 1c
Jun 20 03:02:18 lme-fw pluto[11919]: | e0 01 e4 48 ea 0d c7 26 5b 1c d4 89 62 fa db 5f
Jun 20 03:02:18 lme-fw pluto[11919]: | 82 00 2e 12 95 cf b9 c8 70 1a d5 1e 58 a5 d3 5f
Jun 20 03:02:18 lme-fw pluto[11919]: | 65 f7 ac 66 d9 c5 a8 22 d3 26 58 6f 5c bf 80 53
Jun 20 03:02:18 lme-fw pluto[11919]: | d0 ca d1 fd 29 be f8 26 8f ac 05 76 81 b7 be 3f
Jun 20 03:02:18 lme-fw pluto[11919]: | b9 92 70 0d 4c 0c 73 24 8d af 50 8b 45 c1 61 18
Jun 20 03:02:18 lme-fw pluto[11919]: | 13 69 dd 79 5d 58 2e d9 83 81 01 79 6b ae 80 49
Jun 20 03:02:18 lme-fw pluto[11919]: | b5 1f cb 83 37 80 7e c6 b8 7f e9 54 39 b2 9e da
Jun 20 03:02:18 lme-fw pluto[11919]: | 70 ce 76 57 bf 2b cc 15 3f fd f9 cf 1f 65 63 68
Jun 20 03:02:18 lme-fw pluto[11919]: | fe 43 e6 2d 0a 4a 35 62 b3 22 1c ce 1f ac d6 95
Jun 20 03:02:18 lme-fw pluto[11919]: | 91 12
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting length of ISAKMP Signature Payload: 278
Jun 20 03:02:18 lme-fw pluto[11919]: | encrypting:
Jun 20 03:02:18 lme-fw pluto[11919]: | 09 00 00 10 02 00 00 00 68 71 2e 6c 6f 63 61 6c
Jun 20 03:02:18 lme-fw pluto[11919]: | 00 00 01 16 4e 9c 8b ac 74 0a 50 4b 89 7e 2b 92
Jun 20 03:02:18 lme-fw pluto[11919]: | be 29 29 29 29 73 fc 54 71 15 c0 4c c3 a4 af f3
Jun 20 03:02:18 lme-fw pluto[11919]: | b6 63 55 82 7f f3 ee 72 05 8f d0 92 27 7b eb b0
Jun 20 03:02:18 lme-fw pluto[11919]: | 38 a2 7e c5 40 55 c3 8f 9a 3f de 5c 31 45 6c c7
Jun 20 03:02:18 lme-fw pluto[11919]: | 03 36 69 cc 24 45 e4 44 1d 4a 3c 07 3f e0 e7 c5
Jun 20 03:02:18 lme-fw pluto[11919]: | f1 bf 0b b9 1d fb 1b 88 03 c5 38 bb 71 97 2f 0e
Jun 20 03:02:18 lme-fw pluto[11919]: | fc 1c ab 41 52 64 2f 4d b2 60 26 ce fb 0b 72 a9
Jun 20 03:02:18 lme-fw pluto[11919]: | 92 75 09 a4 07 8a 91 db 94 a7 d0 17 03 f4 63 3f
Jun 20 03:02:18 lme-fw pluto[11919]: | aa c2 d1 1c e0 01 e4 48 ea 0d c7 26 5b 1c d4 89
Jun 20 03:02:18 lme-fw pluto[11919]: | 62 fa db 5f 82 00 2e 12 95 cf b9 c8 70 1a d5 1e
Jun 20 03:02:18 lme-fw pluto[11919]: | 58 a5 d3 5f 65 f7 ac 66 d9 c5 a8 22 d3 26 58 6f
Jun 20 03:02:18 lme-fw pluto[11919]: | 5c bf 80 53 d0 ca d1 fd 29 be f8 26 8f ac 05 76
Jun 20 03:02:18 lme-fw pluto[11919]: | 81 b7 be 3f b9 92 70 0d 4c 0c 73 24 8d af 50 8b
Jun 20 03:02:18 lme-fw pluto[11919]: | 45 c1 61 18 13 69 dd 79 5d 58 2e d9 83 81 01 79
Jun 20 03:02:18 lme-fw pluto[11919]: | 6b ae 80 49 b5 1f cb 83 37 80 7e c6 b8 7f e9 54
Jun 20 03:02:18 lme-fw pluto[11919]: | 39 b2 9e da 70 ce 76 57 bf 2b cc 15 3f fd f9 cf
Jun 20 03:02:18 lme-fw pluto[11919]: | 1f 65 63 68 fe 43 e6 2d 0a 4a 35 62 b3 22 1c ce
Jun 20 03:02:18 lme-fw pluto[11919]: | 1f ac d6 95 91 12
Jun 20 03:02:18 lme-fw pluto[11919]: | IV:
Jun 20 03:02:18 lme-fw pluto[11919]: | bb 44 46 a8 02 a6 d0 5f cd 88 60 cf ac ba a0 22
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting 2 zero bytes of encryption padding into ISAKMP Message
Jun 20 03:02:18 lme-fw pluto[11919]: | encrypting using OAKLEY_3DES_CBC
Jun 20 03:02:18 lme-fw pluto[11919]: | next IV: 15 d6 e0 f0 e0 13 04 b5
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting length of ISAKMP Message: 324
Jun 20 03:02:18 lme-fw pluto[11919]: | complete state transition with STF_OK
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: transition from state STATE_MAIN_I2 to state
STATE_MAIN_I3
Jun 20 03:02:18 lme-fw pluto[11919]: | sending reply packet to 99.135.79.74:500 (from port=500)
Jun 20 03:02:18 lme-fw pluto[11919]: | sending 324 bytes for STATE_MAIN_I2 through eth0:500 to 99.135.79.74:500:
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | 05 10 02 01 00 00 00 00 00 00 01 44 1f e3 6c 3b
Jun 20 03:02:18 lme-fw pluto[11919]: | 25 77 8a d1 4d 98 c6 57 67 7c 3a 7d c4 fe dc 11
Jun 20 03:02:18 lme-fw pluto[11919]: | 0c 25 51 da 63 31 f9 29 6b ab 78 40 84 bc f0 e4
Jun 20 03:02:18 lme-fw pluto[11919]: | ea 67 61 c1 98 55 40 25 2e 0a b2 17 dc 9b 3b ba
Jun 20 03:02:18 lme-fw pluto[11919]: | 20 aa 2d e2 0c 92 8c 97 6c 7b d5 db d2 0f b4 45
Jun 20 03:02:18 lme-fw pluto[11919]: | 6a a6 b5 60 6e e5 91 83 8d f0 0a ca 37 da 23 e9
Jun 20 03:02:18 lme-fw pluto[11919]: | 17 39 ca 7f b2 a5 35 db 6e d7 d3 41 d3 7d 73 b6
Jun 20 03:02:18 lme-fw pluto[11919]: | 2e 10 35 92 f3 aa 8e 1a 96 37 9c 83 25 88 98 e6
Jun 20 03:02:18 lme-fw pluto[11919]: | 4b 62 41 ed f2 c6 c8 ba 68 cd f9 c5 5a 19 4c 7e
Jun 20 03:02:18 lme-fw pluto[11919]: | 80 f4 9a 73 86 21 ac bf e0 11 77 4d 7e 62 a6 14
Jun 20 03:02:18 lme-fw pluto[11919]: | c4 0c 4f e6 7d 0b b5 a3 73 50 56 74 48 4a 55 58
Jun 20 03:02:18 lme-fw pluto[11919]: | 9d 7e 48 ac 9e 33 4c 00 f1 2d c1 84 f2 3d 6d 63
Jun 20 03:02:18 lme-fw pluto[11919]: | 12 46 b7 d9 14 d0 b4 e8 27 5a 4c a6 32 bf 93 b5
Jun 20 03:02:18 lme-fw pluto[11919]: | 94 77 d4 7a c0 6b 44 27 f2 b2 01 27 52 ec 78 5a
Jun 20 03:02:18 lme-fw pluto[11919]: | 1e 33 d5 67 d1 b4 49 0f 5a 5e ad 71 a0 13 1e d5
Jun 20 03:02:18 lme-fw pluto[11919]: | cd 20 ca e4 3c ce f2 4e 92 72 da b9 a9 29 1a 1b
Jun 20 03:02:18 lme-fw pluto[11919]: | 6c aa f1 64 7e c3 eb 6f 45 4d f6 f5 b5 53 02 b8
Jun 20 03:02:18 lme-fw pluto[11919]: | dd a5 91 04 7d 22 d6 33 ff 19 d6 04 8b 4e 28 cd
Jun 20 03:02:18 lme-fw pluto[11919]: | de b5 b9 22 78 d7 c5 ff 8a 35 3b d0 15 d6 e0 f0
Jun 20 03:02:18 lme-fw pluto[11919]: | e0 13 04 b5
Jun 20 03:02:18 lme-fw pluto[11919]: | inserting event EVENT_RETRANSMIT, timeout in 10 seconds for #9
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: STATE_MAIN_I3: sent MI3, expecting MR3
Jun 20 03:02:18 lme-fw pluto[11919]: | modecfg pull: noquirk policy:push not-client
Jun 20 03:02:18 lme-fw pluto[11919]: | phase 1 is done, looking for phase 1 to unpend
Jun 20 03:02:18 lme-fw pluto[11919]: | next event EVENT_RETRANSMIT in 10 seconds for #9
Jun 20 03:02:18 lme-fw pluto[11919]: |
Jun 20 03:02:18 lme-fw pluto[11919]: | *received 340 bytes from 99.135.79.74:500 on eth0 (port=500)
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | 05 10 02 01 00 00 00 00 00 00 01 54 c7 bc 8d 63
Jun 20 03:02:18 lme-fw pluto[11919]: | 54 01 b3 b2 3f ee bc b4 75 ec 1b 96 1f 7d 42 74
Jun 20 03:02:18 lme-fw pluto[11919]: | 0c be 0d ba ba b8 2c c8 f3 5a d5 0b f6 71 6e 7d
Jun 20 03:02:18 lme-fw pluto[11919]: | 32 74 37 2b 48 46 f0 dc ff 15 d8 36 a4 58 2c 7c
Jun 20 03:02:18 lme-fw pluto[11919]: | 56 10 4b 9e 81 4f 1c 02 e2 39 82 7d e7 1f 64 fd
Jun 20 03:02:18 lme-fw pluto[11919]: | 06 3c 7c 68 54 06 23 08 de 25 15 44 64 5e 83 8a
Jun 20 03:02:18 lme-fw pluto[11919]: | 58 ed 08 6d 6d 47 b9 a6 a8 bb 2f 6b 7e 1c 5a 82
Jun 20 03:02:18 lme-fw pluto[11919]: | a4 e2 23 83 8a 77 ae e7 2e f4 b8 fc bf 4e 1b ae
Jun 20 03:02:18 lme-fw pluto[11919]: | 85 e9 b0 e7 d9 72 6f 60 9e 58 0e 02 57 f2 ea e7
Jun 20 03:02:18 lme-fw pluto[11919]: | 66 75 01 57 21 04 cb 9d b6 c3 ff cb 93 0e a5 71
Jun 20 03:02:18 lme-fw pluto[11919]: | 8e b7 f4 65 d0 de f6 07 78 ab ca f3 95 7f e5 d1
Jun 20 03:02:18 lme-fw pluto[11919]: | f1 06 eb e5 10 b2 f6 76 c4 a2 44 2b 99 b0 db 1c
Jun 20 03:02:18 lme-fw pluto[11919]: | 14 8f 9e 39 aa b5 da 43 7e 05 15 1b 0e 83 94 f9
Jun 20 03:02:18 lme-fw pluto[11919]: | e2 01 e8 c2 ad 46 28 82 4b 9a 85 1a e5 1b 16 90
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 1c b6 23 1e 58 0e 6b 13 33 55 2a c4 67 e2 2c
Jun 20 03:02:18 lme-fw pluto[11919]: | c6 82 dc ed 49 fc e9 e6 70 22 d1 91 e5 a6 4d d3
Jun 20 03:02:18 lme-fw pluto[11919]: | 72 94 95 62 4c c9 ba ce 50 62 ab 57 97 96 b5 3f
Jun 20 03:02:18 lme-fw pluto[11919]: | 1d 44 8c 7c d6 b1 8b 8d c7 d9 9f 45 ef bb e8 f8
Jun 20 03:02:18 lme-fw pluto[11919]: | b4 26 4a c2 c9 29 0b f5 9a 4c f5 df db e9 cc 84
Jun 20 03:02:18 lme-fw pluto[11919]: | 75 c7 d9 92 2f d0 8e eb 20 75 2f 43 dc fc 04 06
Jun 20 03:02:18 lme-fw pluto[11919]: | b8 ca 3c 67
Jun 20 03:02:18 lme-fw pluto[11919]: | **parse ISAKMP Message:
Jun 20 03:02:18 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:18 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_ID
Jun 20 03:02:18 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:18 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_IDPROT
Jun 20 03:02:18 lme-fw pluto[11919]: | flags: ISAKMP_FLAG_ENCRYPTION
Jun 20 03:02:18 lme-fw pluto[11919]: | message ID: 00 00 00 00
Jun 20 03:02:18 lme-fw pluto[11919]: | length: 340
Jun 20 03:02:18 lme-fw pluto[11919]: | processing packet with exchange type=ISAKMP_XCHG_IDPROT (2)
Jun 20 03:02:18 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | RCOOKIE: 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:18 lme-fw pluto[11919]: | state hash entry 11
Jun 20 03:02:18 lme-fw pluto[11919]: | peer and cookies match on #9, provided msgid 00000000 vs 00000000
Jun 20 03:02:18 lme-fw pluto[11919]: | state object #9 found, in STATE_MAIN_I3
Jun 20 03:02:18 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:18 lme-fw pluto[11919]: | received encrypted packet from 99.135.79.74:500
Jun 20 03:02:18 lme-fw pluto[11919]: | decrypting 312 bytes using algorithm OAKLEY_3DES_CBC
Jun 20 03:02:18 lme-fw pluto[11919]: | decrypted:
Jun 20 03:02:18 lme-fw pluto[11919]: | 09 00 00 1f 02 00 00 00 6a 61 6e 65 73 76 69 6c
Jun 20 03:02:18 lme-fw pluto[11919]: | 6c 65 63 68 65 65 74 61 68 2e 6c 6f 63 61 6c 00
Jun 20 03:02:18 lme-fw pluto[11919]: | 00 01 16 94 59 ff cd 61 1b 72 e5 f2 9e ee 69 20
Jun 20 03:02:18 lme-fw pluto[11919]: | ef 4a af 14 cd 78 9e d0 d3 eb 93 27 f7 aa dc ac
Jun 20 03:02:18 lme-fw pluto[11919]: | 42 a7 ed eb 4c 31 dc a1 63 7d 54 65 6a 44 5e 78
Jun 20 03:02:18 lme-fw pluto[11919]: | df 68 92 b0 a6 66 0c 92 7d d0 b4 41 5a 3a 24 42
Jun 20 03:02:18 lme-fw pluto[11919]: | 97 c9 1d b0 6c 21 5c 9f 28 5a 9b c6 7d fe c0 5d
Jun 20 03:02:18 lme-fw pluto[11919]: | 7e 86 bc 5b 5b 4c 5c 92 26 48 89 6c f2 04 b1 63
Jun 20 03:02:18 lme-fw pluto[11919]: | a1 2e ab 40 10 cf e5 d0 3f 42 aa 27 73 35 d9 5a
Jun 20 03:02:18 lme-fw pluto[11919]: | 05 0d fb 32 9a 10 4d 6a 7f 43 7e f7 2c 25 67 48
Jun 20 03:02:18 lme-fw pluto[11919]: | 9a e6 e8 b1 18 06 d6 e7 b2 f6 c5 bd 44 86 b2 34
Jun 20 03:02:18 lme-fw pluto[11919]: | b6 b5 08 0d a2 2a ce 78 d3 43 4b f1 3d 93 29 92
Jun 20 03:02:18 lme-fw pluto[11919]: | 34 3b 27 78 dd 64 91 8c 6b dd 48 52 a8 0d 03 fc
Jun 20 03:02:18 lme-fw pluto[11919]: | ad 07 6b 7c 89 ef 93 05 ec 20 bc 12 7d 54 9f 2e
Jun 20 03:02:18 lme-fw pluto[11919]: | 5e 43 e3 32 6c f3 a3 7a 8e 28 cd a3 75 e1 84 c2
Jun 20 03:02:18 lme-fw pluto[11919]: | 2a 96 42 37 3f e0 a6 e8 ba 37 23 98 f9 e7 97 b3
Jun 20 03:02:18 lme-fw pluto[11919]: | e1 7b 76 a3 ae 1d 36 7c 68 72 23 14 f3 a5 76 c1
Jun 20 03:02:18 lme-fw pluto[11919]: | 19 95 d1 72 58 ad c4 54 2d a3 57 ab ac ba d4 2d
Jun 20 03:02:18 lme-fw pluto[11919]: | 96 87 d3 63 96 36 f6 bb 07 fa 1d 98 50 fd 24 58
Jun 20 03:02:18 lme-fw pluto[11919]: | cd 26 51 a4 de 00 00 00
Jun 20 03:02:18 lme-fw pluto[11919]: | next IV: dc fc 04 06 b8 ca 3c 67
Jun 20 03:02:18 lme-fw pluto[11919]: | ***parse ISAKMP Identification Payload:
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_SIG
Jun 20 03:02:18 lme-fw pluto[11919]: | length: 31
Jun 20 03:02:18 lme-fw pluto[11919]: | ID type: ID_FQDN
Jun 20 03:02:18 lme-fw pluto[11919]: | DOI specific A: 0
Jun 20 03:02:18 lme-fw pluto[11919]: | DOI specific B: 0
Jun 20 03:02:18 lme-fw pluto[11919]: | ***parse ISAKMP Signature Payload:
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:18 lme-fw pluto[11919]: | length: 278
Jun 20 03:02:18 lme-fw pluto[11919]: | removing 3 bytes of padding
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: Main mode peer ID is ID_FQDN: '@janesvillecheetah.local'
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: we require peer to have ID '@janesvillepnt.local', but
peer declares '@janesvillecheetah.local'
Jun 20 03:02:18 lme-fw pluto[11919]: | complete state transition with (null)
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: sending encrypted notification INVALID_ID_INFORMATION to
99.135.79.74:500
Jun 20 03:02:18 lme-fw pluto[11919]: | **emit ISAKMP Message:
Jun 20 03:02:18 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:18 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_HASH
Jun 20 03:02:18 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:18 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_INFO
Jun 20 03:02:18 lme-fw pluto[11919]: | flags: ISAKMP_FLAG_ENCRYPTION
Jun 20 03:02:18 lme-fw pluto[11919]: | message ID: 89 19 db 4a
Jun 20 03:02:18 lme-fw pluto[11919]: | ***emit ISAKMP Hash Payload:
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_N
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting 16 zero bytes of HASH(1) into ISAKMP Hash Payload
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting length of ISAKMP Hash Payload: 20
Jun 20 03:02:18 lme-fw pluto[11919]: | ***emit ISAKMP Notification Payload:
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:18 lme-fw pluto[11919]: | DOI: ISAKMP_DOI_IPSEC
Jun 20 03:02:18 lme-fw pluto[11919]: | protocol ID: 1
Jun 20 03:02:18 lme-fw pluto[11919]: | SPI size: 0
Jun 20 03:02:18 lme-fw pluto[11919]: | Notify Message Type: INVALID_ID_INFORMATION
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting length of ISAKMP Notification Payload: 12
Jun 20 03:02:18 lme-fw pluto[11919]: | HASH(1) computed:
Jun 20 03:02:18 lme-fw pluto[11919]: | 98 c2 2f df d4 0e 82 af 48 f2 00 d2 06 c7 10 9a
Jun 20 03:02:18 lme-fw pluto[11919]: | last Phase 1 IV:
Jun 20 03:02:18 lme-fw pluto[11919]: | current Phase 1 IV: dc fc 04 06 b8 ca 3c 67
Jun 20 03:02:18 lme-fw pluto[11919]: | computed Phase 2 IV:
Jun 20 03:02:18 lme-fw pluto[11919]: | 01 ae 1f 24 b1 ae 60 9f c8 7d 06 ac 04 2b 0c de
Jun 20 03:02:18 lme-fw pluto[11919]: | encrypting:
Jun 20 03:02:18 lme-fw pluto[11919]: | 0b 00 00 14 98 c2 2f df d4 0e 82 af 48 f2 00 d2
Jun 20 03:02:18 lme-fw pluto[11919]: | 06 c7 10 9a 00 00 00 0c 00 00 00 01 01 00 00 12
Jun 20 03:02:18 lme-fw pluto[11919]: | IV:
Jun 20 03:02:18 lme-fw pluto[11919]: | 01 ae 1f 24 b1 ae 60 9f c8 7d 06 ac 04 2b 0c de
Jun 20 03:02:18 lme-fw pluto[11919]: | encrypting using OAKLEY_3DES_CBC
Jun 20 03:02:18 lme-fw pluto[11919]: | next IV: 1b ad b8 e4 41 56 8c 22
Jun 20 03:02:18 lme-fw pluto[11919]: | emitting length of ISAKMP Message: 60
Jun 20 03:02:18 lme-fw pluto[11919]: | sending 60 bytes for notification packet through eth0:500 to 99.135.79.74:500:
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | 08 10 05 01 89 19 db 4a 00 00 00 3c 6f 93 6e d9
Jun 20 03:02:18 lme-fw pluto[11919]: | c6 f3 94 8d 3c 6a 47 bc 92 8d 04 ae 2e 40 10 0a
Jun 20 03:02:18 lme-fw pluto[11919]: | 69 a2 aa 72 1b ad b8 e4 41 56 8c 22
Jun 20 03:02:18 lme-fw pluto[11919]: | state transition function for STATE_MAIN_I3 failed: INVALID_ID_INFORMATION
Jun 20 03:02:18 lme-fw pluto[11919]: | next event EVENT_NAT_T_KEEPALIVE in 20 seconds
Jun 20 03:02:18 lme-fw pluto[11919]: |
Jun 20 03:02:18 lme-fw pluto[11919]: | *received 40 bytes from 99.135.79.74:500 on eth0 (port=500)
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | 0b 10 05 00 98 f0 e6 b2 00 00 00 28 00 00 00 0c
Jun 20 03:02:18 lme-fw pluto[11919]: | 00 00 00 01 01 00 00 10
Jun 20 03:02:18 lme-fw pluto[11919]: | **parse ISAKMP Message:
Jun 20 03:02:18 lme-fw pluto[11919]: | initiator cookie:
Jun 20 03:02:18 lme-fw pluto[11919]: | 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | responder cookie:
Jun 20 03:02:18 lme-fw pluto[11919]: | 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_N
Jun 20 03:02:18 lme-fw pluto[11919]: | ISAKMP version: ISAKMP Version 1.0
Jun 20 03:02:18 lme-fw pluto[11919]: | exchange type: ISAKMP_XCHG_INFO
Jun 20 03:02:18 lme-fw pluto[11919]: | flags: none
Jun 20 03:02:18 lme-fw pluto[11919]: | message ID: 98 f0 e6 b2
Jun 20 03:02:18 lme-fw pluto[11919]: | length: 40
Jun 20 03:02:18 lme-fw pluto[11919]: | processing packet with exchange type=ISAKMP_XCHG_INFO (5)
Jun 20 03:02:18 lme-fw pluto[11919]: | ICOOKIE: 84 44 2b e6 d3 fe 61 fe
Jun 20 03:02:18 lme-fw pluto[11919]: | RCOOKIE: 4c 3c 46 99 75 14 1f 72
Jun 20 03:02:18 lme-fw pluto[11919]: | peer: 63 87 4f 4a
Jun 20 03:02:18 lme-fw pluto[11919]: | state hash entry 11
Jun 20 03:02:18 lme-fw pluto[11919]: | peer and cookies match on #9, provided msgid 00000000 vs 00000000/00000000
Jun 20 03:02:18 lme-fw pluto[11919]: | p15 state object #9 found, in STATE_MAIN_I3
Jun 20 03:02:18 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:18 lme-fw pluto[11919]: | ***parse ISAKMP Notification Payload:
Jun 20 03:02:18 lme-fw pluto[11919]: | next payload type: ISAKMP_NEXT_NONE
Jun 20 03:02:18 lme-fw pluto[11919]: | length: 12
Jun 20 03:02:18 lme-fw pluto[11919]: | DOI: ISAKMP_DOI_IPSEC
Jun 20 03:02:18 lme-fw pluto[11919]: | protocol ID: 1
Jun 20 03:02:18 lme-fw pluto[11919]: | SPI size: 0
Jun 20 03:02:18 lme-fw pluto[11919]: | Notify Message Type: PAYLOAD_MALFORMED
Jun 20 03:02:18 lme-fw pluto[11919]: | info:
Jun 20 03:02:18 lme-fw pluto[11919]: | processing informational PAYLOAD_MALFORMED (16)
Jun 20 03:02:18 lme-fw pluto[11919]: "JanesvillePNT-Everywhere" #9: received 1 malformed payload notifies
Jun 20 03:02:18 lme-fw pluto[11919]: | complete state transition with STF_IGNORE
Jun 20 03:02:18 lme-fw pluto[11919]: | next event EVENT_NAT_T_KEEPALIVE in 20 seconds
Jun 20 03:02:38 lme-fw pluto[11919]: |
Jun 20 03:02:38 lme-fw pluto[11919]: | *time to handle event
Jun 20 03:02:38 lme-fw pluto[11919]: | handling event EVENT_NAT_T_KEEPALIVE
Jun 20 03:02:38 lme-fw pluto[11919]: | event after this is EVENT_PENDING_PHASE2 in 30 seconds
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection JanesvillePNT-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection Wichita-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection Wichita-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection Rochester-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection Rochester-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection JanesvilleCheetah-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection Columbia-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection JanesvilleCheetah-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | processing connection Columbia-Everywhere
Jun 20 03:02:38 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 30 seconds
Jun 20 03:03:08 lme-fw pluto[11919]: |
Jun 20 03:03:08 lme-fw pluto[11919]: | *time to handle event
Jun 20 03:03:08 lme-fw pluto[11919]: | handling event EVENT_PENDING_PHASE2
Jun 20 03:03:08 lme-fw pluto[11919]: | event after this is EVENT_SA_REPLACE in 1933 seconds
Jun 20 03:03:08 lme-fw pluto[11919]: | inserting event EVENT_PENDING_PHASE2, timeout in 120 seconds
Jun 20 03:03:08 lme-fw pluto[11919]: | pending review: connection "JanesvillePNT-Everywhere" checked
Jun 20 03:03:08 lme-fw pluto[11919]: | pending review: connection "JanesvilleCheetah-Everywhere" checked
Jun 20 03:03:08 lme-fw pluto[11919]: | pending review: connection "Rochester-Everywhere" checked
Jun 20 03:03:08 lme-fw pluto[11919]: | pending review: connection "Columbia-Everywhere" checked
Jun 20 03:03:08 lme-fw pluto[11919]: | pending review: connection "Wichita-Everywhere" checked
Jun 20 03:03:08 lme-fw pluto[11919]: | next event EVENT_PENDING_PHASE2 in 120 seconds
<<secure.log>>
More information about the Users
mailing list