Screenos Dailup VPN Xauth Pool Debug

= debug ike detail =

 SSG-1-> get db str SSG-1->
 * 1) 2014-12-12 02:11:59 : IKE<192.168.3.1> setting xauth_check_dead timeout for later. username , ip<10.1.1.20/255.255.255.255>
 * 2) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 579, action 1
 * 3) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 551 bytes from socket.
 * 4) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if  of vsys  ******
 * 5) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 551 bytes. src port 10952
 * 6) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 551, nxp 1[SA], exch 4[AG], flag 00
 * 7) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv : [SA] [KE] [NONCE] [ID] [VID] [VID] [VID] [VID] [VID]
 * 8) 2014-12-12 02:12:06 : [VID] [VID] [VID] [VID] [VID] [VID] [VID]
 * 9) 2014-12-12 02:12:06 : valid id checking, id type:U-FQDN, len:23.
 * 10) 2014-12-12 02:12:06 : IKE<0.0.0.0        >     Validate (523): SA/128 KE/100 NONCE/44 ID/23 VID/12 VID/12 VID/20 VID/20 VID/20
 * 11) 2014-12-12 02:12:06 : IKE<192.168.3.1> Receive Id in AG mode, id-type=3, id=aman1@wipro.com, idlen = 15
 * 12) 2014-12-12 02:12:06 : IKE<192.168.2.1>   peer  has static ip.
 * 13) 2014-12-12 02:12:06 :   locate peer entry for (3/aman1@wipro.com), by identity.
 * 14) 2014-12-12 02:12:06 : found single user entry(3/aman1@wipro.com).
 * 15) 2014-12-12 02:12:06 : IKE<192.168.3.1> Found peer entry (Dialup-VPNGW) from 192.168.3.1.
 * 16) 2014-12-12 02:12:06 : responder create sa: 192.168.3.1->192.168.1.1
 * 17) 2014-12-12 02:12:06 : init p1sa, pidt = 0x0
 * 18) 2014-12-12 02:12:06 : change peer identity for p1 sa, pidt = 0x0
 * 19) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   peer_identity_create_with_uid: uid<0>
 * 20) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   create peer identity 0x2a7a2f8
 * 21) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   peer_identity_add_to_peer: num entry before add <1>
 * 22) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   peer_identity_add_to_peer: num entry after add <2>
 * 23) 2014-12-12 02:12:06 : peer identity 2a7a2f8 created.
 * 24) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   EDIPI disabled
 * 25) 2014-12-12 02:12:06 : IKE<192.168.3.1> getProfileFromP1Proposal->
 * 26) 2014-12-12 02:12:06 : IKE<192.168.3.1> find profile[0]=<00000001 00000001 00000001 00000001> for p1 proposal (id 0), xauth(1)
 * 27) 2014-12-12 02:12:06 : IKE<192.168.3.1> responder create sa: 192.168.3.1->192.168.1.1
 * 28) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 1: Responder starts AGGRESSIVE mode negotiations.
 * 29) 2014-12-12 02:12:06 : IKE<192.168.3.1> AG in state OAK_AG_NOSTATE.
 * 30) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 31) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 32) 2014-12-12 02:12:06 : da 8e 93 78 80 01 00 00
 * 33) 2014-12-12 02:12:06 : IKE<192.168.3.1> receive unknown vendor ID payload
 * 34) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 35) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 36) 2014-12-12 02:12:06 : 09 00 26 89 df d6 b7 12
 * 37) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv XAUTH v6.0 vid
 * 38) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 39) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 40) 2014-12-12 02:12:06 : 7d 94 19 a6 53 10 ca 6f  2c 17 9d 92 15 52 9d 56
 * 41) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv non-NAT-Traversal VID payload.
 * 42) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 43) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 44) 2014-12-12 02:12:06 : 90 cb 80 91 3e bb 69 6e  08 63 81 b5 ec 42 7b 1f
 * 45) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv NAT-Traversal VID payload (draft-ietf-ipsec-nat-t-ike-02).
 * 46) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 47) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 48) 2014-12-12 02:12:06 : 44 85 15 2d 18 b6 bb cd  0b e8 a8 46 95 79 dd cc
 * 49) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv NAT-Traversal VID payload (draft-ietf-ipsec-nat-t-ike-00).
 * 50) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 51) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 52) 2014-12-12 02:12:06 : 4a 13 1c 81 07 03 58 45  5c 57 28 f2 0e 95 45 2f
 * 53) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv non-NAT-Traversal VID payload.
 * 54) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 55) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 56) 2014-12-12 02:12:06 : af ca d7 13 68 a1 f1 c9  6b 86 96 fc 77 57 01 00
 * 57) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 58) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 59) 2014-12-12 02:12:06 : 97 87 98 c6 28 e5 82 a8  3b 2a 97 bf 0d 6e 60 dd
 * 60) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv non-NAT-Traversal VID payload.
 * 61) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 62) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 63) 2014-12-12 02:12:06 : cb e7 94 44 a0 87 0d e4  22 4a 2c 15 1f bf e0 99
 * 64) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv non-NAT-Traversal VID payload.
 * 65) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 66) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 67) 2014-12-12 02:12:06 : c6 1b ac a1 f1 a6 0c c1  08 00 00 00 00 00 00 00
 * 68) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv non-NAT-Traversal VID payload.
 * 69) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 70) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 71) 2014-12-12 02:12:06 : 40 48 b7 d5 6e bc e8 85  25 e7 de 7f 00 d6 c2 d3
 * 72) 2014-12-12 02:12:06 : c0 00 00 00
 * 73) 2014-12-12 02:12:06 : IKE<192.168.3.1> receive unknown vendor ID payload
 * 74) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [VID]:
 * 75) 2014-12-12 02:12:06 : IKE<192.168.3.1    >   Vendor ID:
 * 76) 2014-12-12 02:12:06 : 12 f5 f2 8c 45 71 68 a9  70 2d 9f e2 74 cc 01 00
 * 77) 2014-12-12 02:12:06 : IKE<192.168.3.1> rcv non-NAT-Traversal VID payload.
 * 78) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [SA]:
 * 79) 2014-12-12 02:12:06 : IKE<192.168.3.1> Proposal received: xauthflag 0
 * 80) 2014-12-12 02:12:06 : IKE<192.168.3.1> P1 attributes not supported.
 * 81) 2014-12-12 02:12:06 : IKE<192.168.3.1> [0] expect: xauthflag 3
 * 82) 2014-12-12 02:12:06 : IKE<192.168.3.1> auth(1), encr(1), hash(1), group(1)
 * 83) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth attribute: responder
 * 84) 2014-12-12 02:12:06 : IKE<192.168.3.1> Proposal received: xauthflag 1
 * 85) 2014-12-12 02:12:06 : IKE<192.168.3.1> auth(1), encr(1), hash(1), group(1)
 * 86) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth attribute: initiator
 * 87) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 1 proposal [0] selected.
 * 88) 2014-12-12 02:12:06 : IKE<192.168.3.1> SA Life Type = seconds
 * 89) 2014-12-12 02:12:06 : IKE<192.168.3.1> SA lifetime (TLV) = 86400
 * 90) 2014-12-12 02:12:06 : IKE<192.168.3.1> DH_BG_consume OK. p1 resp
 * 91) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [KE]:
 * 92) 2014-12-12 02:12:06 : IKE<192.168.3.1> processing ISA_KE in phase 1.
 * 93) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase1: his_DH_pub_len is 96
 * 94) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [NONCE]:
 * 95) 2014-12-12 02:12:06 : IKE<192.168.3.1> processing NONCE in phase 1.
 * 96) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [ID]:
 * 97) 2014-12-12 02:12:06 : IKE<192.168.3.1> ID received: type=ID_USER_FQDN, USER FQDN = aman1@wipro.com, port=0, protocol=0
 * 98) 2014-12-12 02:12:06 : IKE<192.168.3.1> process_id need to update peer entry, cur .
 * 99) 2014-12-12 02:12:06 : IKE<192.168.2.1>   peer  has static ip.
 * 100) 2014-12-12 02:12:06 :   locate peer entry for (3/aman1@wipro.com), by identity.
 * 101) 2014-12-12 02:12:06 : found single user entry(3/aman1@wipro.com).
 * 102) 2014-12-12 02:12:06 : IKE<192.168.3.1> Dynamic peer IP addr, search peer by identity.
 * 103) 2014-12-12 02:12:06 : IKE<192.168.3.1> peer gateway entry has no peer id configured
 * 104) 2014-12-12 02:12:06 : IKE<192.168.3.1> ID processed. return 0. sa->p1_state = 0.
 * 105) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 1 AG Responder constructing 2nd message.
 * 106) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct ISAKMP header.
 * 107) 2014-12-12 02:12:06 : IKE<192.168.3.1> Msg header built (next payload #1)
 * 108) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [SA] for ISAKMP
 * 109) 2014-12-12 02:12:06 : IKE<192.168.3.1> auth(1), encr(1), hash(1), group(1)
 * 110) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth attribute: disabled
 * 111) 2014-12-12 02:12:06 : IKE<192.168.3.1> lifetime/lifesize (86400/0)
 * 112) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   set_phase1_transform, dh_group(1).
 * 113) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct NetScreen [VID]
 * 114) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct custom [VID]
 * 115) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct custom [VID]
 * 116) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct custom [VID]
 * 117) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [KE] for ISAKMP
 * 118) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [NONCE]
 * 119) 2014-12-12 02:12:06 : IKE<192.168.3.1> gen_skeyid
 * 120) 2014-12-12 02:12:06 : IKE<192.168.3.1> gen_skeyid: returning 0
 * 121) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [ID] for ISAKMP
 * 122) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [HASH]
 * 123) 2014-12-12 02:12:06 : IKE<192.168.3.1> ID, len=8, type=1, pro=17, port=500,
 * 124) 2014-12-12 02:12:06 : IKE<192.168.3.1> addr=192.168.1.1
 * 125) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct NAT-T [VID]: draft 2
 * 126) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder psk ag mode: natt vid constructed.
 * 127) 2014-12-12 02:12:06 : IKE<192.168.3.1> responder (psk) constructing remote NAT-D
 * 128) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [NATD]
 * 129) 2014-12-12 02:12:06 : IKE<192.168.3.1> responder (psk) constructing local NAT-D
 * 130) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [NATD]
 * 131) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Xmit : [SA] [VID] [VID] [VID] [VID] [KE] [NONCE] [ID] [HASH]
 * 132) 2014-12-12 02:12:06 : [VID] [NATD] [NATD]
 * 133) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder sending IPv4 IP 192.168.3.1/port 10952
 * 134) 2014-12-12 02:12:06 : IKE<192.168.3.1> Send Phase 1 packet (len=400)
 * 135) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<5/91180f>
 * 136) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 144, action 0
 * 137) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 116 bytes from socket.
 * 138) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if <ethernet0/3> of vsys <Root> ******
 * 139) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 116 bytes. src port 10952
 * 140) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 116, nxp 8[HASH], exch 4[AG], flag 01  E
 * 141) 2014-12-12 02:12:06 : IKE<192.168.3.1> Decrypting payload (length 88)
 * 142) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv*: [HASH] [NATD] [NATD] [NOTIF]
 * 143) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   extract payload (88):
 * 144) 2014-12-12 02:12:06 : IKE<192.168.3.1> AG in state OAK_AG_INIT_EXCH.
 * 145) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [NATD]:
 * 146) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [NATD]:
 * 147) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [HASH]:
 * 148) 2014-12-12 02:12:06 : IKE<192.168.3.1> ID, len=19, type=3, pro=0, port=0,
 * 149) 2014-12-12 02:12:06 : IKE<192.168.3.1>
 * 150) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [NOTIF]:
 * 151) 2014-12-12 02:12:06 : IKE<192.168.3.1> Received notify message for DOI <1> <INITIAL-CONTACT>.
 * 152) 2014-12-12 02:12:06 : IKE<192.168.3.1> Received initial contact notification and removed Phase 2 SAs.
 * 153) 2014-12-12 02:12:06 : clear phase 2 sa of peer Dialup-VPNGW.
 * 154) 2014-12-12 02:12:06 : IKE<192.168.3.1> deactive p2 sa 0 send_delete 0
 * 155) 2014-12-12 02:12:06 : IKE<192.168.3.1> process notify exit with <0>.
 * 156) 2014-12-12 02:12:06 : IKE<192.168.3.1> completing Phase 1
 * 157) 2014-12-12 02:12:06 : IKE<192.168.3.1> sa_pidt = 2a7a2f8
 * 158) 2014-12-12 02:12:06 : IKE<192.168.3.1> found existing peer identity 2a79d90
 * 159) 2014-12-12 02:12:06 : IKE<192.168.3.1> peer_identity_unregister_p1_sa.
 * 160) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   delete peer identity 0x2a7a2f8
 * 161) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   peer_identity_remove_from_peer: num entry before remove <2>
 * 162) 2014-12-12 02:12:06 : IKE<192.168.3.1> peer_idt.c peer_identity_unregister_p1_sa 686: pidt deleted.
 * 163) 2014-12-12 02:12:06 : IKE<192.168.3.1> clear p1sa(0x2a4bee8) xauth because new p1sa (0x2a4ccd4) gets initial-contact
 * 164) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE Xauth: release prefix route, ret=<-2>.
 * 165) 2014-12-12 02:12:06 : IKE<192.168.3.1> phase 1 sa timeout value reduced to <30>.
 * 166) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 1: Completed for ip <192.168.3.1>, user<test-usr>
 * 167) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 1: Completed Aggressive mode negotiation with a -second lifetime.
 * 168) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth is started: server, p1responder, aggr mode.
 * 169) 2014-12-12 02:12:06 : IKE<192.168.3.1> start_xauth
 * 170) 2014-12-12 02:12:06 : IKE<192.168.3.1> start_xauth: as:0 ac:-1 enable:1
 * 171) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_process_server: accounting server id 0 (use auth server as acct server).
 * 172) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_process_server: xauthstatus 20.
 * 173) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16520, val 0 added, len 0.
 * 174) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16521, val empty string, type added, len 0.
 * 175) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16522, val empty string, type added, len 0.
 * 176) 2014-12-12 02:12:06 : IKE<192.168.3.1> Create conn entry...
 * 177) 2014-12-12 02:12:06 : IKE<192.168.3.1>   ...done(new ed440210)
 * 178) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct ISAKMP header.
 * 179) 2014-12-12 02:12:06 : IKE<192.168.3.1> Msg header built (next payload #8)
 * 180) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [HASH]
 * 181) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   print ikecfg attribute payload:
 * 182) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   next: 0, payloadlength 20, type 1, identifier 40803.
 * 183) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   basic attr type 16520, valint 0
 * 184) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 16521, vallen 0, valstr empty string, type
 * 185) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 16522, vallen 0, valstr empty string, type
 * 186) 2014-12-12 02:12:06 : IKE<0.0.0.0        >
 * 187) 2014-12-12 02:12:06 : IKE<192.168.3.1> construct QM HASH
 * 188) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Xmit*: [HASH] [IKECFG]
 * 189) 2014-12-12 02:12:06 : IKE<192.168.3.1> Encrypt P2 payload (len 68)
 * 190) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder sending IPv4 IP 192.168.3.1/port 10952
 * 191) 2014-12-12 02:12:06 : IKE<192.168.3.1> Send Phase 2 packet (len=76)
 * 192) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg packet sent. msgid ed440210, len: 68, peer<192.168.3.1>
 * 193) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth status updated by state machine: 20
 * 194) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   proc_other_session_notify->
 * 195) 2014-12-12 02:12:06 : IKE<0.0.0.0        >     process Notify Payload: doi(1), msg(24578), txt<INITIAL-CONTACT>
 * 196) 2014-12-12 02:12:06 : IKE<192.168.3.1> Received initial contact notification and removed Phase 1 SAs.
 * 197) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<6/1097182f>
 * 198) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 112, action 0
 * 199) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 84 bytes from socket.
 * 200) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if <ethernet0/3> of vsys <Root> ******
 * 201) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 84 bytes. src port 10952
 * 202) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 84, nxp 8[HASH], exch 6[XACT_EXCH], flag 01  E
 * 203) 2014-12-12 02:12:06 : IKE<192.168.3.1> Decrypting payload (length 56)
 * 204) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv*: [HASH] [IKECFG]
 * 205) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [IKECFG]:
 * 206) 2014-12-12 02:12:06 : IKE<192.168.3.1> processing IKECFG payload. msgid ed440210, msgtype 2, payload ID 40803
 * 207) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   print ikecfg attribute payload:
 * 208) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   next: 0, payloadlength 35, type 2, identifier 40803.
 * 209) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   basic attr type 16520, valint 0
 * 210) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 16521, vallen 8, valstr test-us
 * 211) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 16522, vallen 7, valstr test12
 * 212) 2014-12-12 02:12:06 : IKE<0.0.0.0        >
 * 213) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16520, val 0 added, len 0.
 * 214) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16521, val test-us added, len 8.
 * 215) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16522, val test12 added, len 7.
 * 216) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth server got type: 16520 v<0>
 * 217) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth server got var type: 16521
 * 218) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth server got var type: 16522
 * 219) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth server entering state machine: 20
 * 220) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_process_server: accounting server id 0 (use auth server as acct server).
 * 221) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_process_server: xauthstatus 20.
 * 222) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_auth_pap: authing locally: uname test-usr, passwd test123          SUCCESS
 * 223) 2014-12-12 02:12:06 : IKE<192.168.3.1> Get config for client(local auth)
 * 224) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg_assign_client_cfg: Sa->ip_addr = 0x0
 * 225) 2014-12-12 02:12:06 : IKE<192.168.3.1> getting xauth local user <test-usr> remote setting
 * 226) 2014-12-12 02:12:06 : IKE<192.168.3.1> getting xauth local user IP from pool <Pool1>
 * 227) 2014-12-12 02:12:06 : IKE<192.168.3.1> Don't do xauth RADIUS accounting. Send cfg to client directly.
 * 228) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg_send_client_cfg: ip 10.1.1.20, v4mask 255.255.255.255 dns1 0.0.0.0, dns2 0.0.0.0, win1 0.0.0.0, win2 0.0.0.0
 * 229) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg_send_client_cfg v6: id ::, prefix ::/0
 * 230) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg_send_client_cfg v6: dns1 ::, dns2 ::, win1 ::, win2 ::
 * 231) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 1, val 10.1.1.20 added, len 4.
 * 232) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 2, val 255.255.255.255 added, len 4.
 * 233) 2014-12-12 02:12:06 : IKE<192.168.3.1> Create conn entry...
 * 234) 2014-12-12 02:12:06 : IKE<192.168.3.1>   ...done(new 0024e2eb)
 * 235) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct ISAKMP header.
 * 236) 2014-12-12 02:12:06 : IKE<192.168.3.1> Msg header built (next payload #8)
 * 237) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [HASH]
 * 238) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   print ikecfg attribute payload:
 * 239) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   next: 0, payloadlength 24, type 3, identifier 40803.
 * 240) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 1, vallen 4, valstr 10.1.1.20
 * 241) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 2, vallen 4, valstr 255.255.255.255
 * 242) 2014-12-12 02:12:06 : IKE<0.0.0.0        >
 * 243) 2014-12-12 02:12:06 : IKE<192.168.3.1> construct QM HASH
 * 244) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Xmit*: [HASH] [IKECFG]
 * 245) 2014-12-12 02:12:06 : IKE<192.168.3.1> Encrypt P2 payload (len 72)
 * 246) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder sending IPv4 IP 192.168.3.1/port 10952
 * 247) 2014-12-12 02:12:06 : IKE<192.168.3.1> Send Phase 2 packet (len=76)
 * 248) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg packet sent. msgid 24e2eb, len: 72, peer<192.168.3.1>
 * 249) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth status updated by state machine: 90
 * 250) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<6/1097182f>
 * 251) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 96, action 0
 * 252) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 68 bytes from socket.
 * 253) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if <ethernet0/3> of vsys <Root> ******
 * 254) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 68 bytes. src port 10952
 * 255) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 68, nxp 8[HASH], exch 6[XACT_EXCH], flag 01  E
 * 256) 2014-12-12 02:12:06 : IKE<192.168.3.1> Decrypting payload (length 40)
 * 257) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv*: [HASH] [IKECFG]
 * 258) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [IKECFG]:
 * 259) 2014-12-12 02:12:06 : IKE<192.168.3.1> processing IKECFG payload. msgid 24e2eb, msgtype 4, payload ID 40803
 * 260) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   print ikecfg attribute payload:
 * 261) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   next: 0, payloadlength 16, type 4, identifier 40803.
 * 262) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 1, vallen 0, valstr 0.2.0.0
 * 263) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 2, vallen 0, valstr 0.0.0.0
 * 264) 2014-12-12 02:12:06 : IKE<0.0.0.0        >
 * 265) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 1, val 0.0.0.0 added, len 0.
 * 266) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 2, val 0.0.0.0 added, len 0.
 * 267) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth server entering state machine: 90
 * 268) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_process_server: accounting server id 0 (use auth server as acct server).
 * 269) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_process_server: xauthstatus 90.
 * 270) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ikecfg list add attr type 16527, val 1 added, len 0.
 * 271) 2014-12-12 02:12:06 : IKE<192.168.3.1> Create conn entry...
 * 272) 2014-12-12 02:12:06 : IKE<192.168.3.1>   ...done(new 9664b261)
 * 273) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct ISAKMP header.
 * 274) 2014-12-12 02:12:06 : IKE<192.168.3.1> Msg header built (next payload #8)
 * 275) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [HASH]
 * 276) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   print ikecfg attribute payload:
 * 277) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   next: 0, payloadlength 12, type 3, identifier 40803.
 * 278) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   basic attr type 16527, valint 1
 * 279) 2014-12-12 02:12:06 : IKE<0.0.0.0        >
 * 280) 2014-12-12 02:12:06 : IKE<192.168.3.1> construct QM HASH
 * 281) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Xmit*: [HASH] [IKECFG]
 * 282) 2014-12-12 02:12:06 : IKE<192.168.3.1> Encrypt P2 payload (len 60)
 * 283) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder sending IPv4 IP 192.168.3.1/port 10952
 * 284) 2014-12-12 02:12:06 : IKE<192.168.3.1> Send Phase 2 packet (len=68)
 * 285) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikecfg packet sent. msgid 9664b261, len: 60, peer<192.168.3.1>
 * 286) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth status updated by state machine: 100
 * 287) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_passed
 * 288) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth login PASSED. gw <Dialup-VPNGW>, username <test-usr>, retry: 0
 * 289) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_cleanup
 * 290) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<6/1097182f>
 * 291) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 88, action 0
 * 292) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 200, action 0
 * 293) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 60 bytes from socket.
 * 294) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if <ethernet0/3> of vsys <Root> ******
 * 295) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 60 bytes. src port 10952
 * 296) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 60, nxp 8[HASH], exch 6[XACT_EXCH], flag 01  E
 * 297) 2014-12-12 02:12:06 : IKE<192.168.3.1> Decrypting payload (length 32)
 * 298) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv*: [HASH] [IKECFG]
 * 299) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [IKECFG]:
 * 300) 2014-12-12 02:12:06 : IKE<192.168.3.1> processing IKECFG payload. msgid 9664b261, msgtype 4, payload ID 40803
 * 301) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   print ikecfg attribute payload:
 * 302) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   next: 0, payloadlength 12, type 4, identifier 40803.
 * 303) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   variable attr type 16527, vallen 0, valstr
 * 304) 2014-12-12 02:12:06 : IKE<0.0.0.0        >
 * 305) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth: bad state negt peer
 * 306) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<6/1097182f>
 * 307) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 172 bytes from socket.
 * 308) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if <ethernet0/3> of vsys <Root> ******
 * 309) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 172 bytes. src port 10952
 * 310) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 172, nxp 8[HASH], exch 32[QM], flag 01  E
 * 311) 2014-12-12 02:12:06 : IKE<192.168.3.1> Create conn entry...
 * 312) 2014-12-12 02:12:06 : IKE<192.168.3.1>   ...done(new 519fb6b9)
 * 313) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 2 msg-id : Responded to the first peer message.
 * 314) 2014-12-12 02:12:06 : IKE<192.168.3.1> Decrypting payload (length 144)
 * 315) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv*: [HASH] [SA] [NONCE] [ID] [ID]
 * 316) 2014-12-12 02:12:06 : valid id checking, id type:IP Address, len:12.
 * 317) 2014-12-12 02:12:06 : valid id checking, id type:IP Subnet, len:16.
 * 318) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   extract payload (144):
 * 319) 2014-12-12 02:12:06 : valid id checking, id type:IP Address, len:12.
 * 320) 2014-12-12 02:12:06 : valid id checking, id type:IP Subnet, len:16.
 * 321) 2014-12-12 02:12:06 : IKE<192.168.3.1> QM in state OAK_QM_SA_ACCEPT.
 * 322) 2014-12-12 02:12:06 : IKE<192.168.3.1> receive init proxy id type ID_IPV4_ADDR with mask 0: force mask to all 1.
 * 323) 2014-12-12 02:12:06 : IKE<192.168.3.1> Start by finding matching member SA (verify -1/-1)
 * 324) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE: Matching policy: gw ip <192.168.3.1> peer entry id<1>
 * 325) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   protocol matched expected<0>.
 * 326) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   port matched expect l:<0>, r<0>.
 * 327) 2014-12-12 02:12:06 : IKE<192.168.3.1> Peer is dial up.
 * 328) 2014-12-12 02:12:06 : IKE<192.168.3.1> configured ID for sa(4):
 * 329) 2014-12-12 02:12:06 : IKE<192.168.3.1> local  10.1.1.0/24 prot<0> port<0> type<4>      remote 10.1.1.20/32 prot<0> port<0> type<1>
 * 330) 2014-12-12 02:12:06 : IKE<192.168.3.1> member without dynamic policy found, match local address only
 * 331) 2014-12-12 02:12:06 : ipvx = IPV4
 * 332) 2014-12-12 02:12:06 : rcv_local_addr = 10.1.1.0, rcv_local_mask = 255.255.255.0, p_rcv_local_real = 10.1.1.0
 * 333) 2014-12-12 02:12:06 : rcv_remote_addr = 10.1.1.20, rcv_remote_mask = 255.255.255.255, p_rcv_remote_real = 10.1.1.20
 * 334) 2014-12-12 02:12:06 : ike_p2_id->local_ip = 10.1.1.0, cfg_local_mask = 255.255.255.0, p_cfg_local_real = 10.1.1.0
 * 335) 2014-12-12 02:12:06 : ike_p2_id->remote_ip = 10.1.1.20, cfg_remote_mask = 255.255.255.255, p_cfg_remote_real = 10.1.1.20
 * 336) 2014-12-12 02:12:06 : IKE<192.168.3.1> Proxy ID match: Located matching Phase 2 SA <4>.
 * 337) 2014-12-12 02:12:06 : IKE<192.168.3.1> Start by finding matching member SA (verify -1/-1)
 * 338) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE: Matching policy: gw ip <192.168.3.1> peer entry id<1>
 * 339) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   protocol matched expected<0>.
 * 340) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   port matched expect l:<0>, r<0>.
 * 341) 2014-12-12 02:12:06 : IKE<192.168.3.1> Peer is dial up.
 * 342) 2014-12-12 02:12:06 : IKE<192.168.3.1> configured ID for sa(4):
 * 343) 2014-12-12 02:12:06 : IKE<192.168.3.1> local  10.1.1.0/24 prot<0> port<0> type<4>      remote 10.1.1.20/32 prot<0> port<0> type<1>
 * 344) 2014-12-12 02:12:06 : IKE<192.168.3.1> member without dynamic policy found, match local address only
 * 345) 2014-12-12 02:12:06 : ipvx = IPV4
 * 346) 2014-12-12 02:12:06 : rcv_local_addr = 10.1.1.0, rcv_local_mask = 255.255.255.0, p_rcv_local_real = 10.1.1.0
 * 347) 2014-12-12 02:12:06 : rcv_remote_addr = 10.1.1.20, rcv_remote_mask = 255.255.255.255, p_rcv_remote_real = 10.1.1.20
 * 348) 2014-12-12 02:12:06 : ike_p2_id->local_ip = 10.1.1.0, cfg_local_mask = 255.255.255.0, p_cfg_local_real = 10.1.1.0
 * 349) 2014-12-12 02:12:06 : ike_p2_id->remote_ip = 10.1.1.20, cfg_remote_mask = 255.255.255.255, p_cfg_remote_real = 10.1.1.20
 * 350) 2014-12-12 02:12:06 : IKE<192.168.3.1> Proxy ID match: Located matching Phase 2 SA <4>.
 * 351) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [SA]:
 * 352) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   Check P2 Proposal
 * 353) 2014-12-12 02:12:06 : IKE<192.168.3.1> SA life type = seconds
 * 354) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   SA life duration (TV) = 28800
 * 355) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   encap mode from peer = 1.
 * 356) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   encap mode after converting it to private value = 1.
 * 357) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 2 received:
 * 358) 2014-12-12 02:12:06 : IKE<192.168.3.1> atts<00000003 00000000 00000002 00000001 00000001 00000000>
 * 359) 2014-12-12 02:12:06 : IKE<192.168.3.1> proto(3)<ESP>, esp(2)<ESP_DES>, auth(1)<MD5>, encap(1)<TUNNEL>, group(0)
 * 360) 2014-12-12 02:12:06 : IKE<192.168.3.1> P2 proposal [0] selected.
 * 361) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   add sa list for msg id
 * 362) 2014-12-12 02:12:06 : IKE<192.168.3.1> get_unique_spi 0, 1314921947, 4e601ddb
 * 363) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [NONCE]:
 * 364) 2014-12-12 02:12:06 : IKE<192.168.3.1> processing NONCE in phase 2.
 * 365) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [ID]:
 * 366) 2014-12-12 02:12:06 : IKE<192.168.3.1> Process [ID]:
 * 367) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 2 Responder constructing 2nd message.
 * 368) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct ISAKMP header.
 * 369) 2014-12-12 02:12:06 : IKE<192.168.3.1> Msg header built (next payload #8)
 * 370) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [HASH]
 * 371) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [SA] for IPSEC
 * 372) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   Set IPSEC SA attrs tunnel(1) MD5 grp0 lifetime(28800/0)
 * 373) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   Before NAT-T attr unmap: P2 prop tunnel = 1.
 * 374) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   After NAT-T attr unmap: P2 prop tunnel = 1.
 * 375) 2014-12-12 02:12:06 : IKE<10.1.1.20> IP<10.1.1.20> mask<255.255.255.255> prot<0> port<0>
 * 376) 2014-12-12 02:12:06 : IKE<192.168.3.1> Initiator P2 ID built: ...h
 * 377) 2014-12-12 02:12:06 : IKE<10.1.1.0> IP<10.1.1.0> mask<255.255.255.0> prot<0> port<0>
 * 378) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder P2 ID built: ...h
 * 379) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [NONCE] for IPSec
 * 380) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [ID] for Phase 2
 * 381) 2014-12-12 02:12:06 : id payload constructed. type(1),ip(10.1.1.20),mask(255.255.255.255), prot(0), port(0)
 * 382) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [ID] for Phase 2
 * 383) 2014-12-12 02:12:06 : id payload constructed. type(4),ip(10.1.1.0),mask(255.255.255.0), prot(0), port(0)
 * 384) 2014-12-12 02:12:06 : IKE<192.168.3.1> send out RESPONDER_LIFETIME notification. prot=3,
 * 385) 2014-12-12 02:12:06 : IKE<192.168.3.1> life_sec=3600
 * 386) 2014-12-12 02:12:06 : IKE<192.168.3.1> Construct [NOTIF] (RESPONDER-LIFETIME) for IPSEC
 * 387) 2014-12-12 02:12:06 : IKE<192.168.3.1> construct QM HASH
 * 388) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Xmit*: [HASH] [SA] [NONCE] [ID] [ID] [NOTIF]
 * 389) 2014-12-12 02:12:06 : IKE<192.168.3.1> Encrypt P2 payload (len 192)
 * 390) 2014-12-12 02:12:06 : IKE<192.168.3.1> Responder sending IPv4 IP 192.168.3.1/port 10952
 * 391) 2014-12-12 02:12:06 : IKE<192.168.3.1> Send Phase 2 packet (len=196)
 * 392) 2014-12-12 02:12:06 : IKE<192.168.3.1> oakley_process_quick_mode:exit
 * 393) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<6/1097182f>
 * 394) 2014-12-12 02:12:06 : IKE<192.168.3.1> ike packet, len 80, action 0
 * 395) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: received 52 bytes from socket.
 * 396) 2014-12-12 02:12:06 : IKE<192.168.3.1> ****** Recv packet if <ethernet0/3> of vsys <Root> ******
 * 397) 2014-12-12 02:12:06 : IKE<192.168.3.1> Catcher: get 52 bytes. src port 10952
 * 398) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   ISAKMP msg: len 52, nxp 8[HASH], exch 32[QM], flag 01  E
 * 399) 2014-12-12 02:12:06 : IKE<192.168.3.1> Decrypting payload (length 24)
 * 400) 2014-12-12 02:12:06 : IKE<192.168.3.1    > Recv*: [HASH]
 * 401) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   extract payload (24):
 * 402) 2014-12-12 02:12:06 : IKE<192.168.3.1> QM in state OAK_QM_AUTH_AWAIT.
 * 403) 2014-12-12 02:12:06 : IKE<192.168.3.1> xauth_cleanup
 * 404) 2014-12-12 02:12:06 : IKE<192.168.3.1> Done cleaning up IKE Phase 1 SA
 * 405) 2014-12-12 02:12:06 : IKE<192.168.3.1> Start by finding matching member SA (verify 0/0)
 * 406) 2014-12-12 02:12:06 : IKE<192.168.3.1> Verify sa: index 0
 * 407) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE: Matching policy: gw ip <192.168.3.1> peer entry id<1>
 * 408) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   protocol matched expected<0>.
 * 409) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   port matched expect l:<0>, r<0>.
 * 410) 2014-12-12 02:12:06 : IKE<192.168.3.1> Peer is dial up.
 * 411) 2014-12-12 02:12:06 : IKE<192.168.3.1> configured ID for sa(4):
 * 412) 2014-12-12 02:12:06 : IKE<192.168.3.1> local  10.1.1.0/24 prot<0> port<0> type<4>     remote 10.1.1.20/32 prot<0> port<0> type<1>
 * 413) 2014-12-12 02:12:06 : IKE<192.168.3.1> member without dynamic policy found, match local address only
 * 414) 2014-12-12 02:12:06 : ipvx = IPV4
 * 415) 2014-12-12 02:12:06 : rcv_local_addr = 10.1.1.0, rcv_local_mask = 255.255.255.0, p_rcv_local_real = 10.1.1.0
 * 416) 2014-12-12 02:12:06 : rcv_remote_addr = 10.1.1.20, rcv_remote_mask = 255.255.255.255, p_rcv_remote_real = 10.1.1.20
 * 417) 2014-12-12 02:12:06 : ike_p2_id->local_ip = 10.1.1.0, cfg_local_mask = 255.255.255.0, p_cfg_local_real = 10.1.1.0
 * 418) 2014-12-12 02:12:06 : ike_p2_id->remote_ip = 10.1.1.20, cfg_remote_mask = 255.255.255.255, p_cfg_remote_real = 10.1.1.20
 * 419) 2014-12-12 02:12:06 : IKE<192.168.3.1> Proxy ID match: Located matching Phase 2 SA <4>.
 * 420) 2014-12-12 02:12:06 : IKE<192.168.3.1> sa ID for phase 2 sa is <4>. IP version is 4.
 * 421) 2014-12-12 02:12:06 : IKE<192.168.3.1> Single user entry.
 * 422) 2014-12-12 02:12:06 : ikmpd.c 3871. pidt == 2a79d90
 * 423) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   life (sec or kb): lcl 3600, peer 28800, set 3600.
 * 424) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   life (sec or kb): lcl 0, peer 0, set 0.
 * 425) 2014-12-12 02:12:06 : IKE<192.168.3.1> gen_qm_key
 * 426) 2014-12-12 02:12:06 : IKE<192.168.3.1> load_sa_keys: enter.
 * 427) 2014-12-12 02:12:06 : IKE<192.168.3.1> gen_qm_key
 * 428) 2014-12-12 02:12:06 : IKE<192.168.3.1> load_sa_keys: enter.
 * 429) 2014-12-12 02:12:06 : IKE<192.168.3.1> ikmpd.c 3999. sa ID for phase 2 sa is <4>. IP version is 4.
 * 430) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   spi hash node removed: type<2>,spi ,ip<192.168.1.1>
 * 431) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   spi hash node removed: type<2>,spi ,ip<192.168.3.1>
 * 432) 2014-12-12 02:12:06 : IKE<192.168.3.1> clean_all_sa_state_node_from_list->
 * 433) 2014-12-12 02:12:06 : IKE<192.168.3.1> no relocate earlier SA-state, not active.
 * 434) 2014-12-12 02:12:06 : IKE<192.168.3.1> key_modify: sa index <0> bk_idx <0>.
 * 435) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   insert_sa_state_to_spi_hash spi, sa_index<0>, Incoming
 * 436) 2014-12-12 02:12:06 : IKE<0.0.0.0        >   insert_sa_state_to_spi_hash spi, sa_index<0>, Outgoing
 * 437) 2014-12-12 02:12:06 : IKE<192.168.3.1> update acvpn flags for sa 0
 * 438) 2014-12-12 02:12:06 : IKE<192.168.3.1> update acvpn flags for sa 0 - 0x400033
 * 439) 2014-12-12 02:12:06 : IKE<192.168.3.1>  crypto_ctx 11, 8, 8, 8, 0, 0, 16, 0, 12, 48
 * 440) 2014-12-12 02:12:06 : IKE<192.168.3.1> modify esp tunnel: src (peer) ipv4 <192.168.3.1>
 * 441) 2014-12-12 02:12:06 : IKE<192.168.3.1> modifying esp tunnel: self <ipv4 192.168.1.1>
 * 442) 2014-12-12 02:12:06 : IKE<192.168.3.1> update auto NHTB status for sa 0
 * 443) 2014-12-12 02:12:06 : IKE<192.168.3.1> after mod, out nsptunnel.
 * 444) 2014-12-12 02:12:06 : IKE<192.168.3.1> Phase 2 msg-id : Completed Quick Mode negotiation with SPI ,tunnel ID <4>, and lifetime seconds/<0> KB.
 * 445) 2014-12-12 02:12:06 : IKE<192.168.3.1> Application sa installed.
 * 446) 2014-12-12 02:12:06 : IKE<192.168.3.1> oakley_process_quick_mode:exit
 * 447) 2014-12-12 02:12:06 : IKE<192.168.3.1> IKE msg done: PKI state<0> IKE state<6/1097182f>
 * 448) 2014-12-12 02:12:07 : IKE<192.168.2.1> nhtb_list_update_status: vpn VPN1-PH2
 * 449) 2014-12-12 02:12:07 : IKE<192.168.2.1>   ** link ready return 8
 * 450) 2014-12-12 02:12:07 : IKE<192.168.2.1> sa_link_status_for_tunl_ifp: saidx 1, preliminary status 8
 * 451) 2014-12-12 02:12:07 : IKE<192.168.2.1>   local_if is ethernet0/3

= get config =

<pre style="width: 97%; overflow-x: scroll;">set interface ethernet0/1.1 ip 10.1.1.1/24 set interface ethernet0/1.1 nat set interface ethernet0/3 ip 192.168.1.1/24 set interface ethernet0/3 route set ippool "Pool1" 10.1.1.20 10.1.1.25 set user "test-usr" uid 2 set user "test-usr" ike-id u-fqdn "aman1@wipro.com" share-limit 1 set user "test-usr" type ike xauth set user "test-usr" remote ippool "Pool1" set user "test-usr" password "OW73BW/zNXx/Tqs/rgC0l/3xySn6JZ4RAg==" unset user "test-usr" type auth set user "test-usr" "enable" set crypto-policy set ike gateway "Dialup-VPNGW" dialup "test-usr" Aggr outgoing-interface "ethernet0/3" preshare "Tvh0IpHtNk8w1AsnRUCWBK1GHknZF/BSwA==" proposal "pre-g1-des-md5" set ike gateway "Dialup-VPNGW" nat-traversal keepalive-frequency 5 set ike gateway "Dialup-VPNGW" xauth server "Local" user "test-usr" set xauth default ippool "Pool1" set vpn "Dialup-PH2" gateway "Dialup-VPNGW" no-replay tunnel idletime 0 proposal "nopfs-esp-des-md5" set policy id 5 from "Untrust" to "Trust" "Dial-Up VPN IPv4" "10.1.1.0/24" "ANY" tunnel vpn "Dialup-PH2" id 0x4 log

= get vpn =

SSG-1-> get vpn Name           Gateway         Mode RPlay 1st Proposal         Monitor Use Cnt Interface --- --- -  --- --- --- Dialup-PH2      Dialup-VPNGW    tunl No    nopfs-esp-des-md5    off           1 eth0/3 Total Auto VPN: 1 Total Pure Transport Mode IPSEC VPN: 0

Name      Gateway         Interface       Lcl SPI  Rmt SPI  Algorithm        Monitor Tunnel ID -- --- ---    --- -- Total Manual VPN 0

= get ike cookie =

SSG-1-> get ike cookie

IKEv1 SA -- Active: 1, Dead: 0, Total 1

1097182f/0006, 192.168.3.1:10952->192.168.1.1:500, PRESHR/grp1/DES/MD5, xchg(5) (Dialup-VPNGW/grp-1/usr2) resent-tmr 322 lifetime 28800 lt-recv 86400 nxt_rekey 28773 cert-expire 0 responder, err cnt 0, send dir 1, cond 0xc0 nat-traversal map not available ike heartbeat             : disabled ike heartbeat last rcv time: 0 ike heartbeat last snd time: 0 XAUTH status: 100 DPD seq local 0, peer 8842451

IKEv2 SA -- Active: 0, Dead: 0, Total 0

= get sa =

SSG-1-> get sa total configured sa: 1 HEX ID   Gateway         Port Algorithm     SPI      Life:sec kb Sta   PID vsys 00000004<    192.168.3.1  500 esp: des/md5  4e601ddb  3567 unlim A/-     5 0 00000004>    192.168.3.1  500 esp: des/md5  643e9307  3567 unlim A/-    -1 0

= get sa id =

SSG-1-> get sa id 0x4 index 0, name Dialup-PH2, peer gateway ip 192.168.3.1. vsys<Root> auto key. policy node, tunnel mode, policy id in:<5> out:<-1> vpngrp:<-1>. sa_list_nxt:<-1>. tunnel id 4, peer id 1, NSRP Local. dialup, original. site-to-site. Local interface is ethernet0/3 <192.168.1.1>. esp, group 0, des encryption, md5  authentication autokey, IN active, OUT active monitor<0>, latency: 0, availability: 0 DF bit: clear app_sa_flags: 0x2400033 proxy id: local 10.1.1.0/255.255.255.0, remote 10.1.1.20/255.255.255.255, proto 0, port 0/0 ike activity timestamp: 87547605 DSCP-mark : disabled nat-traversal map not available incoming: SPI 4e601ddb, flag 00004000, tunnel info 40000004, pipeline life 3600 sec, 3549 remain, 0 kb, 0 bytes remain anti-replay off, idle timeout value <0>, idled 51 seconds next pak sequence number: 0x0 bytes/paks:1620/27; sw bytes/paks:1620/27 outgoing: SPI 643e9307, flag 00000000, tunnel info 40000004, pipeline life 3600 sec, 3549 remain, 0 kb, 0 bytes remain anti-replay off, idle timeout value <0>, idled 51 seconds next pak sequence number: 0x0 bytes/paks:1620/27; sw bytes/paks:1620/27

= get event =

<pre style="width: 97%; overflow-x: scroll;"> SSG-1-> get event Total event entries = 3037 Date      Time     Module Level  Type Description 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1 Phase 2 msg ID 519fb6b9: Completed negotiations with SPI 4e601ddb, tunnel ID 4, and lifetime 3600 seconds/0 KB. 2014-12-12 02:12:06 system info  00536 IKE 192.168.3.1 phase 2:The symmetric crypto key has been generated successfully. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1 Phase 2 msg ID 519fb6b9: Responded to the peer's first message. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1: XAuth login was passed for gateway Dialup-VPNGW, username test-usr, retry: 0, Client IP Addr 10.1.1.20, IPPool name: Pool1, Session-Timeout: 0s, Idle-Timeout: 0s. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1: Received initial contact notification and removed Phase 1 SAs. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1 Phase 1: Completed Aggressive mode negotiations with a 28800-second lifetime. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1 Phase 1: Completed for user test-usr. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1: Received initial contact notification and removed Phase 2 SAs. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1: Received a notification message for DOI 1 24578 INITIAL-CONTACT. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1 phase 1:The symmetric crypto key has been generated successfully. 2014-12-12 02:12:06 system info 00536 IKE 192.168.3.1 Phase 1: Responder starts AGGRESSIVE mode negotiations.

= NCP-e Client Profile=

[GENERAL] Export=1 Product=NCP Secure Client - Juniper Edition Version=9.32 Build 218 Date=12/11/2014 3:34:09 PM [PROFILE1] Name=dialup-ssg NotKeepVpn=0 BootProfile=0 ConnMode=0 Timeout=1000 PkiConfig= ExchMode=4 IKE-Policy=Pre-shared Key IkeDhGroup=1 IkeLTSec=001:00:00:00 IPSec-Policy=proposal PFS=0 IPSecLTType=1 IpsecLTSec=000:08:00:00 IPSecLTKb=50000 IkeIdType=3 IkeIdStr=aman1@wipro.com XAUTH-Id=":&#Thþ;þ4þ;" XAUTH-Pw=":&#Tt\T" Gateway=192.168.1.1 UseTunnel=0 UseXAUTH=1 DisDPD=0 DPDInterval=20 DPDRetrys=8 AntiReplay=0 IpAddrAssign=0 IPAddress= SubnetMask=255.255.255.0 DNS1=0.0.0.0 DNS2=0.0.0.0 WINS1=0.0.0.0 WINS2=0.0.0.0 DomainName= SubjectCert= IssuerCert= FingerPrint= UseSHA1=0 DNSActiv=0 DNS1Tmp=0.0.0.0 DNS2Tmp=0.0.0.0 WINS1Tmp=0.0.0.0 WINS2Tmp=0.0.0.0 Secret="qc" UsePreShKey=1 Network1=10.1.1.0 SubMask1=255.255.255.0 [IKEPOLICY1] IkeName=Pre-shared Key IkeCrypt=1 IkeHash=1 IkeAuth=1 IkeDhGroup=2 [IPSECPOLICY1] IPSecName=proposal IpsecCrypt=1 IpsecAuth=1