2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13475: 011400: Mar 14 16:15:58.243 PCTime: IPSEC(sa_request): , 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13476: (key eng. msg.) OUTBOUND local= 10.0.0.10, remote= 10.0.0.2, 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13477: local_proxy= 10.0.0.10/255.255.255.255/0/0 (type=1), 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13478: remote_proxy= 10.0.0.2/255.255.255.255/0/0 (type=1), 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13479: protocol= ESP, transform= NONE (Tunnel), 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13480: lifedur= 3600s and 4608000kb, 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13481: spi= 0x88F257C6(2297583558), conn_id= 0, keysize= 128, flags= 0x0 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13482: 011401: Mar 14 16:15:58.243 PCTime: ISAKMP: local port 500, remote port 500 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13483: 011402: Mar 14 16:15:58.243 PCTime: ISAKMP: set new node 0 to QM_IDLE 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13484: 011403: Mar 14 16:15:58.243 PCTime: ISAKMP: Find a dup sa in the avl tree during calling isadb_insert sa = 82FBB890 2007-03-14 16:15:53 Local7.Notice 10.0.0.10 13485: 011404: Mar 14 16:15:58.243 PCTime: %CRYPTO-5-IKMP_AG_MODE_DISABLED: Unable to initiate or respond to Aggressive Mode while disabled 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13486: 011405: Mar 14 16:15:58.243 PCTime: ISAKMP:(0):Can not start Aggressive mode, trying Main mode. 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13487: 011406: Mar 14 16:15:58.243 PCTime: ISAKMP:(0):found peer pre-shared key matching 10.0.0.2 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13488: 011407: Mar 14 16:15:58.243 PCTime: ISAKMP:(0): constructed NAT-T vendor-07 ID 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13489: 011408: Mar 14 16:15:58.243 PCTime: ISAKMP:(0): constructed NAT-T vendor-03 ID 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13490: 011409: Mar 14 16:15:58.243 PCTime: ISAKMP:(0): constructed NAT-T vendor-02 ID 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13491: 011410: Mar 14 16:15:58.243 PCTime: ISAKMP:(0):Input = IKE_MESG_FROM_IPSEC, IKE_SA_REQ_MM 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13492: 011411: Mar 14 16:15:58.243 PCTime: ISAKMP:(0):Old State = IKE_READY New State = IKE_I_MM1 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13493: 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13494: 011412: Mar 14 16:15:58.247 PCTime: ISAKMP:(0): beginning Main Mode exchange 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13495: 011413: Mar 14 16:15:58.247 PCTime: ISAKMP:(0): sending packet to 10.0.0.2 my_port 500 peer_port 500 (I) MM_NO_STATE 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13496: 011414: Mar 14 16:15:58.263 PCTime: ISAKMP (0:0): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_NO_STATE 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13497: 011415: Mar 14 16:15:58.263 PCTime: ISAKMP:(0):Input = IKE_MESG_FROM_PEER, IKE_MM_EXCH 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13498: 011416: Mar 14 16:15:58.263 PCTime: ISAKMP:(0):Old State = IKE_I_MM1 New State = IKE_I_MM2 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13499: 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13500: 011417: Mar 14 16:15:58.263 PCTime: ISAKMP:(0): processing SA payload. message ID = 0 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13501: 011418: Mar 14 16:15:58.263 PCTime: ISAKMP:(0): processing vendor id payload 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13502: 011419: Mar 14 16:15:58.267 PCTime: ISAKMP:(0): vendor ID seems Unity/DPD but major 69 mismatch 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13503: 011420: Mar 14 16:15:58.267 PCTime: ISAKMP:(0):found peer pre-shared key matching 10.0.0.2 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13504: 011421: Mar 14 16:15:58.267 PCTime: ISAKMP:(0): local preshared key found 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13505: 011422: Mar 14 16:15:58.267 PCTime: ISAKMP:(0):Checking ISAKMP transform 1 against priority 1 policy 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13506: 011423: Mar 14 16:15:58.267 PCTime: ISAKMP: encryption AES-CBC 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13507: 011424: Mar 14 16:15:58.267 PCTime: ISAKMP: hash SHA 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13508: 011425: Mar 14 16:15:58.267 PCTime: ISAKMP: auth pre-share 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13509: 011426: Mar 14 16:15:58.267 PCTime: ISAKMP: default group 2 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13510: 011427: Mar 14 16:15:58.267 PCTime: ISAKMP: life type in seconds 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13511: 011428: Mar 14 16:15:58.267 PCTime: ISAKMP: life duration (VPI) of 0x0 0x1 0x51 0x80 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13512: 011429: Mar 14 16:15:58.267 PCTime: ISAKMP: keylength of 128 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13513: 011430: Mar 14 16:15:58.267 PCTime: ISAKMP:(0):atts are acceptable. Next payload is 0 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13514: 011431: Mar 14 16:15:58.267 PCTime: ISAKMP:(0): processing vendor id payload 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13515: 011432: Mar 14 16:15:58.267 PCTime: ISAKMP:(0): vendor ID seems Unity/DPD but major 69 mismatch 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13516: 011433: Mar 14 16:15:58.267 PCTime: ISAKMP:(0):Input = IKE_MESG_INTERNAL, IKE_PROCESS_MAIN_MODE 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13517: 011434: Mar 14 16:15:58.267 PCTime: ISAKMP:(0):Old State = IKE_I_MM2 New State = IKE_I_MM2 2007-03-14 16:15:53 Local7.Debug 10.0.0.10 13518: 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13519: 011435: Mar 14 16:15:58.271 PCTime: ISAKMP:(0): sending packet to 10.0.0.2 my_port 500 peer_port 500 (I) MM_SA_SETUP 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13520: 011436: Mar 14 16:15:58.271 PCTime: ISAKMP:(0):Input = IKE_MESG_INTERNAL, IKE_PROCESS_COMPLETE 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13521: 011437: Mar 14 16:15:58.271 PCTime: ISAKMP:(0):Old State = IKE_I_MM2 New State = IKE_I_MM3 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13522: 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13523: 011438: Mar 14 16:15:58.487 PCTime: ISAKMP (0:0): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_SA_SETUP 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13524: 011439: Mar 14 16:15:58.487 PCTime: ISAKMP:(0):Input = IKE_MESG_FROM_PEER, IKE_MM_EXCH 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13525: 011440: Mar 14 16:15:58.487 PCTime: ISAKMP:(0):Old State = IKE_I_MM3 New State = IKE_I_MM4 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13526: 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13527: 011441: Mar 14 16:15:58.487 PCTime: ISAKMP:(0): processing KE payload. message ID = 0 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13528: 011442: Mar 14 16:15:58.515 PCTime: ISAKMP:(0): processing NONCE payload. message ID = 0 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13529: 011443: Mar 14 16:15:58.519 PCTime: ISAKMP:(0):found peer pre-shared key matching 10.0.0.2 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13530: 011444: Mar 14 16:15:58.519 PCTime: ISAKMP:(1014): processing vendor id payload 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13531: 011445: Mar 14 16:15:58.519 PCTime: ISAKMP:(1014): vendor ID seems Unity/DPD but major 69 mismatch 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13532: 011446: Mar 14 16:15:58.519 PCTime: ISAKMP:received payload type 0 2007-03-14 16:15:54 Local7.Debug 10.0.0.10 13533: 011447: Mar 14 16:15:58.519 PCTime: ISAKMP:(1014):Input = IKE_MESG_INTERNAL, IKE_PROCESS_MAIN_MODE 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13534: 011448: Mar 14 16:15:58.519 PCTime: ISAKMP:(1014):Old State = IKE_I_MM4 New State = IKE_I_MM4 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13535: 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13536: 011449: Mar 14 16:15:58.519 PCTime: ISAKMP (0:1014): incrementing error counter on sa, attempt 1 of 5: reset_retransmission 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13537: 011450: Mar 14 16:15:58.519 PCTime: ISAKMP:(1014):Input = IKE_MESG_INTERNAL, IKE_PROCESS_ERROR 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13538: 011451: Mar 14 16:15:58.519 PCTime: ISAKMP:(1014):Old State = IKE_I_MM4 New State = IKE_I_MM3 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13539: 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13540: 011452: Mar 14 16:15:59.519 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP... 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13541: 011453: Mar 14 16:15:59.519 PCTime: ISAKMP (0:1014): incrementing error counter on sa, attempt 2 of 5: retransmit phase 1 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13542: 011454: Mar 14 16:15:59.519 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13543: 011455: Mar 14 16:15:59.519 PCTime: ISAKMP:(1014): sending packet to 10.0.0.2 my_port 500 peer_port 500 (I) MM_SA_SETUP 2007-03-14 16:15:55 Local7.Debug 10.0.0.10 13544: 011456: Mar 14 16:15:59.527 PCTime: ISAKMP (0:1014): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_SA_SETUP 2007-03-14 16:15:55 Local7.Info 10.0.0.10 13545: 011457: Mar 14 16:15:59.527 PCTime: %CRYPTO-6-IKMP_NOT_ENCRYPTED: IKE packet from 10.0.0.2 was not encrypted and it should've been. 2007-03-14 16:15:56 Local7.Debug 10.0.0.10 13546: 011458: Mar 14 16:15:59.527 PCTime: ISAKMP (0:1014): incrementing error counter on sa, attempt 3 of 5: reset_retransmission 2007-03-14 16:15:56 Local7.Debug 10.0.0.10 13547: 011459: Mar 14 16:15:59.607 PCTime: ISAKMP:(1012):purging node -1207387121 2007-03-14 16:15:56 Local7.Debug 10.0.0.10 13548: 011460: Mar 14 16:16:00.527 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP... 2007-03-14 16:15:56 Local7.Debug 10.0.0.10 13549: 011461: Mar 14 16:16:00.527 PCTime: ISAKMP (0:1014): incrementing error counter on sa, attempt 4 of 5: retransmit phase 1 2007-03-14 16:15:56 Local7.Debug 10.0.0.10 13550: 011462: Mar 14 16:16:00.527 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP 2007-03-14 16:15:56 Local7.Debug 10.0.0.10 13551: 011463: Mar 14 16:16:00.527 PCTime: ISAKMP:(1014): sending packet to 10.0.0.2 my_port 500 peer_port 500 (I) MM_SA_SETUP 2007-03-14 16:15:57 Local7.Debug 10.0.0.10 13552: 011464: Mar 14 16:16:00.531 PCTime: ISAKMP (0:1014): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_SA_SETUP 2007-03-14 16:15:57 Local7.Debug 10.0.0.10 13553: 011465: Mar 14 16:16:00.531 PCTime: ISAKMP:(1014): phase 1 packet is a duplicate of a previous packet. 2007-03-14 16:15:57 Local7.Debug 10.0.0.10 13554: 011466: Mar 14 16:16:00.531 PCTime: ISAKMP:(1014): retransmission skipped for phase 1 (time since last transmission 4) 2007-03-14 16:16:00 Local7.Debug 10.0.0.10 13555: 011467: Mar 14 16:16:04.171 PCTime: ISAKMP (0:1014): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_SA_SETUP 2007-03-14 16:16:00 Local7.Debug 10.0.0.10 13556: 011468: Mar 14 16:16:04.171 PCTime: ISAKMP:(1014): phase 1 packet is a duplicate of a previous packet. 2007-03-14 16:16:00 Local7.Debug 10.0.0.10 13557: 011469: Mar 14 16:16:04.171 PCTime: ISAKMP:(1014): retransmitting due to retransmit phase 1 2007-03-14 16:16:00 Local7.Debug 10.0.0.10 13558: 011470: Mar 14 16:16:04.671 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP... 2007-03-14 16:16:00 Local7.Debug 10.0.0.10 13559: 011471: Mar 14 16:16:04.671 PCTime: ISAKMP (0:1014): incrementing error counter on sa, attempt 5 of 5: retransmit phase 1 2007-03-14 16:16:00 Local7.Debug 10.0.0.10 13560: 011472: Mar 14 16:16:04.671 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP 2007-03-14 16:16:01 Local7.Debug 10.0.0.10 13561: 011473: Mar 14 16:16:04.671 PCTime: ISAKMP:(1014): sending packet to 10.0.0.2 my_port 500 peer_port 500 (I) MM_SA_SETUP 2007-03-14 16:16:01 Local7.Debug 10.0.0.10 13562: 011474: Mar 14 16:16:04.675 PCTime: ISAKMP (0:1014): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_SA_SETUP 2007-03-14 16:16:01 Local7.Debug 10.0.0.10 13563: 011475: Mar 14 16:16:04.679 PCTime: ISAKMP:(1014): phase 1 packet is a duplicate of a previous packet. 2007-03-14 16:16:01 Local7.Debug 10.0.0.10 13564: 011476: Mar 14 16:16:04.679 PCTime: ISAKMP:(1014): retransmission skipped for phase 1 (time since last transmission 8) 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13565: 011477: Mar 14 16:16:09.607 PCTime: ISAKMP:(1012):purging SA., sa=82A6DD08, delme=82A6DD08 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13566: 011478: Mar 14 16:16:09.855 PCTime: ISAKMP (0:1014): received packet from 10.0.0.2 dport 500 sport 500 Global (I) MM_SA_SETUP 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13567: 011479: Mar 14 16:16:09.855 PCTime: ISAKMP:(1014): phase 1 packet is a duplicate of a previous packet. 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13568: 011480: Mar 14 16:16:09.855 PCTime: ISAKMP:(1014): retransmitting due to retransmit phase 1 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13569: 011481: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014): retransmitting phase 1 MM_SA_SETUP... 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13570: 011482: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014):peer does not do paranoid keepalives. 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13571: 2007-03-14 16:16:06 Local7.Debug 10.0.0.10 13572: 011483: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014):deleting SA reason "Death by retransmission P1" state (I) MM_SA_SETUP (peer 10.0.0.2) 2007-03-14 16:16:07 Local7.Debug 10.0.0.10 13573: 011484: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014):deleting SA reason "Death by retransmission P1" state (I) MM_SA_SETUP (peer 10.0.0.2) 2007-03-14 16:16:07 Local7.Debug 10.0.0.10 13574: 011485: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014):deleting node 577463392 error FALSE reason "IKE deleted" 2007-03-14 16:16:07 Local7.Debug 10.0.0.10 13575: 011486: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014):Input = IKE_MESG_INTERNAL, IKE_PHASE1_DEL 2007-03-14 16:16:07 Local7.Debug 10.0.0.10 13576: 011487: Mar 14 16:16:10.355 PCTime: ISAKMP:(1014):Old State = IKE_I_MM3 New State = IKE_DEST_SA