2003-09-30 12:39:04: INFO: main.c:172:main(): @(#)package version netbsd-pkgsrc-20021120a
2003-09-30 12:39:04: INFO: main.c:174:main(): @(#)internal version 20001216 sakane@kame.net
2003-09-30 12:39:04: INFO: main.c:175:main(): @(#)This product linked OpenSSL 0.9.6g 9 Aug 2002 (http://www.openssl.org/)
2003-09-30 12:39:04: DEBUG: pfkey.c:371:pfkey_init(): call pfkey_send_register for AH
2003-09-30 12:39:04: DEBUG: pfkey.c:371:pfkey_init(): call pfkey_send_register for ESP
2003-09-30 12:39:04: DEBUG: pfkey.c:371:pfkey_init(): call pfkey_send_register for IPCOMP
2003-09-30 12:39:04: DEBUG2: cftoken.l:115:yylex(): begin <5>path
2003-09-30 12:39:04: DEBUG2: cftoken.l:118:yylex(): <5>
2003-09-30 12:39:04: DEBUG2: cftoken.l:386:yylex(): <5>
2003-09-30 12:39:04: DEBUG2: cftoken.l:124:yylex(): begin <3>;
2003-09-30 12:39:04: DEBUG2: cftoken.l:115:yylex(): begin <5>path
2003-09-30 12:39:04: DEBUG2: cftoken.l:120:yylex(): <5>
2003-09-30 12:39:04: DEBUG2: cftoken.l:386:yylex(): <5>
2003-09-30 12:39:04: DEBUG2: cftoken.l:124:yylex(): begin <3>;
2003-09-30 12:39:04: DEBUG2: cftoken.l:157:yylex(): begin <13>listen
2003-09-30 12:39:04: DEBUG2: cftoken.l:159:yylex(): <13>
2003-09-30 12:39:04: DEBUG2: cftoken.l:401:yylex(): <13>
2003-09-30 12:39:04: DEBUG2: cftoken.l:265:yylex(): <13>
2003-09-30 12:39:04: DEBUG2: cftoken.l:161:yylex(): <13>
2003-09-30 12:39:04: DEBUG2: cftoken.l:195:yylex(): begin <25>remote
2003-09-30 12:39:04: DEBUG2: cftoken.l:196:yylex(): <25>
2003-09-30 12:39:04: DEBUG2: cftoken.l:200:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:203:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:227:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:229:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:215:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:216:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:386:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:386:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:212:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:336:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:386:yylex(): <27>
2003-09-30 12:39:04: DEBUG2: cftoken.l:238:yylex(): begin <29>proposal
2003-09-30 12:39:04: DEBUG2: cftoken.l:244:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:285:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:246:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:306:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:245:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:324:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:247:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:315:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:238:yylex(): begin <29>proposal
2003-09-30 12:39:04: DEBUG2: cftoken.l:244:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:285:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:246:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:306:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:245:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:325:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:247:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cftoken.l:315:yylex(): <29>
2003-09-30 12:39:04: DEBUG2: cfparse.y:1172:set_isakmp_proposal(): lifetime = 28800
2003-09-30 12:39:04: DEBUG2: cfparse.y:1175:set_isakmp_proposal(): lifebyte = 0
2003-09-30 12:39:04: DEBUG2: cfparse.y:1178:set_isakmp_proposal(): encklen=0
2003-09-30 12:39:04: DEBUG2: cfparse.y:1241:expand_isakmpspec(): p:1 t:1
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): 3DES-CBC(5)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): SHA(2)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): 1024-bit MODP group(2)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): pre-shared key(1)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1252:expand_isakmpspec(): 
2003-09-30 12:39:04: DEBUG2: cfparse.y:1172:set_isakmp_proposal(): lifetime = 28800
2003-09-30 12:39:04: DEBUG2: cfparse.y:1175:set_isakmp_proposal(): lifebyte = 0
2003-09-30 12:39:04: DEBUG2: cfparse.y:1178:set_isakmp_proposal(): encklen=0
2003-09-30 12:39:04: DEBUG2: cfparse.y:1241:expand_isakmpspec(): p:1 t:2
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): 3DES-CBC(5)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): SHA(2)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): 1024-bit MODP group(2)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1245:expand_isakmpspec(): RSA signatures(3)
2003-09-30 12:39:04: DEBUG2: cfparse.y:1252:expand_isakmpspec(): 
2003-09-30 12:39:04: DEBUG2: cftoken.l:175:yylex(): begin <21>sainfo
2003-09-30 12:39:04: DEBUG2: cftoken.l:176:yylex(): <21>
2003-09-30 12:39:04: DEBUG2: cftoken.l:189:yylex(): <23>
2003-09-30 12:39:04: DEBUG2: cftoken.l:285:yylex(): <23>
2003-09-30 12:39:04: DEBUG2: cftoken.l:190:yylex(): <23>
2003-09-30 12:39:04: DEBUG2: cftoken.l:299:yylex(): <23>
2003-09-30 12:39:04: DEBUG2: cftoken.l:191:yylex(): <23>
2003-09-30 12:39:04: DEBUG2: cftoken.l:312:yylex(): <23>
2003-09-30 12:39:04: DEBUG: pfkey.c:2243:pk_checkalg(): compression algorithm can not be checked because sadb message doesn't support it.
2003-09-30 12:39:04: DEBUG2: cfparse.y:1354:cfparse(): parse successed.
2003-09-30 12:39:04: INFO: isakmp.c:1358:isakmp_open(): 63.202.92.133[500] used as isakmp port (fd=10)
2003-09-30 12:39:04: DEBUG: pfkey.c:195:pfkey_handler(): get pfkey X_SPDDUMP message
2003-09-30 12:39:04: DEBUG2: plog.c:193:plogdump(): 
02120000 17000100 01000000 dd510000 03000500 ff200000 10020000 ac1e1601
00000000 00000000 03000600 ff200000 10020000 0a080807 00000000 00000000
07001200 02000100 19000000 00000000 28003200 02020000 10020000 405e326c
00000000 00000000 10020000 3fca5c85 00000000 00000000 04000200 00000000
00000000 00000000 d7db793f 00000000 d7db793f 00000000 04000300 00000000
00000000 00000000 00000000 00000000 00000000 00000000
2003-09-30 12:39:04: DEBUG: pfkey.c:195:pfkey_handler(): get pfkey X_SPDDUMP message
2003-09-30 12:39:04: DEBUG2: plog.c:193:plogdump(): 
02120000 17000100 00000000 dd510000 03000500 ff200000 10020000 0a080807
00000000 00000000 03000600 ff200000 10020000 ac1e1601 00000000 00000000
07001200 02000200 1a000000 00000000 28003200 02020000 10020000 3fca5c85
00000000 00000000 10020000 405e326c 00000000 00000000 04000200 00000000
00000000 00000000 d7db793f 00000000 d7db793f 00000000 04000300 00000000
00000000 00000000 00000000 00000000 00000000 00000000
2003-09-30 12:39:04: DEBUG: policy.c:184:cmpspidxstrict(): sub:0xbfbfd4fc: 10.8.8.7/32[0] 172.30.22.1/32[0] proto=any dir=out
2003-09-30 12:39:04: DEBUG: policy.c:185:cmpspidxstrict(): db :0x80a2c08: 172.30.22.1/32[0] 10.8.8.7/32[0] proto=any dir=in
2003-09-30 12:39:37: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:39:37: DEBUG: isakmp.c:222:isakmp_handler(): 220 bytes message received from 64.94.50.108[500]
2003-09-30 12:39:37: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 00000000 00000000 01100200 00000000 000000dc 0d000034
00000001 00000001 00000028 00010001 00000020 00010000 80010005 80020002
80030001 80040002 800b0001 800c2a30 0d000014 5de9bc4c 3560aa16 cb2df25e
7950f160 0d000014 27bab5dc 01ea0760 ea4e3190 ac27c0d0 0d000014 6105c422
e76847e4 3f968480 1292aecd 0d000014 4485152d 18b6bbcd 0be8a846 9579ddcc
0d000014 cd604643 35df21f8 7cfdb2fc 68b6a448 0d000014 90cb8091 3ebb696e
086381b5 ec427b1f 00000014 7d9419a6 5310ca6f 2c179d92 15529d56
2003-09-30 12:39:37: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:37: DEBUG: remoteconf.c:129:getrmconf(): anonymous configuration selected for 64.94.50.108[500].
2003-09-30 12:39:37: DEBUG: isakmp.c:889:isakmp_ph1begin_r(): ===
2003-09-30 12:39:37: INFO: isakmp.c:894:isakmp_ph1begin_r(): respond new phase 1 negotiation: 63.202.92.133[500]<=>64.94.50.108[500]
2003-09-30 12:39:37: INFO: isakmp.c:899:isakmp_ph1begin_r(): begin Identity Protection mode.
2003-09-30 12:39:37: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=1(sa)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=13(vid)
2003-09-30 12:39:37: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: vendorid.c:137:check_vendorid(): received unknown Vendor ID
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1117:get_proppair(): total SA len=48
2003-09-30 12:39:37: DEBUG: plog.c:193:plogdump(): 
00000001 00000001 00000028 00010001 00000020 00010000 80010005 80020002
80030001 80040002 800b0001 800c2a30
2003-09-30 12:39:37: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=2(prop)
2003-09-30 12:39:37: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1170:get_proppair(): proposal #0 len=40
2003-09-30 12:39:37: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=3(trns)
2003-09-30 12:39:37: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1311:get_transform(): transform #0 len=32
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1870:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC
2003-09-30 12:39:37: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1870:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA
2003-09-30 12:39:37: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1870:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1870:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group
2003-09-30 12:39:37: DEBUG: algorithm.c:610:alg_oakley_dhdef(): hmac(modp1024)
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1870:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1870:check_attr_isakmp(): type=Life Duration, flag=0x8000, lorv=10800
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1213:get_proppair(): pair 0:
2003-09-30 12:39:37: DEBUG: proposal.c:892:print_proppair0():  0x80a83b0: next=0x0 tnext=0x0
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:1248:get_proppair(): proposal #0: 1 transform
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:322:get_ph1approvalx(): prop#=0, prot-id=ISAKMP, spi-size=0, #trns=1
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:327:get_ph1approvalx(): trns#=0, trns-id=IKE
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:491:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:491:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:491:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:491:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:491:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:491:t2isakmpsa(): type=Life Duration, flag=0x8000, lorv=10800
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:338:get_ph1approvalx(): Compared: DB:Peer
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): (lifetime = 28800:10800)
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:341:get_ph1approvalx(): (lifebyte = 0:0)
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:343:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:348:get_ph1approvalx(): (encklen = 0:0)
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:350:get_ph1approvalx(): hashtype = SHA:SHA
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:355:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:360:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group
2003-09-30 12:39:37: DEBUG: ipsec_doi.c:248:get_ph1approval(): an acceptable proposal found.
2003-09-30 12:39:37: DEBUG: algorithm.c:610:alg_oakley_dhdef(): hmac(modp1024)
2003-09-30 12:39:37: DEBUG: isakmp.c:1996:isakmp_newcookie(): new cookie:
7afb98eabea359c8 
2003-09-30 12:39:37: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 48, next type 13
2003-09-30 12:39:37: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 16, next type 0
2003-09-30 12:39:37: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:37: DEBUG: sockmisc.c:421:sendfromto(): sockname 63.202.92.133[500]
2003-09-30 12:39:37: DEBUG: sockmisc.c:423:sendfromto(): send packet from 63.202.92.133[500]
2003-09-30 12:39:37: DEBUG: sockmisc.c:425:sendfromto(): send packet to 64.94.50.108[500]
2003-09-30 12:39:37: DEBUG: sockmisc.c:570:sendfromto(): 1 times of 100 bytes message will be sent to 63.202.92.133[500]
2003-09-30 12:39:37: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 01100200 00000000 00000064 0d000034
00000001 00000001 00000028 00010001 00000020 00010000 80010005 80020002
80030001 80040002 800b0001 800c2a30 00000014 7003cbc1 097dbe9c 2600ba69
83bc8b35
2003-09-30 12:39:37: DEBUG: isakmp.c:1449:isakmp_ph1resend(): resend phase1 packet 18e051f94121f0a5:7afb98eabea359c8
2003-09-30 12:39:37: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:39:37: DEBUG: isakmp.c:222:isakmp_handler(): 180 bytes message received from 64.94.50.108[500]
2003-09-30 12:39:37: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 04100200 00000000 000000b4 0a000084
82961813 b620cbe2 4885f100 d37acba1 63469e59 44e299a6 d78c9ccd 2836e8cf
bba5a578 2b915833 462beb28 d8cb1788 c0a45aba 1f439a2c 1cacec01 2f9f04e7
7182ad64 b8cda954 244621be ee8d47d2 51aadab6 f51fec5f d57c0d0c fa9d1efd
0d6a4cbf 5421706d 62431bf0 412499a5 ce48fd88 ccf43e04 b4df4d01 6bc35c94
00000014 6d372331 49dadb89 b6d1fe64 e249f046
2003-09-30 12:39:37: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:37: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=4(ke)
2003-09-30 12:39:37: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=10(nonce)
2003-09-30 12:39:37: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:37: DEBUG: isakmp.c:622:ph1_main(): ===
2003-09-30 12:39:38: DEBUG: oakley.c:256:oakley_dh_generate(): compute DH's private.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
69dc784c af1c3f14 0107e9af 9b48dcd4 912a5e54 7c793b36 5da70fbc a719348b
4115c3d4 5bf7e2fe 8237d15e 3bbe68ce a85bb3e3 029fbee2 04d6574f 44d9ee1e
ab82c39c 357d1387 b726bd39 5ffe1c77 1678b11d 517622f1 4c02d4ac 334791c1
05657770 d45e0924 762f0339 687f015c 57050d93 14197534 ba62c5ae 637914e2
2003-09-30 12:39:38: DEBUG: oakley.c:258:oakley_dh_generate(): compute DH's public.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
eacd735b 6f950657 aeb13f97 01491c6a 1922b69c 38bdcd61 ae039bee 28a3d62f
c03d5075 d1b2d001 4d28d2ca 9760135d 543bc697 1d888481 6336bbc5 c3492638
846d89fe bbb28a74 80618428 b8322025 a052c98d 8fb184f0 f2c5f641 9e7b7f22
e84ddaad b41dff60 7d82c67b e833eeee 99064e19 0d130e43 0136a1c7 08c12197
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 128, next type 10
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 16, next type 13
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 16, next type 0
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: sockmisc.c:421:sendfromto(): sockname 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:423:sendfromto(): send packet from 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:425:sendfromto(): send packet to 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:570:sendfromto(): 1 times of 200 bytes message will be sent to 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 04100200 00000000 000000c8 0a000084
eacd735b 6f950657 aeb13f97 01491c6a 1922b69c 38bdcd61 ae039bee 28a3d62f
c03d5075 d1b2d001 4d28d2ca 9760135d 543bc697 1d888481 6336bbc5 c3492638
846d89fe bbb28a74 80618428 b8322025 a052c98d 8fb184f0 f2c5f641 9e7b7f22
e84ddaad b41dff60 7d82c67b e833eeee 99064e19 0d130e43 0136a1c7 08c12197
0d000014 e0db430e b9146597 44cc6f7a 5382502f 00000014 7003cbc1 097dbe9c
2600ba69 83bc8b35
2003-09-30 12:39:38: DEBUG: isakmp.c:1449:isakmp_ph1resend(): resend phase1 packet 18e051f94121f0a5:7afb98eabea359c8
2003-09-30 12:39:38: DEBUG: oakley.c:210:oakley_dh_compute(): compute DH's shared.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
dc46a727 d3528746 b2e523f4 b395d490 41a6bce4 94b8ab89 e9400122 8044040e
c8d1acc7 b0725a8c 2f6b8eca 8dfa8e74 52a12a00 9397eddd c6eeede9 1892111a
f92d85c5 88f2095c 0dd358a7 96c6ed0e c7d9f624 4911f4da 1ffe4064 0bbaa5ff
72675fe2 e7b48b2a 6441e080 c1d5c021 7607b922 df620aab 4b10dcde 8ab001db
2003-09-30 12:39:38: DEBUG: oakley.c:2063:oakley_skeyid(): the psk found.
2003-09-30 12:39:38: DEBUG2: oakley.c:2065:oakley_skeyid(): psk: 2003-09-30 12:39:38: DEBUG2: plog.c:193:plogdump(): 
6d656b6d 69746173 6469676f 6174
2003-09-30 12:39:38: DEBUG: oakley.c:2078:oakley_skeyid(): nonce 1: 2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
6d372331 49dadb89 b6d1fe64 e249f046
2003-09-30 12:39:38: DEBUG: oakley.c:2084:oakley_skeyid(): nonce 2: 2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
e0db430e b9146597 44cc6f7a 5382502f
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2137:oakley_skeyid(): SKEYID computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
123ea36d bd7dbdcb c926557b 8367f6cc 9a566c50
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2194:oakley_skeyid_dae(): SKEYID_d computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
6d3d20db f804d48c faf26e78 4290570f 50176d83
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2223:oakley_skeyid_dae(): SKEYID_a computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
29c79102 b8cf1b17 14e70514 f0f54b60 121d6dc9
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2252:oakley_skeyid_dae(): SKEYID_e computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
b523acfd 9af262ed 5d1d4349 f5982cae 6eb125ef
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2321:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...)
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2346:oakley_compute_enckey(): compute intermediate encryption key K1
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
00
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:2346:oakley_compute_enckey(): compute intermediate encryption key K2
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9baadf15 25b85ed3 e9c69aa4 0848ea2a e75fbeb4
2003-09-30 12:39:38: DEBUG: oakley.c:2394:oakley_compute_enckey(): final encryption key computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2505:oakley_newiv(): IV computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
8e55734c 57993ae2
2003-09-30 12:39:38: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:39:38: DEBUG: isakmp.c:222:isakmp_handler(): 76 bytes message received from 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 05100201 00000000 0000004c ac1b2916
ab9f94ce 4708dd72 d25ac0df b7fc066d 481a0060 8a0c5531 8d19afb2 d89cb203
6f4fef88 340ccba3 5d7b19c0
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: oakley.c:2625:oakley_do_decrypt(): begin decryption.
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2639:oakley_do_decrypt(): IV was saved for next processing:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
340ccba3 5d7b19c0
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2664:oakley_do_decrypt(): with key:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: oakley.c:2672:oakley_do_decrypt(): decrypted payload by IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
340ccba3 5d7b19c0
2003-09-30 12:39:38: DEBUG: oakley.c:2675:oakley_do_decrypt(): decrypted payload, but not trimed.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
0800000c 011101f4 405e326c 0b000018 1db0543f d8b82548 4d158e7d 19fac42c
d47dbe46 0000000c 00000001 01006002
2003-09-30 12:39:38: DEBUG: oakley.c:2684:oakley_do_decrypt(): padding len=3
2003-09-30 12:39:38: DEBUG: oakley.c:2698:oakley_do_decrypt(): skip to trim padding.
2003-09-30 12:39:38: DEBUG: oakley.c:2713:oakley_do_decrypt(): decrypted.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 05100201 00000000 0000004c 0800000c
011101f4 405e326c 0b000018 1db0543f d8b82548 4d158e7d 19fac42c d47dbe46
0000000c 00000001 01006002
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=5(id)
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=8(hash)
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=11(notify)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: isakmp_inf.c:1264:isakmp_check_notify(): Notify Message received
2003-09-30 12:39:38: WARNING: isakmp_inf.c:1281:isakmp_check_notify(): ignore INITIAL-CONTACT notification, because it is only accepted after phase1.
2003-09-30 12:39:38: DEBUG: oakley.c:1162:oakley_validate_auth(): HASH received:2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
1db0543f d8b82548 4d158e7d 19fac42c d47dbe46
2003-09-30 12:39:38: DEBUG: oakley.c:867:oakley_ph1hash_common(): HASH with:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
82961813 b620cbe2 4885f100 d37acba1 63469e59 44e299a6 d78c9ccd 2836e8cf
bba5a578 2b915833 462beb28 d8cb1788 c0a45aba 1f439a2c 1cacec01 2f9f04e7
7182ad64 b8cda954 244621be ee8d47d2 51aadab6 f51fec5f d57c0d0c fa9d1efd
0d6a4cbf 5421706d 62431bf0 412499a5 ce48fd88 ccf43e04 b4df4d01 6bc35c94
eacd735b 6f950657 aeb13f97 01491c6a 1922b69c 38bdcd61 ae039bee 28a3d62f
c03d5075 d1b2d001 4d28d2ca 9760135d 543bc697 1d888481 6336bbc5 c3492638
846d89fe bbb28a74 80618428 b8322025 a052c98d 8fb184f0 f2c5f641 9e7b7f22
e84ddaad b41dff60 7d82c67b e833eeee 99064e19 0d130e43 0136a1c7 08c12197
18e051f9 4121f0a5 7afb98ea bea359c8 00000001 00000001 00000028 00010001
00000020 00010000 80010005 80020002 80030001 80040002 800b0001 800c2a30
011101f4 405e326c
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:877:oakley_ph1hash_common(): HASH computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
1db0543f d8b82548 4d158e7d 19fac42c d47dbe46
2003-09-30 12:39:38: DEBUG: oakley.c:1193:oakley_validate_auth(): HASH for PSK validated.
2003-09-30 12:39:38: DEBUG: isakmp_ident.c:1250:ident_r3recv(): peer's ID
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
011101f4 405e326c
2003-09-30 12:39:38: DEBUG: isakmp.c:622:ph1_main(): ===
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:3185:ipsecdoi_setid1(): use ID type of IPv4_address
2003-09-30 12:39:38: DEBUG: isakmp_ident.c:1327:ident_r3send(): generate HASH_R
2003-09-30 12:39:38: DEBUG: oakley.c:867:oakley_ph1hash_common(): HASH with:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
eacd735b 6f950657 aeb13f97 01491c6a 1922b69c 38bdcd61 ae039bee 28a3d62f
c03d5075 d1b2d001 4d28d2ca 9760135d 543bc697 1d888481 6336bbc5 c3492638
846d89fe bbb28a74 80618428 b8322025 a052c98d 8fb184f0 f2c5f641 9e7b7f22
e84ddaad b41dff60 7d82c67b e833eeee 99064e19 0d130e43 0136a1c7 08c12197
82961813 b620cbe2 4885f100 d37acba1 63469e59 44e299a6 d78c9ccd 2836e8cf
bba5a578 2b915833 462beb28 d8cb1788 c0a45aba 1f439a2c 1cacec01 2f9f04e7
7182ad64 b8cda954 244621be ee8d47d2 51aadab6 f51fec5f d57c0d0c fa9d1efd
0d6a4cbf 5421706d 62431bf0 412499a5 ce48fd88 ccf43e04 b4df4d01 6bc35c94
7afb98ea bea359c8 18e051f9 4121f0a5 00000001 00000001 00000028 00010001
00000020 00010000 80010005 80020002 80030001 80040002 800b0001 800c2a30
011101f4 3fca5c85
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:877:oakley_ph1hash_common(): HASH computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
369ec84d 0ca7bed0 60d78067 1f2e5706 a7d67670
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 8, next type 8
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 20, next type 0
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: oakley.c:2748:oakley_do_encrypt(): begin encryption.
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2764:oakley_do_encrypt(): pad length = 4
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
0800000c 011101f4 3fca5c85 00000018 369ec84d 0ca7bed0 60d78067 1f2e5706
a7d67670 96c8bf03
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2799:oakley_do_encrypt(): with key:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: oakley.c:2807:oakley_do_encrypt(): encrypted payload by IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9133be7f 4e430f94
2003-09-30 12:39:38: DEBUG: oakley.c:2814:oakley_do_encrypt(): save IV for next:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9133be7f 4e430f94
2003-09-30 12:39:38: DEBUG: oakley.c:2831:oakley_do_encrypt(): encrypted.
2003-09-30 12:39:38: DEBUG: sockmisc.c:421:sendfromto(): sockname 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:423:sendfromto(): send packet from 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:425:sendfromto(): send packet to 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:570:sendfromto(): 1 times of 68 bytes message will be sent to 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 05100201 00000000 00000044 4b834ad9
72ee29c9 41252305 b5a5ebe7 ae2ce1b2 551bed94 985924fb caa48df5 9133be7f
4e430f94
2003-09-30 12:39:38: DEBUG: oakley.c:2549:oakley_newiv2(): compute IV for phase2
2003-09-30 12:39:38: DEBUG: oakley.c:2550:oakley_newiv2(): phase1 last IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9133be7f 4e430f94 78cc9e41
2003-09-30 12:39:38: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2582:oakley_newiv2(): phase2 IV computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
127328a1 a2243272
2003-09-30 12:39:38: DEBUG: oakley.c:748:oakley_compute_hash1(): HASH with:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
78cc9e41 0000001c 00000001 01106002 18e051f9 4121f0a5 7afb98ea bea359c8
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:758:oakley_compute_hash1(): HASH computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
54d86193 2696989b 08726e3c 285cc9f9 2842f223
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: oakley.c:2748:oakley_do_encrypt(): begin encryption.
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2764:oakley_do_encrypt(): pad length = 4
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
0b000018 54d86193 2696989b 08726e3c 285cc9f9 2842f223 0000001c 00000001
01106002 18e051f9 4121f0a5 7afb98ea bea359c8 6cfe3803
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2799:oakley_do_encrypt(): with key:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: oakley.c:2807:oakley_do_encrypt(): encrypted payload by IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
0b6c2f14 ffa847bb
2003-09-30 12:39:38: DEBUG: oakley.c:2814:oakley_do_encrypt(): save IV for next:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
0b6c2f14 ffa847bb
2003-09-30 12:39:38: DEBUG: oakley.c:2831:oakley_do_encrypt(): encrypted.
2003-09-30 12:39:38: DEBUG: sockmisc.c:421:sendfromto(): sockname 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:423:sendfromto(): send packet from 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:425:sendfromto(): send packet to 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:570:sendfromto(): 1 times of 84 bytes message will be sent to 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08100501 78cc9e41 00000054 e12132a4
7c0a7e55 f6dd284b 5683f280 8e4c3417 ec7d8a18 66c0121e 93c63604 e6bd181a
75b3d1dc 68b610c9 f4f18472 0b6c2f14 ffa847bb
2003-09-30 12:39:38: DEBUG: isakmp_inf.c:634:isakmp_info_send_common(): sendto Information notify.
2003-09-30 12:39:38: INFO: isakmp.c:2412:log_ph1established(): ISAKMP-SA established 63.202.92.133[500]-64.94.50.108[500] spi:18e051f94121f0a5:7afb98eabea359c8
2003-09-30 12:39:38: DEBUG: isakmp.c:669:ph1_main(): ===
2003-09-30 12:39:38: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:39:38: DEBUG: isakmp.c:222:isakmp_handler(): 148 bytes message received from 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08102001 5ce1bd76 00000094 fec7a84d
cd1fec37 8793e294 27bee8af 276be90b 034ebe7d fe667ec5 caeb2146 092c088e
db74c11f ddf288cb 610448f8 3a2ece3f b401113f 8edae23d 77bffbfc 1780be7d
08853d74 a52062ba 2a96f221 dcbcefee ef77c3fc 5c5ec01c 133bfa2d 0cddba91
18b5bf51 147afa08 1187a9d2 3474ef67 8f955cc9
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: oakley.c:2549:oakley_newiv2(): compute IV for phase2
2003-09-30 12:39:38: DEBUG: oakley.c:2550:oakley_newiv2(): phase1 last IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9133be7f 4e430f94 5ce1bd76
2003-09-30 12:39:38: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2582:oakley_newiv2(): phase2 IV computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
1f092485 e74b95db
2003-09-30 12:39:38: DEBUG: isakmp.c:1044:isakmp_ph2begin_r(): ===
2003-09-30 12:39:38: INFO: isakmp.c:1049:isakmp_ph2begin_r(): respond new phase 2 negotiation: 63.202.92.133[0]<=>64.94.50.108[0]
2003-09-30 12:39:38: DEBUG: oakley.c:2625:oakley_do_decrypt(): begin decryption.
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2639:oakley_do_decrypt(): IV was saved for next processing:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
3474ef67 8f955cc9
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2664:oakley_do_decrypt(): with key:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: oakley.c:2672:oakley_do_decrypt(): decrypted payload by IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
3474ef67 8f955cc9
2003-09-30 12:39:38: DEBUG: oakley.c:2675:oakley_do_decrypt(): decrypted payload, but not trimed.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
01000018 211774b8 bbd66993 d176ca79 1cbd77f4 7ef34d54 0a000030 00000001
00000001 00000024 01030401 2c28c6fe 00000018 01030000 80050002 80010001
80027080 80040001 05000014 189133f9 6da35eb8 987f8610 11ef3993 0500000c
01000000 ac1e1601 0000000c 01000000 0a080807 00000000
2003-09-30 12:39:38: DEBUG: oakley.c:2684:oakley_do_decrypt(): padding len=1
2003-09-30 12:39:38: DEBUG: oakley.c:2698:oakley_do_decrypt(): skip to trim padding.
2003-09-30 12:39:38: DEBUG: oakley.c:2713:oakley_do_decrypt(): decrypted.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08102001 5ce1bd76 00000094 01000018
211774b8 bbd66993 d176ca79 1cbd77f4 7ef34d54 0a000030 00000001 00000001
00000024 01030401 2c28c6fe 00000018 01030000 80050002 80010001 80027080
80040001 05000014 189133f9 6da35eb8 987f8610 11ef3993 0500000c 01000000
ac1e1601 0000000c 01000000 0a080807 00000000
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=8(hash)
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=1(sa)
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=10(nonce)
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=5(id)
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=5(id)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1006:quick_r1recv(): received IDci2:2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
01000000 ac1e1601
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1010:quick_r1recv(): received IDcr2:2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
01000000 0a080807
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1025:quick_r1recv(): HASH(1) validate:2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
211774b8 bbd66993 d176ca79 1cbd77f4 7ef34d54
2003-09-30 12:39:38: DEBUG: oakley.c:748:oakley_compute_hash1(): HASH with:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
5ce1bd76 0a000030 00000001 00000001 00000024 01030401 2c28c6fe 00000018
01030000 80050002 80010001 80027080 80040001 05000014 189133f9 6da35eb8
987f8610 11ef3993 0500000c 01000000 ac1e1601 0000000c 01000000 0a080807
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:758:oakley_compute_hash1(): HASH computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
211774b8 bbd66993 d176ca79 1cbd77f4 7ef34d54
2003-09-30 12:39:38: DEBUG: sainfo.c:100:getsainfo(): anonymous sainfo selected.
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1817:get_sainfo_r(): get sa info: anonymous
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1995:get_proposal_r(): get a src address from ID payload 172.30.22.1[0] prefixlen=32 ul_proto=255
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:2000:get_proposal_r(): get dst address from ID payload 10.8.8.7[0] prefixlen=32 ul_proto=255
2003-09-30 12:39:38: DEBUG: policy.c:216:cmpspidxwild(): sub:0xbfbfd32c: 172.30.22.1/32[0] 10.8.8.7/32[0] proto=any dir=in
2003-09-30 12:39:38: DEBUG: policy.c:217:cmpspidxwild(): db: 0x80a2c08: 172.30.22.1/32[0] 10.8.8.7/32[0] proto=any dir=in
2003-09-30 12:39:38: DEBUG: policy.c:244:cmpspidxwild(): 0xbfbfd32c masked with /32: 172.30.22.1[0]
2003-09-30 12:39:38: DEBUG: policy.c:246:cmpspidxwild(): 0x80a2c08 masked with /32: 172.30.22.1[0]
2003-09-30 12:39:38: DEBUG: policy.c:260:cmpspidxwild(): 0xbfbfd32c masked with /32: 10.8.8.7[0]
2003-09-30 12:39:38: DEBUG: policy.c:262:cmpspidxwild(): 0x80a2c08 masked with /32: 10.8.8.7[0]
2003-09-30 12:39:38: DEBUG: policy.c:216:cmpspidxwild(): sub:0xbfbfd32c: 10.8.8.7/32[0] 172.30.22.1/32[0] proto=any dir=out
2003-09-30 12:39:38: DEBUG: policy.c:217:cmpspidxwild(): db: 0x80a2c08: 172.30.22.1/32[0] 10.8.8.7/32[0] proto=any dir=in
2003-09-30 12:39:38: DEBUG: policy.c:216:cmpspidxwild(): sub:0xbfbfd32c: 10.8.8.7/32[0] 172.30.22.1/32[0] proto=any dir=out
2003-09-30 12:39:38: DEBUG: policy.c:217:cmpspidxwild(): db: 0x80ae008: 10.8.8.7/32[0] 172.30.22.1/32[0] proto=any dir=out
2003-09-30 12:39:38: DEBUG: policy.c:244:cmpspidxwild(): 0xbfbfd32c masked with /32: 10.8.8.7[0]
2003-09-30 12:39:38: DEBUG: policy.c:246:cmpspidxwild(): 0x80ae008 masked with /32: 10.8.8.7[0]
2003-09-30 12:39:38: DEBUG: policy.c:260:cmpspidxwild(): 0xbfbfd32c masked with /32: 172.30.22.1[0]
2003-09-30 12:39:38: DEBUG: policy.c:262:cmpspidxwild(): 0x80ae008 masked with /32: 172.30.22.1[0]
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:2056:get_proposal_r(): suitable SP found:10.8.8.7/32[0] 172.30.22.1/32[0] proto=any dir=out
2003-09-30 12:39:38: DEBUG: proposal.c:825:printsaproto():  (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0)
2003-09-30 12:39:38: DEBUG: proposal.c:859:printsatrns():   (trns_id=3DES encklen=0 authtype=2)
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1117:get_proppair(): total SA len=44
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
00000001 00000001 00000024 01030401 2c28c6fe 00000018 01030000 80050002
80010001 80027080 80040001
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=2(prop)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1170:get_proppair(): proposal #1 len=36
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=3(trns)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1311:get_transform(): transform #1 len=24
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=SA Life Duration, flag=0x8000, lorv=28800
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2155:check_attr_ipsec(): life duration was in TLV.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1213:get_proppair(): pair 1:
2003-09-30 12:39:38: DEBUG: proposal.c:892:print_proppair0():  0x80a8780: next=0x0 tnext=0x0
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1248:get_proppair(): proposal #1: 1 transform
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:948:get_ph2approval(): begin compare proposals.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:954:get_ph2approval(): pair[1]: 0x80a8780
2003-09-30 12:39:38: DEBUG: proposal.c:892:print_proppair0():  0x80a8780: next=0x0 tnext=0x0
2003-09-30 12:39:38: DEBUG: proposal.c:681:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:3643:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:3643:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:3643:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x8000, lorv=28800
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:3643:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:990:get_ph2approvalx(): peer's single bundle:
2003-09-30 12:39:38: DEBUG: proposal.c:825:printsaproto():  (proto_id=ESP spisize=4 spi=2c28c6fe spi_p=00000000 encmode=Tunnel reqid=0:0)
2003-09-30 12:39:38: DEBUG: proposal.c:859:printsatrns():   (trns_id=3DES encklen=0 authtype=2)
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:993:get_ph2approvalx(): my single bundle:
2003-09-30 12:39:38: DEBUG: proposal.c:825:printsaproto():  (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0)
2003-09-30 12:39:38: DEBUG: proposal.c:859:printsatrns():   (trns_id=3DES encklen=0 authtype=2)
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1012:get_ph2approvalx(): matched
2003-09-30 12:39:38: DEBUG: isakmp.c:1078:isakmp_ph2begin_r(): ===
2003-09-30 12:39:38: DEBUG: pfkey.c:792:pk_sendgetspi(): call pfkey_send_getspi
2003-09-30 12:39:38: DEBUG: pfkey.c:805:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 64.94.50.108->63.202.92.133 
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1143:quick_r1prep(): pfkey getspi sent.
2003-09-30 12:39:38: DEBUG: pfkey.c:195:pfkey_handler(): get pfkey GETSPI message
2003-09-30 12:39:38: DEBUG2: plog.c:193:plogdump(): 
02010003 0a000000 5e9aabb1 df510000 02000100 0af88df9 00000000 00000000
03000500 ff200000 10020000 405e326c 00000000 00000000 03000600 ff200000
10020000 3fca5c85 00000000 00000000
2003-09-30 12:39:38: DEBUG: pfkey.c:876:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 64.94.50.108->63.202.92.133 spi=184061433(0xaf88df9)
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1117:get_proppair(): total SA len=44
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
00000001 00000001 00000024 01030401 00000000 00000018 01030000 80050002
80010001 80027080 80040001
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=2(prop)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1170:get_proppair(): proposal #1 len=36
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=3(trns)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1311:get_transform(): transform #1 len=24
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=SA Life Duration, flag=0x8000, lorv=28800
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2155:check_attr_ipsec(): life duration was in TLV.
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:2067:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1213:get_proppair(): pair 1:
2003-09-30 12:39:38: DEBUG: proposal.c:892:print_proppair0():  0x80a86b0: next=0x0 tnext=0x0
2003-09-30 12:39:38: DEBUG: ipsec_doi.c:1248:get_proppair(): proposal #1: 1 transform
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 44, next type 10
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 16, next type 5
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 8, next type 5
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 8, next type 0
2003-09-30 12:39:38: DEBUG: oakley.c:748:oakley_compute_hash1(): HASH with:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
5ce1bd76 189133f9 6da35eb8 987f8610 11ef3993 0a000030 00000001 00000001
00000024 01030401 0af88df9 00000018 01030000 80050002 80010001 80027080
80040001 05000014 8bc0f553 c182e9f1 5131732f efd8b6cb 0500000c 01000000
ac1e1601 0000000c 01000000 0a080807
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:758:oakley_compute_hash1(): HASH computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
547e0ee6 4fe46a04 a7d6d6e3 1b358d47 f49e82f7
2003-09-30 12:39:38: DEBUG: isakmp.c:2113:set_isakmp_payload(): add payload of len 20, next type 1
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: oakley.c:2748:oakley_do_encrypt(): begin encryption.
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2764:oakley_do_encrypt(): pad length = 4
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
01000018 547e0ee6 4fe46a04 a7d6d6e3 1b358d47 f49e82f7 0a000030 00000001
00000001 00000024 01030401 0af88df9 00000018 01030000 80050002 80010001
80027080 80040001 05000014 8bc0f553 c182e9f1 5131732f efd8b6cb 0500000c
01000000 ac1e1601 0000000c 01000000 0a080807 c3525203
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2799:oakley_do_encrypt(): with key:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: oakley.c:2807:oakley_do_encrypt(): encrypted payload by IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
f231b885 6ff7fa23
2003-09-30 12:39:38: DEBUG: oakley.c:2814:oakley_do_encrypt(): save IV for next:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
f231b885 6ff7fa23
2003-09-30 12:39:38: DEBUG: oakley.c:2831:oakley_do_encrypt(): encrypted.
2003-09-30 12:39:38: DEBUG: sockmisc.c:421:sendfromto(): sockname 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:423:sendfromto(): send packet from 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:425:sendfromto(): send packet to 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: sockmisc.c:570:sendfromto(): 1 times of 148 bytes message will be sent to 63.202.92.133[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08102001 5ce1bd76 00000094 45ec9183
9246fc8d a1ce799d 3ef4d021 94446ecc bcbc40a9 6e6c05f9 6d30dac5 f7a56866
2eaf917f cb8fa8af 9c0b5e99 4aecb165 7dd2feec 7b30ac1a 9799e770 20a98f77
3462f286 a1698cb7 b136a8b4 13f33e0d 2f97925f 14931e6f 113a9416 5ee1505f
06fedf89 b21d1e57 cb050863 f231b885 6ff7fa23
2003-09-30 12:39:38: DEBUG: isakmp.c:1487:isakmp_ph2resend(): resend phase2 packet 18e051f94121f0a5:7afb98eabea359c8:00005ce1
2003-09-30 12:39:38: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:39:38: DEBUG: isakmp.c:222:isakmp_handler(): 52 bytes message received from 64.94.50.108[500]
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08102001 5ce1bd76 00000034 412a67f6
ebf3b79b 0c466f2c b1e0826b 29c8f270 dfccb4ff
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: oakley.c:2625:oakley_do_decrypt(): begin decryption.
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2639:oakley_do_decrypt(): IV was saved for next processing:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
29c8f270 dfccb4ff
2003-09-30 12:39:38: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: oakley.c:2664:oakley_do_decrypt(): with key:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:39:38: DEBUG: oakley.c:2672:oakley_do_decrypt(): decrypted payload by IV:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
29c8f270 dfccb4ff
2003-09-30 12:39:38: DEBUG: oakley.c:2675:oakley_do_decrypt(): decrypted payload, but not trimed.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
00000018 46bccca1 48db049c 0e0af9d1 84bb6320 f8864c38
2003-09-30 12:39:38: DEBUG: oakley.c:2684:oakley_do_decrypt(): padding len=57
2003-09-30 12:39:38: DEBUG: oakley.c:2698:oakley_do_decrypt(): skip to trim padding.
2003-09-30 12:39:38: DEBUG: oakley.c:2713:oakley_do_decrypt(): decrypted.
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08102001 5ce1bd76 00000034 00000018
46bccca1 48db049c 0e0af9d1 84bb6320 f8864c38
2003-09-30 12:39:38: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:39:38: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=8(hash)
2003-09-30 12:39:38: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1430:quick_r3recv(): HASH(3) validate:2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
46bccca1 48db049c 0e0af9d1 84bb6320 f8864c38
2003-09-30 12:39:38: DEBUG: oakley.c:692:oakley_compute_hash3(): HASH with: 
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
005ce1bd 76189133 f96da35e b8987f86 1011ef39 938bc0f5 53c182e9 f1513173
2fefd8b6 cb
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:702:oakley_compute_hash3(): HASH computed:
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
46bccca1 48db049c 0e0af9d1 84bb6320 f8864c38
2003-09-30 12:39:38: DEBUG: isakmp.c:736:quick_main(): ===
2003-09-30 12:39:38: DEBUG: oakley.c:464:oakley_compute_keymat_x(): KEYMAT compute with
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
030af88d f9189133 f96da35e b8987f86 1011ef39 938bc0f5 53c182e9 f1513173
2fefd8b6 cb
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:509:alg_ipsec_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: algorithm.c:552:alg_ipsec_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:497:oakley_compute_keymat_x(): encklen=192 authklen=160
2003-09-30 12:39:38: DEBUG: oakley.c:504:oakley_compute_keymat_x(): generating 640 bits of key (dupkeymat=4)
2003-09-30 12:39:38: DEBUG: oakley.c:522:oakley_compute_keymat_x(): generating K1...K4 for KEYMAT.
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
db7d64eb 9ee4ab4b ebaf25d9 bc1a0450 7a6b8b81 11677158 f741a03d 78d8249b
d92834d7 7791f303 bba6f091 7be12ae3 81d07e11 aee65b63 645a2429 a41bd01c
26346c03 e961cfec dbae5577 ab988376
2003-09-30 12:39:38: DEBUG: oakley.c:464:oakley_compute_keymat_x(): KEYMAT compute with
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
032c28c6 fe189133 f96da35e b8987f86 1011ef39 938bc0f5 53c182e9 f1513173
2fefd8b6 cb
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:509:alg_ipsec_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: algorithm.c:552:alg_ipsec_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: oakley.c:497:oakley_compute_keymat_x(): encklen=192 authklen=160
2003-09-30 12:39:38: DEBUG: oakley.c:504:oakley_compute_keymat_x(): generating 640 bits of key (dupkeymat=4)
2003-09-30 12:39:38: DEBUG: oakley.c:522:oakley_compute_keymat_x(): generating K1...K4 for KEYMAT.
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: algorithm.c:322:alg_oakley_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: plog.c:193:plogdump(): 
63dd8df5 2272acf4 73f0106e 4cbcc3e0 2eabe569 08d1011a 7a8e4820 9cdfb203
d6d2c1f0 e1471569 3a79cbce c063d6db cbb2b889 67df64cd 33a1dd13 597a56fb
adb021df cac1b5bd 5bea2361 de6d8fcf
2003-09-30 12:39:38: DEBUG: oakley.c:392:oakley_compute_keymat(): KEYMAT computed.
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1613:quick_r3prep(): call pk_sendupdate
2003-09-30 12:39:38: DEBUG: algorithm.c:509:alg_ipsec_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: algorithm.c:552:alg_ipsec_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: pfkey.c:974:pk_sendupdate(): call pfkey_send_update
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1618:quick_r3prep(): pfkey update sent.
2003-09-30 12:39:38: DEBUG: algorithm.c:509:alg_ipsec_encdef(): encription(3des)
2003-09-30 12:39:38: DEBUG: algorithm.c:552:alg_ipsec_hmacdef(): hmac(hmac_sha1)
2003-09-30 12:39:38: DEBUG: pfkey.c:1215:pk_sendadd(): call pfkey_send_add
2003-09-30 12:39:38: DEBUG: isakmp_quick.c:1625:quick_r3prep(): pfkey add sent.
2003-09-30 12:39:38: DEBUG: pfkey.c:195:pfkey_handler(): get pfkey UPDATE message
2003-09-30 12:39:38: DEBUG2: plog.c:193:plogdump(): 
02020003 14000000 5e9aabb1 df510000 02000100 0af88df9 04000303 00000000
02001300 02000000 00000000 00000000 03000500 ff200000 10020000 405e326c
00000000 00000000 03000600 ff200000 10020000 3fca5c85 00000000 00000000
04000300 00000000 00000000 00000000 80700000 00000000 00000000 00000000
04000400 00000000 00000000 00000000 005a0000 00000000 00000000 00000000
2003-09-30 12:39:38: DEBUG: pfkey.c:1103:pk_recvupdate(): pfkey UPDATE succeeded: ESP/Tunnel 64.94.50.108->63.202.92.133 spi=184061433(0xaf88df9)
2003-09-30 12:39:38: INFO: pfkey.c:1110:pk_recvupdate(): IPsec-SA established: ESP/Tunnel 64.94.50.108->63.202.92.133 spi=184061433(0xaf88df9)
2003-09-30 12:39:38: DEBUG: pfkey.c:1148:pk_recvupdate(): ===
2003-09-30 12:39:38: DEBUG: pfkey.c:195:pfkey_handler(): get pfkey ADD message
2003-09-30 12:39:38: DEBUG2: plog.c:193:plogdump(): 
02030003 14000000 5e9aabb1 df510000 02000100 2c28c6fe 04000303 00000000
02001300 02000000 00000000 00000000 03000500 ff200000 10020000 3fca5c85
00000000 00000000 03000600 ff200000 10020000 405e326c 00000000 00000000
04000300 00000000 00000000 00000000 80700000 00000000 00000000 00000000
04000400 00000000 00000000 00000000 005a0000 00000000 00000000 00000000
2003-09-30 12:39:38: INFO: pfkey.c:1322:pk_recvadd(): IPsec-SA established: ESP/Tunnel 63.202.92.133->64.94.50.108 spi=740869886(0x2c28c6fe)
2003-09-30 12:39:38: DEBUG: pfkey.c:1327:pk_recvadd(): ===
2003-09-30 12:39:38: DEBUG: grabmyaddr.c:438:update_myaddrs(): msg 1 not interesting
2003-09-30 12:44:31: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:44:31: DEBUG: isakmp.c:222:isakmp_handler(): 68 bytes message received from 64.94.50.108[500]
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08100501 113c4687 00000044 91a6d90a
91db5f2d 97dca607 528fa590 f67b2c3c 8b5c8e8f 409effe3 a2b962be 3dbdb47a
b0a32836
2003-09-30 12:44:31: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:44:31: DEBUG: isakmp_inf.c:115:isakmp_info_recv(): receive Information.
2003-09-30 12:44:31: DEBUG: oakley.c:2549:oakley_newiv2(): compute IV for phase2
2003-09-30 12:44:31: DEBUG: oakley.c:2550:oakley_newiv2(): phase1 last IV:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
9133be7f 4e430f94 113c4687
2003-09-30 12:44:31: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:44:31: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:44:31: DEBUG: oakley.c:2582:oakley_newiv2(): phase2 IV computed:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
b824a76f 76b6f127
2003-09-30 12:44:31: DEBUG: oakley.c:2625:oakley_do_decrypt(): begin decryption.
2003-09-30 12:44:31: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:44:31: DEBUG: oakley.c:2639:oakley_do_decrypt(): IV was saved for next processing:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
3dbdb47a b0a32836
2003-09-30 12:44:31: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:44:31: DEBUG: oakley.c:2664:oakley_do_decrypt(): with key:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:44:31: DEBUG: oakley.c:2672:oakley_do_decrypt(): decrypted payload by IV:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
3dbdb47a b0a32836
2003-09-30 12:44:31: DEBUG: oakley.c:2675:oakley_do_decrypt(): decrypted payload, but not trimed.
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
0c000018 5fb79951 fe3ae915 7b8d3ba9 841e62c8 0dfdc00c 00000010 00000001
03040001 2c28c6fe
2003-09-30 12:44:31: DEBUG: oakley.c:2684:oakley_do_decrypt(): padding len=255
2003-09-30 12:44:31: DEBUG: oakley.c:2698:oakley_do_decrypt(): skip to trim padding.
2003-09-30 12:44:31: DEBUG: oakley.c:2713:oakley_do_decrypt(): decrypted.
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08100501 113c4687 00000044 0c000018
5fb79951 fe3ae915 7b8d3ba9 841e62c8 0dfdc00c 00000010 00000001 03040001
2c28c6fe
2003-09-30 12:44:31: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:44:31: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:44:31: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=8(hash)
2003-09-30 12:44:31: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=12(delete)
2003-09-30 12:44:31: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:44:31: DEBUG: pfkey.c:271:pfkey_dump_sadb(): call pfkey_send_dump
2003-09-30 12:44:31: DEBUG: isakmp_inf.c:902:purge_ipsec_spi(): check spi(packet)=740869886 spi(db)=740869886.
2003-09-30 12:44:31: DEBUG: schedule.c:210:sched_scrub_param(): an undead schedule has been deleted.
2003-09-30 12:44:31: INFO: isakmp_inf.c:925:purge_ipsec_spi(): purged IPsec-SA proto_id=ESP spi=740869886.
2003-09-30 12:44:31: DEBUG: isakmp_inf.c:1249:isakmp_info_recv_d(): purged SAs.
2003-09-30 12:44:31: DEBUG: isakmp.c:221:isakmp_handler(): ===
2003-09-30 12:44:31: DEBUG: isakmp.c:222:isakmp_handler(): 84 bytes message received from 64.94.50.108[500]
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08100501 a469672b 00000054 76f863fd
f5ecfd56 dc56bd49 16c13138 dc81fbfa f8292792 3198a736 3def59ee e9eb2415
2b3c8eae ddfaf5e8 ee0028fd db6b0ba1 d93ae6e5
2003-09-30 12:44:31: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:44:31: DEBUG: isakmp_inf.c:115:isakmp_info_recv(): receive Information.
2003-09-30 12:44:31: DEBUG: oakley.c:2549:oakley_newiv2(): compute IV for phase2
2003-09-30 12:44:31: DEBUG: oakley.c:2550:oakley_newiv2(): phase1 last IV:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
9133be7f 4e430f94 a469672b
2003-09-30 12:44:31: DEBUG: algorithm.c:252:alg_oakley_hashdef(): hash(sha1)
2003-09-30 12:44:31: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:44:31: DEBUG: oakley.c:2582:oakley_newiv2(): phase2 IV computed:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
fa6304bf 153057e4
2003-09-30 12:44:31: DEBUG: oakley.c:2625:oakley_do_decrypt(): begin decryption.
2003-09-30 12:44:31: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:44:31: DEBUG: oakley.c:2639:oakley_do_decrypt(): IV was saved for next processing:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
db6b0ba1 d93ae6e5
2003-09-30 12:44:31: DEBUG: algorithm.c:382:alg_oakley_encdef(): encription(3des)
2003-09-30 12:44:31: DEBUG: oakley.c:2664:oakley_do_decrypt(): with key:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
9518f1e4 c5f0bfd5 e5091081 f7d0b9cf b6917b4d 9baadf15
2003-09-30 12:44:31: DEBUG: oakley.c:2672:oakley_do_decrypt(): decrypted payload by IV:
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
db6b0ba1 d93ae6e5
2003-09-30 12:44:31: DEBUG: oakley.c:2675:oakley_do_decrypt(): decrypted payload, but not trimed.
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
0c000018 4a7296af 3c07a5e0 985e44b9 ab4bed28 0c2ff581 0000001c 00000001
01100001 18e051f9 4121f0a5 7afb98ea bea359c8 00000000
2003-09-30 12:44:31: DEBUG: oakley.c:2684:oakley_do_decrypt(): padding len=1
2003-09-30 12:44:31: DEBUG: oakley.c:2698:oakley_do_decrypt(): skip to trim padding.
2003-09-30 12:44:31: DEBUG: oakley.c:2713:oakley_do_decrypt(): decrypted.
2003-09-30 12:44:31: DEBUG: plog.c:193:plogdump(): 
18e051f9 4121f0a5 7afb98ea bea359c8 08100501 a469672b 00000054 0c000018
4a7296af 3c07a5e0 985e44b9 ab4bed28 0c2ff581 0000001c 00000001 01100001
18e051f9 4121f0a5 7afb98ea bea359c8 00000000
2003-09-30 12:44:31: DEBUG: isakmp.c:2248:isakmp_printpacket(): begin.
2003-09-30 12:44:31: DEBUG: isakmp.c:1112:isakmp_parsewoh(): begin.
2003-09-30 12:44:31: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=8(hash)
2003-09-30 12:44:31: DEBUG: isakmp.c:1139:isakmp_parsewoh(): seen nptype=12(delete)
2003-09-30 12:44:31: DEBUG: isakmp.c:1178:isakmp_parsewoh(): succeed.
2003-09-30 12:44:31: INFO: isakmp_inf.c:823:purge_isakmp_spi(): purged ISAKMP-SA proto_id=ISAKMP spi=18e051f94121f0a5:7afb98eabea359c8.
2003-09-30 12:44:31: DEBUG: isakmp_inf.c:1249:isakmp_info_recv_d(): purged SAs.
2003-09-30 12:44:31: DEBUG: pfkey.c:195:pfkey_handler(): get pfkey DELETE message
2003-09-30 12:44:31: DEBUG2: plog.c:193:plogdump(): 
02040003 0a000000 00000000 df510000 02000100 2c28c6fe 00000000 00000000
03000500 ff200000 10020000 3fca5c85 00000000 00000000 03000600 ff200000
10020000 405e326c 00000000 00000000
2003-09-30 12:44:31: DEBUG: pfkey.c:1674:pk_recvdelete(): DELETE message is not interesting because the message was originated by me.
2003-09-30 12:44:32: INFO: isakmp.c:1564:isakmp_ph1delete(): ISAKMP-SA deleted 63.202.92.133[500]-64.94.50.108[500] spi:18e051f94121f0a5:7afb98eabea359c8