May 25 21:14:53 komp clear-log[24332]: logfile cleared [May 25 21:15:12]iked_pm_ike_spd_notify_request: Sending Initial contact [May 25 21:15:12]ssh_ike_connect: Start, remote_name = 5.8.180.230:500, xchg = 2, flags = 00090000 [May 25 21:15:12]ike_sa_allocate: Start, SA = { 6d9fcbd2 aea9aacf - 00000000 00000000 } [May 25 21:15:12]ike_init_isakmp_sa: Start, remote = 5.8.180.230:500, initiator = 1 [May 25 21:15:12]ssh_ike_connect: SA = { 6d9fcbd2 aea9aacf - 00000000 00000000}, nego = -1 [May 25 21:15:12]ike_st_o_sa_proposal: Start [May 25 21:15:12]ike_policy_reply_isakmp_vendor_ids: Start [May 25 21:15:12]ike_st_o_private: Start [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_encode_packet: Start, SA = { 0x6d9fcbd2 aea9aacf - 00000000 00000000 } / 00000000, nego = -1 [May 25 21:15:12]ike_send_packet: Start, send SA = { 6d9fcbd2 aea9aacf - 00000000 00000000}, nego = -1, dst = 5.8.180.230:500, routing table id = 0 [May 25 21:15:12]ikev2_packet_allocate: Allocated packet 8c52c00 from freelist [May 25 21:15:12]ike_sa_find: Not found SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:12]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:12]ike_get_sa: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } / 00000000, remote = 5.8.180.230:500 [May 25 21:15:12]ike_sa_find: Not found SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:12]ike_sa_find_half: Found half SA = { 6d9fcbd2 aea9aacf - 00000000 00000000 } [May 25 21:15:12]ike_sa_upgrade: Start, SA = { 6d9fcbd2 aea9aacf - 00000000 00000000 } -> { ... - 2117a5dc a03c1236 } [May 25 21:15:12]ike_decode_packet: Start [May 25 21:15:12]ike_decode_packet: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236} / 00000000, nego = -1 [May 25 21:15:12]ike_decode_payload_sa: Start [May 25 21:15:12]ike_decode_payload_t: Start, # trans = 1 [May 25 21:15:12]ike_st_i_sa_value: Start [May 25 21:15:12]ike_st_i_cr: Start [May 25 21:15:12]ike_st_i_cert: Start [May 25 21:15:12]ike_st_i_vid: VID[0..16] = afcad713 68a1f1c9 ... [May 25 21:15:12]ike_st_i_vid: VID[0..16] = 4a131c81 07035845 ... [May 25 21:15:12]ike_st_i_vid: VID[0..28] = 69936922 8741c6d4 ... [May 25 21:15:12]ike_st_i_private: Start [May 25 21:15:12]ike_st_o_ke: Start [May 25 21:15:12]ike_st_o_nonce: Start [May 25 21:15:12]ike_policy_reply_isakmp_nonce_data_len: Start [May 25 21:15:12]ike_st_o_private: Start [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_encode_packet: Start, SA = { 0x6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } / 00000000, nego = -1 [May 25 21:15:12]ike_send_packet: Start, send SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = -1, dst = 5.8.180.230:500, routing table id = 0 [May 25 21:15:12]ikev2_packet_allocate: Allocated packet 8c53000 from freelist [May 25 21:15:12]ike_sa_find: Found SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:12]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:12]ike_get_sa: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } / 00000000, remote = 5.8.180.230:500 [May 25 21:15:12]ike_sa_find: Found SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:12]ike_decode_packet: Start [May 25 21:15:12]ike_decode_packet: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236} / 00000000, nego = -1 [May 25 21:15:12]ike_st_i_nonce: Start, nonce[0..16] = f60b2ed0 be360c71 ... [May 25 21:15:12]ike_st_i_ke: Ke[0..256] = 31ea5e80 213e0bf8 ... [May 25 21:15:12]ike_st_i_cr: Start [May 25 21:15:12]ike_st_i_cert: Start [May 25 21:15:12]ike_st_i_private: Start [May 25 21:15:12]ike_st_o_id: Start [May 25 21:15:12]ike_st_o_hash: Start [May 25 21:15:12]ike_find_pre_shared_key: Find pre shared key key for 10.69.253.4:500, id = ipv4(any:0,[0..3]=185.12.29.20) -> 5.8.180.230:500, id = No Id [May 25 21:15:12]ike_policy_reply_find_pre_shared_key: Start [May 25 21:15:12]ike_calc_mac: Start, initiator = true, local = true [May 25 21:15:12]ike_st_o_status_n: Start [May 25 21:15:12]ike_st_o_private: Start [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_st_o_encrypt: Marking encryption for packet [May 25 21:15:12]ike_encode_packet: Start, SA = { 0x6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } / 00000000, nego = -1 [May 25 21:15:12]ike_send_packet: Start, send SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = -1, dst = 5.8.180.230:4500, routing table id = 0 [May 25 21:15:12]ikev2_packet_allocate: Allocated packet 8c53400 from freelist [May 25 21:15:12]ike_sa_find: Found SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:12]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:12]ike_get_sa: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } / 00000000, remote = 5.8.180.230:4500 [May 25 21:15:12]ike_sa_find: Found SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:12]ike_decode_packet: Start [May 25 21:15:12]ike_decode_packet: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236} / 00000000, nego = -1 [May 25 21:15:12]ike_st_i_encrypt: Check that packet was encrypted succeeded [May 25 21:15:12]ike_st_i_id: Start [May 25 21:15:12]ike_st_i_hash: Start, hash[0..32] = 0f6acf5f 8948dede ... [May 25 21:15:12]ike_calc_mac: Start, initiator = true, local = false [May 25 21:15:12]ike_st_i_cert: Start [May 25 21:15:12]ike_st_i_private: Start [May 25 21:15:12]ike_st_o_wait_done: Marking for waiting for done [May 25 21:15:12]ike_st_o_all_done: MESSAGE: Phase 1 { 0x6d9fcbd2 aea9aacf - 0x2117a5dc a03c1236 } / 00000000, version = 1.0, xchg = Identity protect, auth_method = Pre shared keys, Initiator, cipher = aes-cbc, hash = sha256, prf = hmac-sha [May 25 21:15:12]10.69.253.4:4500 (Initiator) <-> 5.8.180.230:4500 { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 [-1] / 0x00000000 } IP; MESSAGE: Phase 1 version = 1.0, auth_method = Pre shared keys, cipher = aes-cbc, hash = sha256, prf = hmac-sh [May 25 21:15:12]ike_send_notify: Connected, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = -1 [May 25 21:15:12]iked_pm_ike_sa_done: local:10.69.253.4, remote:5.8.180.230 IKEv1 [May 25 21:15:12]IKE negotiation done for local:10.69.253.4, remote:5.8.180.230 IKEv1 with status: Error ok [May 25 21:15:12]Added (spi=0x7152d5f9, protocol=0) entry to the spi table [May 25 21:15:12]Added (spi=0xbf71dd9d, protocol=0) entry to the spi table [May 25 21:15:12]ssh_ike_connect_ipsec: Start, remote_name = :500, flags = 00010000 [May 25 21:15:12]ike_alloc_negotiation: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236} [May 25 21:15:12]ssh_ike_connect_ipsec: SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = 0 [May 25 21:15:12]ike_init_qm_negotiation: Start, initiator = 1, message_id = 8cc9d469 [May 25 21:15:12]ike_st_o_qm_hash_1: Start [May 25 21:15:12]ike_st_o_qm_sa_proposals: Start [May 25 21:15:12]ike_st_o_qm_nonce: Start [May 25 21:15:12]ike_policy_reply_qm_nonce_data_len: Start [May 25 21:15:12]ike_st_o_qm_optional_ke: Start [May 25 21:15:12]ike_st_o_qm_optional_ids: Start [May 25 21:15:12]ike_st_qm_optional_id: Start [May 25 21:15:12]ike_st_qm_optional_id: Start [May 25 21:15:12]ike_st_o_private: Start [May 25 21:15:12]Construction NHTB payload for local:10.69.253.4, remote:5.8.180.230 IKEv1 P1 SA index 605016 sa-cfg gw-jvsrx-b [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_policy_reply_private_payload_out: Start [May 25 21:15:12]ike_st_o_encrypt: Marking encryption for packet [May 25 21:15:12]ike_encode_packet: Start, SA = { 0x6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } / 8cc9d469, nego = 0 [May 25 21:15:12]ike_finalize_qm_hash_1: Hash[0..32] = dc7803cf a8d1b6f4 ... [May 25 21:15:12]ike_send_packet: Start, send SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = 0, dst = 5.8.180.230:4500, routing table id = 0 [May 25 21:15:12]iked_deferred_free_inactive_peer_entry: Free 1 peer_entry(s) [May 25 21:15:13]ikev2_packet_allocate: Allocated packet 8c53800 from freelist [May 25 21:15:13]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:13]ike_get_sa: Start, SA = { 9bf5a7f4 5d8ca403 - 00000000 00000000 } / 00000000, remote = 5.8.180.230:500 [May 25 21:15:13]ike_sa_allocate: Start, SA = { 9bf5a7f4 5d8ca403 - ce8bd523 9417f8c7 } [May 25 21:15:13]ike_init_isakmp_sa: Start, remote = 5.8.180.230:500, initiator = 0 [May 25 21:15:13]ike_decode_packet: Start [May 25 21:15:13]ike_decode_packet: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} / 00000000, nego = -1 [May 25 21:15:13]ike_decode_payload_sa: Start [May 25 21:15:13]ike_decode_payload_t: Start, # trans = 1 [May 25 21:15:13]ike_st_i_vid: VID[0..16] = afcad713 68a1f1c9 ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = 27bab5dc 01ea0760 ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = 6105c422 e76847e4 ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = 4485152d 18b6bbcd ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = cd604643 35df21f8 ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = 90cb8091 3ebb696e ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = 7d9419a6 5310ca6f ... [May 25 21:15:13]ike_st_i_vid: VID[0..16] = 4a131c81 07035845 ... [May 25 21:15:13]ike_st_i_vid: VID[0..28] = 69936922 8741c6d4 ... [May 25 21:15:13]ike_st_i_sa_proposal: Start [May 25 21:15:13]ike_isakmp_sa_reply: Start [May 25 21:15:13]ike_state_restart_packet: Start, restart packet SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]ike_st_i_sa_proposal: Start [May 25 21:15:13]ike_st_i_cr: Start [May 25 21:15:13]ike_st_i_cert: Start [May 25 21:15:13]ike_st_i_private: Start [May 25 21:15:13]ike_st_o_sa_values: Start [May 25 21:15:13]ike_policy_reply_isakmp_vendor_ids: Start [May 25 21:15:13]ike_st_o_private: Start [May 25 21:15:13]ike_policy_reply_private_payload_out: Start [May 25 21:15:13]ike_encode_packet: Start, SA = { 0x9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / 00000000, nego = -1 [May 25 21:15:13]ike_send_packet: Start, send SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1, dst = 5.8.180.230:500, routing table id = 0 [May 25 21:15:13]ikev2_packet_allocate: Allocated packet 8c53c00 from freelist [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:13]ike_get_sa: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / 00000000, remote = 5.8.180.230:500 [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ike_decode_packet: Start [May 25 21:15:13]ike_decode_packet: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} / 00000000, nego = -1 [May 25 21:15:13]ike_st_i_nonce: Start, nonce[0..16] = 263f2056 ca58d79b ... [May 25 21:15:13]ike_st_i_ke: Ke[0..256] = d490747b f629acda ... [May 25 21:15:13]ike_st_i_cr: Start [May 25 21:15:13]ike_st_i_cert: Start [May 25 21:15:13]ike_st_i_private: Start [May 25 21:15:13]ike_st_o_ke: Start [May 25 21:15:13]ike_st_o_nonce: Start [May 25 21:15:13]ike_policy_reply_isakmp_nonce_data_len: Start [May 25 21:15:13]ike_find_pre_shared_key: Find pre shared key key for 10.69.253.4:500, id = No Id -> 5.8.180.230:500, id = No Id [May 25 21:15:13]ike_policy_reply_find_pre_shared_key: Start [May 25 21:15:13]ike_state_restart_packet: Start, restart packet SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]ike_find_pre_shared_key: Find pre shared key key for 10.69.253.4:500, id = No Id -> 5.8.180.230:500, id = No Id [May 25 21:15:13]ike_st_o_private: Start [May 25 21:15:13]ike_policy_reply_private_payload_out: Start [May 25 21:15:13]ike_policy_reply_private_payload_out: Start [May 25 21:15:13]ike_policy_reply_private_payload_out: Start [May 25 21:15:13]ike_st_o_calc_skeyid: Calculating skeyid [May 25 21:15:13]ike_find_pre_shared_key: Find pre shared key key for 10.69.253.4:500, id = No Id -> 5.8.180.230:500, id = No Id [May 25 21:15:13]ike_encode_packet: Start, SA = { 0x9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / 00000000, nego = -1 [May 25 21:15:13]ike_send_packet: Start, send SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1, dst = 5.8.180.230:500, routing table id = 0 [May 25 21:15:13]ikev2_packet_allocate: Allocated packet 8c54000 from freelist [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:13]ike_get_sa: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / 00000000, remote = 5.8.180.230:4500 [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ike_decode_packet: Start [May 25 21:15:13]ike_decode_packet: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} / 00000000, nego = -1 [May 25 21:15:13]ike_st_i_encrypt: Check that packet was encrypted succeeded [May 25 21:15:13]ike_st_i_id: Start [May 25 21:15:13]ike_st_i_hash: Start, hash[0..32] = 615576ce cc4b4add ... [May 25 21:15:13]ike_calc_mac: Start, initiator = false, local = false [May 25 21:15:13]ike_st_i_cert: Start [May 25 21:15:13]ike_st_i_status_n: Start, doi = 1, protocol = 1, code = Initial contact notification (24578), spi[0..16] = 9bf5a7f4 5d8ca403 ..., data[0..0] = 00000000 00000000 ... [May 25 21:15:13]iked_pm_ike_spd_notify_received: Received authenticated notification payload unknown from local:10.69.253.4 remote:5.8.180.230 IKEv1 for P1 SA 605017 [May 25 21:15:13]ike_st_i_private: Start [May 25 21:15:13]ike_st_o_id: Start [May 25 21:15:13]ike_policy_reply_isakmp_id: Start [May 25 21:15:13]ike_state_restart_packet: Start, restart packet SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]ike_st_o_id: Start [May 25 21:15:13]ike_st_o_hash: Start [May 25 21:15:13]ike_calc_mac: Start, initiator = false, local = true [May 25 21:15:13]ike_st_o_status_n: Start [May 25 21:15:13]ike_st_o_private: Start [May 25 21:15:13]ike_policy_reply_private_payload_out: Start [May 25 21:15:13]ike_st_o_encrypt: Marking encryption for packet [May 25 21:15:13]ike_st_o_wait_done: Marking for waiting for done [May 25 21:15:13]ike_st_o_all_done: MESSAGE: Phase 1 { 0x9bf5a7f4 5d8ca403 - 0x6f7b2ae3 2bdb69be } / 00000000, version = 1.0, xchg = Identity protect, auth_method = Pre shared keys, Responder, cipher = aes-cbc, hash = sha256, prf = hmac-sha [May 25 21:15:13]10.69.253.4:4500 (Responder) <-> 5.8.180.230:4500 { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be [-1] / 0x00000000 } IP; MESSAGE: Phase 1 version = 1.0, auth_method = Pre shared keys, cipher = aes-cbc, hash = sha256, prf = hmac-sh [May 25 21:15:13]ike_encode_packet: Start, SA = { 0x9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / 00000000, nego = -1 [May 25 21:15:13]ike_send_packet: Start, send SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1, dst = 5.8.180.230:4500, routing table id = 0 [May 25 21:15:13]ike_send_notify: Connected, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]iked_pm_ike_sa_done: local:10.69.253.4, remote:5.8.180.230 IKEv1 [May 25 21:15:13]IKE negotiation done for local:10.69.253.4, remote:5.8.180.230 IKEv1 with status: Error ok [May 25 21:15:13]iked_pm_ike_sa_delete_done_cb: For p1 sa index 605016, ref cnt 2, status: Error ok [May 25 21:15:13]ike_remove_callback: Start, delete SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = -1 [May 25 21:15:13]ike_delete_negotiation: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236}, nego = -1 [May 25 21:15:13]ssh_ike_tunnel_table_entry_delete: Deleting tunnel_id: 0 from IKE tunnel table [May 25 21:15:13]ssh_ike_tunnel_table_entry_delete: The tunnel id: 0 doesn't exist in IKE tunnel table [May 25 21:15:13]ike_sa_delete: Start, SA = { 6d9fcbd2 aea9aacf - 2117a5dc a03c1236 } [May 25 21:15:13]ike_free_negotiation_qm: Start, nego = 0 [May 25 21:15:13]ike_free_negotiation: Start, nego = 0 [May 25 21:15:13]ike_free_id_payload: Start, id type = 4 [May 25 21:15:13]ike_free_id_payload: Start, id type = 4 [May 25 21:15:13]ike_free_negotiation_isakmp: Start, nego = -1 [May 25 21:15:13]ike_free_negotiation: Start, nego = -1 [May 25 21:15:13]IKE SA delete called for p1 sa 605016 (ref cnt 2) local:10.69.253.4, remote:5.8.180.230, IKEv1 [May 25 21:15:13]P1 SA 605016 reference count is not zero (1). Delaying deletion of SA [May 25 21:15:13]ike_free_id_payload: Start, id type = 1 [May 25 21:15:13]ike_free_id_payload: Start, id type = 1 [May 25 21:15:13]ike_free_sa: Start [May 25 21:15:13]iked_pm_p1_sa_destroy: p1 sa 605016 (ref cnt 0), waiting_for_del 0x8c05400 [May 25 21:15:13]ikev2_packet_allocate: Allocated packet 8c54400 from freelist [May 25 21:15:13]ikev2_packet_allocate: Allocated packet 8c54800 from freelist [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:13]ike_get_sa: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / 9ea2f0e8, remote = 5.8.180.230:4500 [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ike_st_o_done: ISAKMP SA negotiation done [May 25 21:15:13]ike_send_notify: Connected, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]ike_free_negotiation_isakmp: Start, nego = -1 [May 25 21:15:13]ike_free_negotiation: Start, nego = -1 [May 25 21:15:13]ike_alloc_negotiation: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} [May 25 21:15:13]ike_init_qm_negotiation: Start, initiator = 0, message_id = 9ea2f0e8 [May 25 21:15:13]ike_decode_packet: Start [May 25 21:15:13]ike_decode_packet: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} / 9ea2f0e8, nego = 0 [May 25 21:15:13]ike_decode_payload_sa: Start [May 25 21:15:13]ike_decode_payload_t: Start, # trans = 1 [May 25 21:15:13]ike_st_i_encrypt: Check that packet was encrypted succeeded [May 25 21:15:13]ike_st_i_qm_hash_1: Start, hash[0..32] = 7e04abb6 e9c7f1c6 ... [May 25 21:15:13]ike_st_i_qm_nonce: Nonce[0..16] = 571815a5 88650625 ... [May 25 21:15:13]ike_st_i_qm_ke: Ke[0..256] = 9ed4a545 0b2e4918 ... [May 25 21:15:13]ike_st_i_qm_sa_proposals: Start [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ikev2_packet_v1_start: Passing IKE v1.0 packet to IKEv1 library [May 25 21:15:13]ike_get_sa: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } / a5aa3bc8, remote = 5.8.180.230:4500 [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ike_alloc_negotiation: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} [May 25 21:15:13]ike_decode_packet: Start [May 25 21:15:13]ike_decode_packet: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be} / a5aa3bc8, nego = 1 [May 25 21:15:13]ike_st_i_encrypt: Check that packet was encrypted succeeded [May 25 21:15:13]ike_st_i_gen_hash: Start, hash[0..32] = 4f7dbb5b 783e8ece ... [May 25 21:15:13]ike_st_i_d: Start, doi = 1, protocol = 1, spis[0..1][0..16] = [9bf5a7f4 5d8ca403 ...] [May 25 21:15:13]ike_sa_find: Found SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]:4500 (Responder) <-> 5.8.180.230:4500 { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be [1] / 0xa5aa3bc8 } Info; delete spi[16] = 0x9bf5a7f4 5d8ca403 6f7b2ae3 2bdb69be [May 25 21:15:13]ike_st_i_private: Start [May 25 21:15:13]ike_send_notify: Connected, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = 1 [May 25 21:15:13]ike_delete_negotiation: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = 1 [May 25 21:15:13]ike_free_negotiation_info: Start, nego = 1 [May 25 21:15:13]ike_free_negotiation: Start, nego = 1 [May 25 21:15:13]Added (spi=0xb8ebb770, protocol=0) entry to the spi table [May 25 21:15:13]Added (spi=0xe0c07cbf, protocol=0) entry to the spi table [May 25 21:15:13]ike_qm_sa_reply: Start [May 25 21:15:13]ike_qm_sa_reply: Selected proposal 0, and transform 0 for protocol 0 [May 25 21:15:13]ike_remove_callback: Start, delete SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]ike_delete_negotiation: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be}, nego = -1 [May 25 21:15:13]ssh_ike_tunnel_table_entry_delete: Deleting tunnel_id: 0 from IKE tunnel table [May 25 21:15:13]ssh_ike_tunnel_table_entry_delete: The tunnel id: 0 doesn't exist in IKE tunnel table [May 25 21:15:13]ike_sa_delete: Start, SA = { 9bf5a7f4 5d8ca403 - 6f7b2ae3 2bdb69be } [May 25 21:15:13]ike_free_negotiation_isakmp: Start, nego = -1 [May 25 21:15:13]ike_free_negotiation: Start, nego = -1 [May 25 21:15:13]IKE SA delete called for p1 sa 605017 (ref cnt 2) local:10.69.253.4, remote:5.8.180.230, IKEv1 [May 25 21:15:13]P1 SA 605017 reference count is not zero (1). Delaying deletion of SA [May 25 21:15:13]ike_free_id_payload: Start, id type = 1 [May 25 21:15:13]ike_free_id_payload: Start, id type = 1 [May 25 21:15:13]ike_free_sa: Start [May 25 21:15:13]ike_free_negotiation_qm: Start, nego = 0 [May 25 21:15:13]ike_free_negotiation: Start, nego = 0 [May 25 21:15:13]ike_free_id_payload: Start, id type = 4 [May 25 21:15:13]ike_free_id_payload: Start, id type = 4 [May 25 21:15:13]IPSec negotiation failed for SA-CFG gw-jvsrx-b for local:10.69.253.4, remote:5.8.180.230 IKEv1. status: Invalid syntax [May 25 21:15:13] P2 ed info: flags 0x0, P2 error: Error ok [May 25 21:15:13] IKEv1 Error : Aborted notification [May 25 21:15:13]iked_pm_p1_sa_destroy: p1 sa 605017 (ref cnt 0), waiting_for_del 0x8c05e60 [May 25 21:15:13]iked_deferred_free_inactive_peer_entry: Free 1 peer_entry(s)