=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2019.01.20 23:20:22 =~=~=~=~=~=~=~=~=~=~=~= *Jan 20 23:20:27.431: IKEv2:Adding Proposal aes-cbc-256-proposal1 to toolkit policy *Jan 20 23:20:27.443: IKEv2:(1): Choosing IKE profile profile *Jan 20 23:20:27.447: IKEv2:New ikev2 sa request admitted *Jan 20 23:20:27.447: IKEv2:Incrementing outgoing negotiating sa count by one *Jan 20 23:20:27.455: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: IDLE Event: EV_INIT_SA *Jan 20 23:20:27.459: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GET_IKE_POLICY *Jan 20 23:20:27.463: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_SET_POLICY *Jan 20 23:20:27.463: IKEv2:(SA ID = 1):Setting configured policies *Jan 20 23:20:27.467: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV Cbtme-Spoke1#_CHK_AUTH4PKI *Jan 20 23:20:27.471: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_PKI_SESH_OPEN *Jan 20 23:20:27.475: IKEv2:(SA ID = 1):Opening a PKI session *Jan 20 23:20:27.475: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GEN_DH_KEY *Jan 20 23:20:27.479: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_NO_EVENT *Jan 20 23:20:27.479: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_OK_RECD_DH_PUBKEY_RESP *Jan 20 23:20:27.479: IKEv2:(SA ID = 1):Action: Action_Null *Jan 20 23:20:27.479: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GET_CONFIG_MODE *Jan 20 23:20:27. Cbtme-Spoke1#479: IKEv2:No config data to send to toolkit: *Jan 20 23:20:27.479: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_BLD_MSG *Jan 20 23:20:27.479: IKEv2:Construct Vendor Specific Payload: DELETE-REASON *Jan 20 23:20:27.479: IKEv2:Construct Vendor Specific Payload: (CUSTOM) *Jan 20 23:20:27.479: IKEv2:Construct Notify Payload: NAT_DETECTION_SOURCE_IP *Jan 20 23:20:27.483: IKEv2:Construct Notify Payload: NAT_DETECTION_DESTINATION_IP *Jan 20 23:20:27.483: IKEv2:(SA ID = 1):Next payload: SA, version: 2.0 Exchange type: IKE_SA_INIT, flags: INITIATOR Message id: 0, length: 464 Payload contents: SA Next payload: KE, reserved: 0x0, length: 48 last proposal: 0x0, reserved: 0x0, length: 44 Proposal: 1, Protocol id: IKE, SPI size: 0, #trans: 4 last transform: 0x3, reserved: 0x0: length: 12 type: 1, reserved: 0x0, id: AES-CBC last transform: 0x3, reserved: 0x0: length: 8 type: 2, Cbtme-Spoke1#reserved: 0x0, id: SHA256 last transform: 0x3, reserved: 0x0: length: 8 type: 3, reserved: 0x0, id: SHA256 last transform: 0x0, reserved: 0x0: length: 8 type: 4, reserved: 0x0, id: DH_GROUP_2048_MODP/Group 14 KE Next payload: N, reserved: 0x0, length: 264 DH group: 14, Reserved: 0x0 N Next payload: VID, reserved: 0x0, length: 24 VID Next payload: VID, reserved: 0x0, length: 23 VID Next payload: NOTIFY, reserved: 0x0, length: 21 NOTIFY(NAT_DETECTION_SOURCE_IP) Next payload: NOTIFY, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_SOURCE_IP NOTIFY(NAT_DETECTION_DESTINATION_IP) Next payload: NONE, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_DESTINATION_IP *Jan 20 23:20:27.487: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_INSERT_SA *Jan 20 23:20:27.487: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD4 Cbtme-Spoke1#1 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_WAIT_INIT Event: EV_NO_EVENT *Jan 20 23:20:27.783: IKEv2:Got a packet from dispatcher *Jan 20 23:20:27.791: IKEv2:Processing an item off the pak queue *Jan 20 23:20:27.791: IKEv2:(SA ID = 1):Next payload: SA, version: 2.0 Exchange type: IKE_SA_INIT, flags: RESPONDER MSG-RESPONSE Message id: 0, length: 517 Payload contents: SA Next payload: KE, reserved: 0x0, length: 48 last proposal: 0x0, reserved: 0x0, length: 44 Proposal: 1, Protocol id: IKE, SPI size: 0, #trans: 4 last transform: 0x3, reserved: 0x0: length: 12 type: 1, reserved: 0x0, id: AES-CBC last transform: 0x3, reserved: 0x0: length: 8 type: 2, reserved: 0x0, id: SHA256 last transform: 0x3, reserved: 0x0: length: 8 type: 3, reserved: 0x0, id: SHA256 last transform: 0x0, reserved: 0x0: length: 8 type: 4, reserved: 0x0, id: DH_GROUP_2048_MODP/Group 14 KE Next payload: N, reserved: 0x0, length: 264 DH group: Cbtme-Spoke1#14, Reserved: 0x0 N Next payload: VID, reserved: 0x0, length: 24 *Jan 20 23:20:27.791: IKEv2:Parse Vendor Specific Payload: CISCO-DELETE-REASON VID Next payload: VID, reserved: 0x0, length: 23 *Jan 20 23:20:27.791: IKEv2:Parse Vendor Specific Payload: (CUSTOM) VID Next payload: NOTIFY, reserved: 0x0, length: 21 *Jan 20 23:20:27.791: IKEv2:Parse Notify Payload: NAT_DETECTION_SOURCE_IP NOTIFY(NAT_DETECTION_SOURCE_IP) Next payload: NOTIFY, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_SOURCE_IP *Jan 20 23:20:27.795: IKEv2:Parse Notify Payload: NAT_DETECTION_DESTINATION_IP NOTIFY(NAT_DETECTION_DESTINATION_IP) Next payload: CERTREQ, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_DESTINATION_IP CERTREQ Next payload: NOTIFY, reserved: 0x0, length: 45 Cert encoding Hash and URL of PKIX *Jan 20 23:20:27.795: IKEv2:Parse Notify Payload: HTTP_CERT_LOOKUP_SUPPORTED NOTIFY(HTTP_CE Cbtme-Spoke1#RT_LOOKUP_SUPPORTED) Next payload: NONE, reserved: 0x0, length: 8 Security protocol id: IKE, spi size: 0, type: HTTP_CERT_LOOKUP_SUPPORTED *Jan 20 23:20:27.795: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_WAIT_INIT Event: EV_RECV_INIT *Jan 20 23:20:27.795: IKEv2:(SA ID = 1):Processing IKE_SA_INIT message *Jan 20 23:20:27.795: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK4_NOTIFY *Jan 20 23:20:27.795: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_VERIFY_MSG *Jan 20 23:20:27.795: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_PROC_MSG *Jan 20 23:20:27.799: IKEv2:(SA ID = 1):Matching certificate found *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):SM Trace- Cbtme-Spoke1#> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_DETECT_NAT *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):Process NAT discovery notify *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):Processing nat detect src notify *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):Remote address matched *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):Processing nat detect dst notify *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):Local address matched *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):No NAT found *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK_NAT_T *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK_CONFIG_MODE *Jan 20 23:20:27.803: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: INIT_DONE Event Cbtme-Spoke1#: EV_GEN_DH_SECRET *Jan 20 23:20:28.087: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_NO_EVENT *Jan 20 23:20:28.095: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_OK_RECD_DH_SECRET_RESP *Jan 20 23:20:28.095: IKEv2:(SA ID = 1):Action: Action_Null *Jan 20 23:20:28.099: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_GEN_SKEYID *Jan 20 23:20:28.103: IKEv2:(SA ID = 1):Generate skeyid *Jan 20 23:20:28.111: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_DONE *Jan 20 23:20:28.115: IKEv2:(SA ID = 1):Cisco DeleteReason Notify is enabled *Jan 20 23:20:28.119: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 C Cbtme-Spoke1#urState: INIT_DONE Event: EV_CHK4_ROLE *Jan 20 23:20:28.123: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_GET_CONFIG_MODE *Jan 20 23:20:28.131: IKEv2:Sending config data to toolkit *Jan 20 23:20:28.139: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_CHK_EAP *Jan 20 23:20:28.143: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_GEN_AUTH *Jan 20 23:20:28.147: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_CHK_AUTH_TYPE *Jan 20 23:20:28.147: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_SIGN *Jan 20 23:20:28.523: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 Cbtme-Spoke1# R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_NO_EVENT *Jan 20 23:20:28.523: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_OK_RECD_SIG *Jan 20 23:20:28.523: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_OK_AUTH_GEN *Jan 20 23:20:28.523: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_SEND_AUTH *Jan 20 23:20:28.523: IKEv2:Construct Vendor Specific Payload: CISCO-GRANITE *Jan 20 23:20:28.527: IKEv2:(SA ID = 1):Failed to construct certificate request *Jan 20 23:20:28.527: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000001 CurState: AUTH_DONE Event: EV_FAIL *Jan 20 23:20:28.527: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB Cbtme-Spoke1# (I) MsgID = 00000001 CurState: EXIT Event: EV_ABORT *Jan 20 23:20:28.527: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000001 CurState: EXIT Event: EV_CHK_PENDING_ABORT *Jan 20 23:20:28.527: IKEv2:Negotiating SA request deleted *Jan 20 23:20:28.527: IKEv2:Decrement count for outgoing negotiating *Jan 20 23:20:28.531: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=BB418CA85847FD41 R_SPI=E309695DEEA599DB (I) MsgID = 00000001 CurState: EXIT Event: EV_UPDATE_CAC_STATS Cbtme-Spoke1# *Jan 20 23:21:02.131: IKEv2:Adding Proposal aes-cbc-256-proposal1 to toolkit policy *Jan 20 23:21:02.147: IKEv2:(1): Choosing IKE profile profile *Jan 20 23:21:02.151: IKEv2:New ikev2 sa request admitted *Jan 20 23:21:02.151: IKEv2:Incrementing outgoing negotiating sa count by one *Jan 20 23:21:02.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: IDLE Event: EV_INIT_SA *Jan 20 23:21:02.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GET_IKE_POLICY *Jan 20 23:21:02.159: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_SET_POLICY *Jan 20 23:21:02.159: IKEv2:(SA ID = 1):Setting configured policies *Jan 20 23:21:02.159: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV Cbtme-Spoke1#_CHK_AUTH4PKI *Jan 20 23:21:02.159: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_PKI_SESH_OPEN *Jan 20 23:21:02.159: IKEv2:(SA ID = 1):Opening a PKI session *Jan 20 23:21:02.159: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GEN_DH_KEY *Jan 20 23:21:02.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_NO_EVENT *Jan 20 23:21:02.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_OK_RECD_DH_PUBKEY_RESP *Jan 20 23:21:02.163: IKEv2:(SA ID = 1):Action: Action_Null *Jan 20 23:21:02.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GET_CONFIG_MODE *Jan 20 23:21:02. Cbtme-Spoke1#163: IKEv2:No config data to send to toolkit: *Jan 20 23:21:02.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_BLD_MSG *Jan 20 23:21:02.167: IKEv2:Construct Vendor Specific Payload: DELETE-REASON *Jan 20 23:21:02.167: IKEv2:Construct Vendor Specific Payload: (CUSTOM) *Jan 20 23:21:02.167: IKEv2:Construct Notify Payload: NAT_DETECTION_SOURCE_IP *Jan 20 23:21:02.167: IKEv2:Construct Notify Payload: NAT_DETECTION_DESTINATION_IP *Jan 20 23:21:02.167: IKEv2:(SA ID = 1):Next payload: SA, version: 2.0 Exchange type: IKE_SA_INIT, flags: INITIATOR Message id: 0, length: 464 Payload contents: SA Next payload: KE, reserved: 0x0, length: 48 last proposal: 0x0, reserved: 0x0, length: 44 Proposal: 1, Protocol id: IKE, SPI size: 0, #trans: 4 last transform: 0x3, reserved: 0x0: length: 12 type: 1, reserved: 0x0, id: AES-CBC last transform: 0x3, reserved: 0x0: length: 8 type: 2, Cbtme-Spoke1#reserved: 0x0, id: SHA256 last transform: 0x3, reserved: 0x0: length: 8 type: 3, reserved: 0x0, id: SHA256 last transform: 0x0, reserved: 0x0: length: 8 type: 4, reserved: 0x0, id: DH_GROUP_2048_MODP/Group 14 KE Next payload: N, reserved: 0x0, length: 264 DH group: 14, Reserved: 0x0 N Next payload: VID, reserved: 0x0, length: 24 VID Next payload: VID, reserved: 0x0, length: 23 VID Next payload: NOTIFY, reserved: 0x0, length: 21 NOTIFY(NAT_DETECTION_SOURCE_IP) Next payload: NOTIFY, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_SOURCE_IP NOTIFY(NAT_DETECTION_DESTINATION_IP) Next payload: NONE, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_DESTINATION_IP *Jan 20 23:21:02.175: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_INSERT_SA *Jan 20 23:21:02.179: IKEv2:(SA ID = 1) Cbtme-Spoke1#:SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_WAIT_INIT Event: EV_NO_EVENT *Jan 20 23:21:02.395: IKEv2:Got a packet from dispatcher *Jan 20 23:21:02.403: IKEv2:Processing an item off the pak queue *Jan 20 23:21:02.407: IKEv2:(SA ID = 1):Next payload: SA, version: 2.0 Exchange type: IKE_SA_INIT, flags: RESPONDER MSG-RESPONSE Message id: 0, length: 517 Payload contents: SA Next payload: KE, reserved: 0x0, length: 48 last proposal: 0x0, reserved: 0x0, length: 44 Proposal: 1, Protocol id: IKE, SPI size: 0, #trans: 4 last transform: 0x3, reserved: 0x0: length: 12 type: 1, reserved: 0x0, id: AES-CBC last transform: 0x3, reserved: 0x0: length: 8 type: 2, reserved: 0x0, id: SHA256 last transform: 0x3, reserved: 0x0: length: 8 type: 3, reserved: 0x0, id: SHA256 last transform: 0x0, reserved: 0x0: length: 8 type: 4, reserved: 0x0, id: DH_GROUP_2048_MODP/Group 14 KE Next payload: N, reser Cbtme-Spoke1#ved: 0x0, length: 264 DH group: 14, Reserved: 0x0 N Next payload: VID, reserved: 0x0, length: 24 *Jan 20 23:21:02.431: IKEv2:Parse Vendor Specific Payload: CISCO-DELETE-REASON VID Next payload: VID, reserved: 0x0, length: 23 *Jan 20 23:21:02.435: IKEv2:Parse Vendor Specific Payload: (CUSTOM) VID Next payload: NOTIFY, reserved: 0x0, length: 21 *Jan 20 23:21:02.439: IKEv2:Parse Notify Payload: NAT_DETECTION_SOURCE_IP NOTIFY(NAT_DETECTION_SOURCE_IP) Next payload: NOTIFY, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_SOURCE_IP *Jan 20 23:21:02.443: IKEv2:Parse Notify Payload: NAT_DETECTION_DESTINATION_IP NOTIFY(NAT_DETECTION_DESTINATION_IP) Next payload: CERTREQ, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_DESTINATION_IP CERTREQ Next payload: NOTIFY, reserved: 0x0, length: 45 Cert encoding Hash and URL of PKIX *Jan 20 23:21:02.451: IKEv2:Parse Notify Payload: HTTP_CERT_LOOKUP_SUPPORTED NOTIFY(HTTP_CERT_LOOKUP_SUPPORTED) Next payload: NONE, reserved: 0x0, length: 8 Security protocol id: IKE, spi size: 0, type: HTTP_CERT_LOOKUP_SUPPORTED *Jan 20 23:21:02.459: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_WAIT_INIT Event: EV_RECV_INIT *Jan 20 23:21:02.459: IKEv2:(SA ID = 1):Processing IKE_SA_INIT message *Jan 20 23:21:02.459: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK4_NOTIFY *Jan 20 23:21:02.459: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_VERIFY_MSG *Jan 20 23:21:02.463: IKEv2:(SA ID = 1):SM Trace Cbtme-Spoke1#-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_PROC_MSG *Jan 20 23:21:02.467: IKEv2:(SA ID = 1):Matching certificate found *Jan 20 23:21:02.467: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_DETECT_NAT *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):Process NAT discovery notify *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):Processing nat detect src notify *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):Remote address matched *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):Processing nat detect dst notify *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):Local address matched *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):No NAT found *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK_NAT_T *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=1 Cbtme-Spoke1#2295B59EA4B343E (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK_CONFIG_MODE *Jan 20 23:21:02.471: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_GEN_DH_SECRET *Jan 20 23:21:02.683: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_NO_EVENT *Jan 20 23:21:02.683: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_OK_RECD_DH_SECRET_RESP *Jan 20 23:21:02.683: IKEv2:(SA ID = 1):Action: Action_Null *Jan 20 23:21:02.683: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_GEN_SKEYID *Jan 20 23:21:02.683: IKEv2:(SA ID = 1):Generate skeyid *Jan 20 23:21:02.687: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurS Cbtme-Spoke1#tate: INIT_DONE Event: EV_DONE *Jan 20 23:21:02.687: IKEv2:(SA ID = 1):Cisco DeleteReason Notify is enabled *Jan 20 23:21:02.687: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_CHK4_ROLE *Jan 20 23:21:02.687: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_GET_CONFIG_MODE *Jan 20 23:21:02.687: IKEv2:Sending config data to toolkit *Jan 20 23:21:02.691: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_CHK_EAP *Jan 20 23:21:02.691: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_GEN_AUTH *Jan 20 23:21:02.691: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_CHK_AUTH_TYPE *Ja Cbtme-Spoke1#n 20 23:21:02.691: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_SIGN *Jan 20 23:21:03.051: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_NO_EVENT *Jan 20 23:21:03.051: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_OK_RECD_SIG *Jan 20 23:21:03.051: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_OK_AUTH_GEN *Jan 20 23:21:03.051: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_SEND_AUTH *Jan 20 23:21:03.051: IKEv2:Construct Vendor Specific Payload: CISCO-GRANITE *Jan 20 23:21:03.055: IKEv2:(SA ID = 1):Failed to construct certificate request *Jan 20 23:21:03.055: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000001 CurState: AUTH_DONE Event: EV_FAIL *Jan 20 23:21:03.055: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000001 CurState: EXIT Event: EV_ABORT *Jan 20 23:21:03.055: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343 Cbtme-Spoke1#E (I) MsgID = 00000001 CurState: EXIT Event: EV_CHK_PENDING_ABORT *Jan 20 23:21:03.055: IKEv2:Negotiating SA request deleted *Jan 20 23:21:03.055: IKEv2:Decrement count for outgoing negotiating *Jan 20 23:21:03.055: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=300843FC4CFDFD0F R_SPI=12295B59EA4B343E (I) MsgID = 00000001 CurState: EXIT Event: EV_UPDATE_CAC_STATS Cbtme-Spoke1# *Jan 20 23:21:32.127: IKEv2:Adding Proposal aes-cbc-256-proposal1 to toolkit policy *Jan 20 23:21:32.139: IKEv2:(1): Choosing IKE profile profile *Jan 20 23:21:32.143: IKEv2:New ikev2 sa request admitted *Jan 20 23:21:32.143: IKEv2:Incrementing outgoing negotiating sa count by one *Jan 20 23:21:32.151: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: IDLE Event: EV_INIT_SA *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GET_IKE_POLICY *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_SET_POLICY *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):Setting configured policies *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV Cbtme-Spoke1#_CHK_AUTH4PKI *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_PKI_SESH_OPEN *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):Opening a PKI session *Jan 20 23:21:32.155: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GEN_DH_KEY *Jan 20 23:21:32.159: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_NO_EVENT *Jan 20 23:21:32.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_OK_RECD_DH_PUBKEY_RESP *Jan 20 23:21:32.163: IKEv2:(SA ID = 1):Action: Action_Null *Jan 20 23:21:32.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_GET_CONFIG_MODE *Jan 20 23:21:32. Cbtme-Spoke1#163: IKEv2:No config data to send to toolkit: *Jan 20 23:21:32.163: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_BLD_MSG *Jan 20 23:21:32.163: IKEv2:Construct Vendor Specific Payload: DELETE-REASON *Jan 20 23:21:32.163: IKEv2:Construct Vendor Specific Payload: (CUSTOM) *Jan 20 23:21:32.163: IKEv2:Construct Notify Payload: NAT_DETECTION_SOURCE_IP *Jan 20 23:21:32.167: IKEv2:Construct Notify Payload: NAT_DETECTION_DESTINATION_IP *Jan 20 23:21:32.167: IKEv2:(SA ID = 1):Next payload: SA, version: 2.0 Exchange type: IKE_SA_INIT, flags: INITIATOR Message id: 0, length: 464 Payload contents: SA Next payload: KE, reserved: 0x0, length: 48 last proposal: 0x0, reserved: 0x0, length: 44 Proposal: 1, Protocol id: IKE, SPI size: 0, #trans: 4 last transform: 0x3, reserved: 0x0: length: 12 type: 1, reserved: 0x0, id: AES-CBC last transform: 0x3, reserved: 0x0: length: 8 type: 2, Cbtme-Spoke1#reserved: 0x0, id: SHA256 last transform: 0x3, reserved: 0x0: length: 8 type: 3, reserved: 0x0, id: SHA256 last transform: 0x0, reserved: 0x0: length: 8 type: 4, reserved: 0x0, id: DH_GROUP_2048_MODP/Group 14 KE Next payload: N, reserved: 0x0, length: 264 DH group: 14, Reserved: 0x0 N Next payload: VID, reserved: 0x0, length: 24 VID Next payload: VID, reserved: 0x0, length: 23 VID Next payload: NOTIFY, reserved: 0x0, length: 21 NOTIFY(NAT_DETECTION_SOURCE_IP) Next payload: NOTIFY, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_SOURCE_IP NOTIFY(NAT_DETECTION_DESTINATION_IP) Next payload: NONE, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_DESTINATION_IP *Jan 20 23:21:32.171: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_BLD_INIT Event: EV_INSERT_SA *Jan 20 23:21:32.171: IKEv2:(SA ID = 1) Cbtme-Spoke1#:SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=0000000000000000 (I) MsgID = 00000000 CurState: I_WAIT_INIT Event: EV_NO_EVENT *Jan 20 23:21:32.407: IKEv2:Got a packet from dispatcher *Jan 20 23:21:32.415: IKEv2:Processing an item off the pak queue *Jan 20 23:21:32.419: IKEv2:(SA ID = 1):Next payload: SA, version: 2.0 Exchange type: IKE_SA_INIT, flags: RESPONDER MSG-RESPONSE Message id: 0, length: 517 Payload contents: SA Next payload: KE, reserved: 0x0, length: 48 last proposal: 0x0, reserved: 0x0, length: 44 Proposal: 1, Protocol id: IKE, SPI size: 0, #trans: 4 last transform: 0x3, reserved: 0x0: length: 12 type: 1, reserved: 0x0, id: AES-CBC last transform: 0x3, reserved: 0x0: length: 8 type: 2, reserved: 0x0, id: SHA256 last transform: 0x3, reserved: 0x0: length: 8 type: 3, reserved: 0x0, id: SHA256 last transform: 0x0, reserved: 0x0: length: 8 type: 4, reserved: 0x0, id: DH_GROUP_2048_MODP/Group 14 KE Next payload: N, reser Cbtme-Spoke1#ved: 0x0, length: 264 DH group: 14, Reserved: 0x0 N Next payload: VID, reserved: 0x0, length: 24 *Jan 20 23:21:32.435: IKEv2:Parse Vendor Specific Payload: CISCO-DELETE-REASON VID Next payload: VID, reserved: 0x0, length: 23 *Jan 20 23:21:32.435: IKEv2:Parse Vendor Specific Payload: (CUSTOM) VID Next payload: NOTIFY, reserved: 0x0, length: 21 *Jan 20 23:21:32.435: IKEv2:Parse Notify Payload: NAT_DETECTION_SOURCE_IP NOTIFY(NAT_DETECTION_SOURCE_IP) Next payload: NOTIFY, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_SOURCE_IP *Jan 20 23:21:32.435: IKEv2:Parse Notify Payload: NAT_DETECTION_DESTINATION_IP NOTIFY(NAT_DETECTION_DESTINATION_IP) Next payload: CERTREQ, reserved: 0x0, length: 28 Security protocol id: IKE, spi size: 0, type: NAT_DETECTION_DESTINATION_IP CERTREQ Next payload: NOTIFY, reserved: 0x0, length: 45 Cert encoding Hash and URL of PKIX *Jan 20 23:21:32.435: IKEv2:Parse Notify Payload: HTTP Cbtme-Spoke1#_CERT_LOOKUP_SUPPORTED NOTIFY(HTTP_CERT_LOOKUP_SUPPORTED) Next payload: NONE, reserved: 0x0, length: 8 Security protocol id: IKE, spi size: 0, type: HTTP_CERT_LOOKUP_SUPPORTED *Jan 20 23:21:32.439: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_WAIT_INIT Event: EV_RECV_INIT *Jan 20 23:21:32.439: IKEv2:(SA ID = 1):Processing IKE_SA_INIT message *Jan 20 23:21:32.439: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK4_NOTIFY *Jan 20 23:21:32.439: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_VERIFY_MSG *Jan 20 23:21:32.439: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_PROC_MSG *Jan 20 23:21:32.443: IKEv2:(SA ID = 1):Matching certificate found *Jan 20 23:2 Cbtme-Spoke1#1:32.443: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_DETECT_NAT *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):Process NAT discovery notify *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):Processing nat detect src notify *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):Remote address matched *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):Processing nat detect dst notify *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):Local address matched *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):No NAT found *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK_NAT_T *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_PROC_INIT Event: EV_CHK_CONFIG_MODE *Jan 20 23:21:32.447: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID Cbtme-Spoke1# = 00000000 CurState: INIT_DONE Event: EV_GEN_DH_SECRET *Jan 20 23:21:32.735: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_NO_EVENT *Jan 20 23:21:32.739: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_OK_RECD_DH_SECRET_RESP *Jan 20 23:21:32.739: IKEv2:(SA ID = 1):Action: Action_Null *Jan 20 23:21:32.739: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_GEN_SKEYID *Jan 20 23:21:32.739: IKEv2:(SA ID = 1):Generate skeyid *Jan 20 23:21:32.743: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_DONE *Jan 20 23:21:32.743: IKEv2:(SA ID = 1):Cisco DeleteReason Notify is enabled *Jan 20 23:21:32.743: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=33 Cbtme-Spoke1#7C860875B17FCF (I) MsgID = 00000000 CurState: INIT_DONE Event: EV_CHK4_ROLE *Jan 20 23:21:32.743: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_GET_CONFIG_MODE *Jan 20 23:21:32.743: IKEv2:Sending config data to toolkit *Jan 20 23:21:32.743: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_CHK_EAP *Jan 20 23:21:32.747: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_GEN_AUTH *Jan 20 23:21:32.747: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_CHK_AUTH_TYPE *Jan 20 23:21:32.747: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_SIGN *Jan 20 23:21:33.099: IKEv2:(SA ID = 1): Cbtme-Spoke1#SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_NO_EVENT *Jan 20 23:21:33.099: IKEv2:(SA ID = 1):SM Trace-> SA: I_SPI=095910EDAB7A4361 R_SPI=337C860875B17FCF (I) MsgID = 00000000 CurState: I_BLD_AUTH Event: EV_OK_RECD_SIG *Jan 20 23: