2002-09-02 22:57:39: INFO: main.c:126:main(): @(#)racoon 20001216 sakane@ydc.co.jp 2002-09-02 22:57:39: INFO: main.c:127:main(): @(#)This product linked software developed by the OpenSSL Project for use in the OpenSSL Toolkit. (http://www.openssl.org/) 2002-09-02 22:57:39: DEBUG: pfkey.c:351:pfkey_init(): call pfkey_send_register 2002-09-02 22:57:39: DEBUG: pfkey.c:360:pfkey_init(): call pfkey_send_register 2002-09-02 22:57:39: DEBUG: pfkey.c:369:pfkey_init(): call pfkey_send_register 2002-09-02 22:57:39: DEBUG2: cftoken.l:119:yylex(): begin <5>path 2002-09-02 22:57:39: DEBUG2: cftoken.l:122:yylex(): <5>2002-09-02 22:57:39: DEBUG2: cftoken.l:457:yylex(): <5>2002-09-02 22:57:39: DEBUG2: cftoken.l:126:yylex(): begin <3>; 2002-09-02 22:57:39: DEBUG2: cftoken.l:119:yylex(): begin <5>path 2002-09-02 22:57:39: DEBUG2: cftoken.l:124:yylex(): <5>2002-09-02 22:57:39: DEBUG2: cftoken.l:457:yylex(): <5>2002-09-02 22:57:39: DEBUG2: cftoken.l:126:yylex(): begin <3>; 2002-09-02 22:57:39: DEBUG2: cftoken.l:156:yylex(): begin <13>listen 2002-09-02 22:57:39: DEBUG2: cftoken.l:158:yylex(): <13>2002-09-02 22:57:39: DEBUG2: cftoken.l:472:yylex(): <13>2002-09-02 22:57:39: DEBUG2: cftoken.l:348:yylex(): <13>2002-09-02 22:57:39: DEBUG2: cftoken.l:160:yylex(): <13>2002-09-02 22:57:39: DEBUG2: cftoken.l:255:yylex(): begin <33>remote 2002-09-02 22:57:39: DEBUG2: cftoken.l:256:yylex(): <33>2002-09-02 22:57:39: DEBUG2: cftoken.l:260:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:263:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:285:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:287:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:274:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:275:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:457:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:457:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:272:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:407:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:457:yylex(): <35>2002-09-02 22:57:39: DEBUG2: cftoken.l:295:yylex(): begin <37>proposal 2002-09-02 22:57:39: DEBUG2: cftoken.l:305:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:368:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:307:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:385:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:306:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:395:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:308:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:391:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:295:yylex(): begin <37>proposal 2002-09-02 22:57:39: DEBUG2: cftoken.l:305:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:368:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:307:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:385:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:306:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:396:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:308:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cftoken.l:391:yylex(): <37>2002-09-02 22:57:39: DEBUG2: cfparse.y:1722:set_isakmp_proposal(): lifetime = 28800 2002-09-02 22:57:39: DEBUG2: cfparse.y:1725:set_isakmp_proposal(): lifebyte = 0 2002-09-02 22:57:39: DEBUG2: cfparse.y:1728:set_isakmp_proposal(): strength=extra high 2002-09-02 22:57:39: DEBUG2: cfparse.y:1730:set_isakmp_proposal(): encklen=0 2002-09-02 22:57:39: DEBUG2: cfparse.y:1912:expand_isakmpspec(): p:1 t:1 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 3DES-CBC(5) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): SHA(2) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 1024-bit MODP group(2) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): pre-shared key(1) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1923:expand_isakmpspec(): 2002-09-02 22:57:39: DEBUG2: cfparse.y:1722:set_isakmp_proposal(): lifetime = 28800 2002-09-02 22:57:39: DEBUG2: cfparse.y:1725:set_isakmp_proposal(): lifebyte = 0 2002-09-02 22:57:39: DEBUG2: cfparse.y:1728:set_isakmp_proposal(): strength=extra high 2002-09-02 22:57:39: DEBUG2: cfparse.y:1730:set_isakmp_proposal(): encklen=0 2002-09-02 22:57:39: DEBUG2: cfparse.y:1912:expand_isakmpspec(): p:1 t:1 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 3DES-CBC(5) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): SHA(2) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 1024-bit MODP group(2) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1916:expand_isakmpspec(): RSA signatures(3) 2002-09-02 22:57:39: DEBUG2: cfparse.y:1923:expand_isakmpspec(): 2002-09-02 22:57:39: DEBUG2: cftoken.l:235:yylex(): begin <29>sainfo 2002-09-02 22:57:39: DEBUG2: cftoken.l:236:yylex(): <29>2002-09-02 22:57:39: DEBUG2: cftoken.l:249:yylex(): <31>2002-09-02 22:57:39: DEBUG2: cftoken.l:368:yylex(): <31>2002-09-02 22:57:39: DEBUG2: cftoken.l:250:yylex(): <31>2002-09-02 22:57:39: DEBUG2: cftoken.l:381:yylex(): <31>2002-09-02 22:57:39: DEBUG2: cftoken.l:251:yylex(): <31>2002-09-02 22:57:39: DEBUG2: cftoken.l:388:yylex(): <31>2002-09-02 22:57:39: WARNING: pfkey.c:1977:pk_checkalg(): compression algorithm can not be checked. 2002-09-02 22:57:39: DEBUG2: cfparse.y:2005:cfparse(): parse successed. 2002-09-02 22:57:39: INFO: isakmp.c:1250:isakmp_open(): 165.227.249.5[500] used as isakmp port (fd=6) 2002-09-02 22:57:39: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey X_SPDDUMP message 2002-09-02 22:57:39: DEBUG: plog.c:204:plogdump(): 02120000 0f000100 01000000 93220000 03000500 ff200000 10020000 0a0017fb 00000000 00000000 03000600 ff200000 10020000 0a080807 00000000 00000000 07001200 02000100 2f000000 00000000 28003200 02020000 10020000 c15ec262 00000000 00000000 10020000 a5e3f905 00000000 00000000 2002-09-02 22:57:39: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey X_SPDDUMP message 2002-09-02 22:57:39: DEBUG: plog.c:204:plogdump(): 02120000 0f000100 00000000 93220000 03000500 ff200000 10020000 0a080807 00000000 00000000 03000600 ff200000 10020000 0a0017fb 00000000 00000000 07001200 02000200 30000000 00000000 28003200 02020000 10020000 a5e3f905 00000000 00000000 10020000 c15ec262 00000000 00000000 2002-09-02 22:57:39: DEBUG: policy.c:181:cmpspidx(): sub:0xbfbfd5c4: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 22:57:39: DEBUG: policy.c:182:cmpspidx(): db :0x809c408: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 22:57:42: DEBUG: grabmyaddr.c:452:update_myaddrs(): caught rtm:15, need update interface address list 2002-09-02 22:57:42: DEBUG: grabmyaddr.c:446:update_myaddrs(): msg 14 not interesting 2002-09-02 22:58:25: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:25: DEBUG: isakmp.c:232:isakmp_handler(): 128 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:25: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 00000000 00000000 01100200 00000000 00000080 0d00003c 00000001 00000001 00000030 00010801 cbbb200a 4f530000 00000020 00010000 80010005 80020002 80030003 80040002 800b0001 800c0744 0d000014 c573b056 d7faca36 c2fba283 74127cbf 00000014 baeb2390 37e17787 d730eed9 d95d48aa2002-09-02 22:58:25: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:25: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 193.94.194.98[500]. 2002-09-02 22:58:25: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2002-09-02 22:58:25: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>193.94.194.98[500] 2002-09-02 22:58:25: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2002-09-02 22:58:25: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:25: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2002-09-02 22:58:25: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2002-09-02 22:58:25: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2002-09-02 22:58:25: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:25: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2002-09-02 22:58:25: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2002-09-02 22:58:25: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2002-09-02 22:58:25: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=56 2002-09-02 22:58:25: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000030 00010801 cbbb200a 4f530000 00000020 00010000 80010005 80020002 80030003 80040002 800b0001 800c0744 2002-09-02 22:58:25: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:25: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2002-09-02 22:58:25: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #0 len=48 2002-09-02 22:58:25: WARNING: ipsec_doi.c:1659:check_spi_size(): SPI size isn't zero, but IKE proposal. 2002-09-02 22:58:25: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:25: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2002-09-02 22:58:25: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1246:get_transform(): transform #0 len=32 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=RSA signatures 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x8000, lorv=1860 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 0: 2002-09-02 22:58:25: DEBUG: proposal.c:866:print_proppair0(): 0x8097370: next=0x0 tnext=0x0 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #0: 1 transform 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=0, prot-id=ISAKMP, spi-size=8, #trns=1 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=0, trns-id=IKE 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=RSA signatures 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x8000, lorv=1860 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:1860) 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:RSA signatures 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:1860) 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = RSA signatures:RSA signatures 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2002-09-02 22:58:25: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2002-09-02 22:58:25: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: 8587abd761244aa9 2002-09-02 22:58:25: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 56, next type 0 2002-09-02 22:58:25: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:25: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2002-09-02 22:58:25: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2002-09-02 22:58:25: DEBUG: sockmisc.c:361:sendfromto(): send packet to 193.94.194.98[500] 2002-09-02 22:58:25: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 88 bytes message will be sent. 2002-09-02 22:58:25: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 01100200 00000000 00000058 0000003c 00000001 00000001 00000030 00010801 00000000 00000000 00000020 00010000 80010005 80020002 80030003 80040002 800b0001 800c0744 2002-09-02 22:58:26: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:26: DEBUG: isakmp.c:232:isakmp_handler(): 128 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 00000000 00000000 01100200 00000000 00000080 0d00003c 00000001 00000001 00000030 00010801 cbbb200a 4f530000 00000020 00010000 80010005 80020002 80030003 80040002 800b0001 800c0744 0d000014 c573b056 d7faca36 c2fba283 74127cbf 00000014 baeb2390 37e17787 d730eed9 d95d48aa2002-09-02 22:58:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:26: DEBUG: isakmp.c:420:isakmp_main(): the packet retransmited by peer. 2002-09-02 22:58:26: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:26: DEBUG: isakmp.c:232:isakmp_handler(): 239 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 04100200 00000000 000000ef 0a000084 ad78724c 5df33ff4 5419bf51 f8e72887 6c28f95b 3931a005 fc0508d0 bd91a2be 83bd8776 69ec3a7a 3190838e 7deb83bb 49ce041a 9b70c044 b9d3a209 503389cf 3a7ebeb6 2687f222 acbd0c5c 15e93d39 455b3aef d6f06263 9b9324ce 8b814096 2159b2d5 52bf0da8 1b2ecec9 718c1ff4 c62d4b55 ddbdfa7d 877c0c8c 5d4aa7bf 07000014 f0e66f0a d51be532 268f5975 f35a3c98 0000003b 04303431 0d300b06 0355040a 13045650 4e433123 30210603 55040b13 1a436f6e 666f726d 616e6365 20746573 74696e67 20726f6f 742031 2002-09-02 22:58:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2002-09-02 22:58:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2002-09-02 22:58:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=7(cr) 2002-09-02 22:58:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:26: WARNING: isakmp_ident.c:900:ident_r2recv(): CR received, ignore it. It should be in other exchange. 2002-09-02 22:58:26: DEBUG: isakmp.c:609:ph1_main(): === 2002-09-02 22:58:26: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 74dfd7be 691b4778 afbf30b1 de021521 e76219d4 b3ca94d1 89fe4d84 7533e5d1 ee9bfcbc 45e467d3 f513ee59 2f63cea6 1df53847 0abb3c9c 91ea4bb5 cc7869e7 de6f9890 106ad679 5b350393 7353d34c bed3fd01 546002a1 ed9a2c87 f96c755b d55bc172 1cea3244 cda7d24c f9450efb 73179672 98ce1a75 6713b9d9 0272efe42002-09-02 22:58:26: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 5caa5317 6e121cb1 f2b5eb29 1d440a17 753bc15c f4cf0ff4 4eebab98 2ff7348e 1aa4c98f fa045817 6c4e8cda af063663 b1dede33 9f1c23e0 6cfb1ae3 202c3676 8be05dae 0473d97e 716421d8 efe877ec 4bbfb2d4 3fa82beb b5ee4921 eb2860ff 734299a5 e11be3fb 8c8c885e e85867a8 b5901b63 e74829c5 2183209f f796e0642002-09-02 22:58:26: DEBUG: oakley.c:1839:oakley_getcr(): create my CR: X.509 Certificate Signature 2002-09-02 22:58:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2002-09-02 22:58:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2002-09-02 22:58:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 7 2002-09-02 22:58:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 1, next type 0 2002-09-02 22:58:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:26: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2002-09-02 22:58:26: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2002-09-02 22:58:26: DEBUG: sockmisc.c:361:sendfromto(): send packet to 193.94.194.98[500] 2002-09-02 22:58:26: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 205 bytes message will be sent. 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 04100200 00000000 000000cd 0a000084 5caa5317 6e121cb1 f2b5eb29 1d440a17 753bc15c f4cf0ff4 4eebab98 2ff7348e 1aa4c98f fa045817 6c4e8cda af063663 b1dede33 9f1c23e0 6cfb1ae3 202c3676 8be05dae 0473d97e 716421d8 efe877ec 4bbfb2d4 3fa82beb b5ee4921 eb2860ff 734299a5 e11be3fb 8c8c885e e85867a8 b5901b63 e74829c5 2183209f f796e064 0d000014 a0a567ba 12996f68 26143e4b aacb3b63 07000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 00000005 04 2002-09-02 22:58:26: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 4aa0dcfb 69d5d9d3 580ff09c f0293149 ed46c021 6f0f1353 a0b007b6 fc56be01 8adc17e9 9c84e1ef 8abf2137 48435522 c206458a 7c32817a ec6a2eac 8cd2b44e 2c690e70 e70d7e75 a55f1e11 38af585c 0fb7b8c5 eb883b37 f2bc0661 a5d354ca 207159f1 c6590250 76551ecd 41db6188 817d1ae0 04563752 78e50e5c 457b0e1d2002-09-02 22:58:26: DEBUG: oakley.c:1969:oakley_skeyid(): nonce1: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): f0e66f0a d51be532 268f5975 f35a3c98 2002-09-02 22:58:26: DEBUG: oakley.c:1975:oakley_skeyid(): nonce2: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): a0a567ba 12996f68 26143e4b aacb3b63 2002-09-02 22:58:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:26: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 7757a72e 381ac1a0 240cd71f 5ee209d5 89540669 2002-09-02 22:58:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:26: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 9087738f a54995a4 9bcdb9b6 ce0c0413 82a9bcd5 2002-09-02 22:58:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:26: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): b4a53f3d 36196611 cf1e3d57 3854de15 5fec9c4c 2002-09-02 22:58:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:26: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 7d48eef4 758cfef8 8cc196f8 24029495 da6008de 2002-09-02 22:58:26: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2002-09-02 22:58:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:26: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 00 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e 2002-09-02 22:58:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:26: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): fb3fe83e 42ccac38 c3324e1e 765543e2 8cda15a0 2002-09-02 22:58:26: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:26: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2002-09-02 22:58:26: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): 174e7971 7c3d44ec 2002-09-02 22:58:26: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:26: DEBUG: isakmp.c:232:isakmp_handler(): 239 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:26: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 04100200 00000000 000000ef 0a000084 ad78724c 5df33ff4 5419bf51 f8e72887 6c28f95b 3931a005 fc0508d0 bd91a2be 83bd8776 69ec3a7a 3190838e 7deb83bb 49ce041a 9b70c044 b9d3a209 503389cf 3a7ebeb6 2687f222 acbd0c5c 15e93d39 455b3aef d6f06263 9b9324ce 8b814096 2159b2d5 52bf0da8 1b2ecec9 718c1ff4 c62d4b55 ddbdfa7d 877c0c8c 5d4aa7bf 07000014 f0e66f0a d51be532 268f5975 f35a3c98 0000003b 04303431 0d300b06 0355040a 13045650 4e433123 30210603 55040b13 1a436f6e 666f726d 616e6365 20746573 74696e67 20726f6f 742031 2002-09-02 22:58:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:26: DEBUG: isakmp.c:420:isakmp_main(): the packet retransmited by peer. 2002-09-02 22:58:27: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:27: DEBUG: isakmp.c:232:isakmp_handler(): 724 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 05100201 00000000 000002d4 dae5c6ea eeb204c4 a867a184 c5f39e08 bec5c673 fa9b3f8d 077e31fa 052c2d7c 07e35ca1 f68a8a74 c17c9237 96752b0f 3ffb3f55 1fc3b5e9 ae46a607 4c6cdc71 fc1c4e49 4181c23c 0964ba6d b2bb38ff 33433b18 237444ef 6754f56c 9bdf7041 661457c6 9913d8cc 0d35957c 8b639f7b 6e94a460 d0138c2c 1c1c2c19 3fbd9205 402d0108 3f5b3e11 9740b9c6 8d20e310 51fb70f5 c74692c1 b5b5db97 33bc52f1 04da50ec 93ed6106 d8fd7c6d 19ebb410 e3f4fb39 7fc75738 0c31f0b4 991650b4 d394174b d2d590dc f59bf736 5eca040e 7625fb7e d0a114a8 edf16f74 54076fe9 bb0545c7 801b434f d3587248 2b9bb9c4 13802a55 8605df75 66dbc8ef 73d0d2d7 39a04ca3 6f75fa39 5deab036 49f8cfe2 b8f341b3 cb204ddf a7c5b1f8 1f90481f 28296171 36a5f241 a6dcc38f a9cb9635 0ecdc4f1 037a1d9b af5c99a8 79ee88e8 f7de9070 18bbb025 d0a49901 9f9ff2d0 f8b03fb1 3a2ec4a0 a370229c b6cf4a65 976a0332 ba977995 424c08fa 1a23bc04 e3406d00 3795083a 0f0dd44e de3bbf2b 5efa7f68 39fd073e 738dd6a1 a9b280b6 18e69368 819eee75 201c6305 90b463d4 ca0c241f a6e1cb4a b39160a1 ee2439e1 74b76353 2ce9bcc8 443327f9 55f7e8b4 cfdc5591 d1f2af49 5eaac0e7 9ffe2bf1 49a2ea4b 49e82608 a8fddc00 380aed19 10aa2d29 aee496b9 ca96c99e 764e9fbc f36b48d4 c0cbb6aa ba6aec24 4ad5d0dc f9404387 15a9d8fd 4e794951 c8fdd598 a30e5dce ab7bcf2a 133e59bb bb33b782 323e1029 3f77c27a 3077a6b4 4bfa259b c96d6c65 c6451d95 45e209cb b2302be7 8a770966 4f43db32 6f7e28f6 40c8edea 8cf26eee 4db848a7 3ea34b80 369e202c 15dfaddf 7d3a1a05 1fc60264 49cf2790 403e2532 1c8f07ed 6ec0090c c5c9d9b6 2450044a 4911b282 27285de7 72921945 846996c8 f8582dd4 484c2a6b f7d56e56 0e035e1d c27b9227 199b1365 01d2efa6 1024cc74 e67164fa 2002-09-02 22:58:27: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:27: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2002-09-02 22:58:27: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 1024cc74 e67164fa 2002-09-02 22:58:27: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2002-09-02 22:58:27: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:27: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 1024cc74 e67164fa 2002-09-02 22:58:27: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 0600000c 011101f4 c15ec262 0900020c 04308202 03308201 6ca00302 01020201 26300d06 092a8648 86f70d01 01050500 3034310d 300b0603 55040a13 0456504e 43312330 21060355 040b131a 436f6e66 6f726d61 6e636520 74657374 696e6720 726f6f74 2031301e 170d3032 30393032 31353538 30325a17 0d313031 31313931 35353830 325a3046 310b3009 06035504 06130246 49311230 10060355 040a1309 53746f6e 65736f66 74312330 21060355 0403131a 56504e43 20746573 7420636c 75737465 72203230 30323039 30323081 9f300d06 092a8648 86f70d01 01010500 03818d00 30818902 8181009a e4cc85f4 5c4d4110 81119f69 700072df 11a61ea3 84614111 6f6d8e7f bce2b50b c7d7d500 360132f8 c275105d 4bbbe24f 81f13488 1c236914 c01745a1 bc7c47b3 74fb7f59 1cc7fe15 59c7fab2 947f9142 e69377ea 4b7aae1e 4f1d00c1 667926bf 9775803e fc408aa4 c3a13d2e 41100f7c b74da9f0 892102c1 96ea4556 6c334702 03010001 a3133011 300f0603 551d1104 08300687 04c15ec2 62300d06 092a8648 86f70d01 01050500 03818100 21402bc1 8d34fab8 b34fa39d e0d2c3aa 125c39ec 68d3bb6b 373c4148 b8126f00 8eb0aff8 b4603193 905d991a 826629f0 a72832a1 b87e268d 62264913 f7df1e7e 94888c33 b7390d19 6a9f622d b02c7886 69feb6bf bc327a62 ea3a8524 d43fd5a9 88612f5f 52cd7cc1 e0ac43b6 137faa3d 97ae9edc 055bba6e 2868d204 241a206b 0b000084 8c913fdd 4cfb1df5 66c57887 ebb14e7b 3ba5eca1 b3dc590a 8f27f74c a329d744 1685817d 5c0c757e 0dc38766 613b5d7e 6045a9ae 2f66fa32 c25824b6 1ce9b4bb d502c551 b36c3a9e c0fa4e35 4448c6b0 1f94db4c f63e5af4 def6a224 d435bdc8 947489ac 2dee3093 e8b3ac23 37c3aaa1 9448a039 bb0ad5ed 12ccbdf5 3657bf25 0000001c 00000001 01106002 cbbb200a 4f530000 8587abd7 61244aa9 2002-09-02 22:58:27: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=170 2002-09-02 22:58:27: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2002-09-02 22:58:27: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 05100201 00000000 000002d4 0600000c 011101f4 c15ec262 0900020c 04308202 03308201 6ca00302 01020201 26300d06 092a8648 86f70d01 01050500 3034310d 300b0603 55040a13 0456504e 43312330 21060355 040b131a 436f6e66 6f726d61 6e636520 74657374 696e6720 726f6f74 2031301e 170d3032 30393032 31353538 30325a17 0d313031 31313931 35353830 325a3046 310b3009 06035504 06130246 49311230 10060355 040a1309 53746f6e 65736f66 74312330 21060355 0403131a 56504e43 20746573 7420636c 75737465 72203230 30323039 30323081 9f300d06 092a8648 86f70d01 01010500 03818d00 30818902 8181009a e4cc85f4 5c4d4110 81119f69 700072df 11a61ea3 84614111 6f6d8e7f bce2b50b c7d7d500 360132f8 c275105d 4bbbe24f 81f13488 1c236914 c01745a1 bc7c47b3 74fb7f59 1cc7fe15 59c7fab2 947f9142 e69377ea 4b7aae1e 4f1d00c1 667926bf 9775803e fc408aa4 c3a13d2e 41100f7c b74da9f0 892102c1 96ea4556 6c334702 03010001 a3133011 300f0603 551d1104 08300687 04c15ec2 62300d06 092a8648 86f70d01 01050500 03818100 21402bc1 8d34fab8 b34fa39d e0d2c3aa 125c39ec 68d3bb6b 373c4148 b8126f00 8eb0aff8 b4603193 905d991a 826629f0 a72832a1 b87e268d 62264913 f7df1e7e 94888c33 b7390d19 6a9f622d b02c7886 69feb6bf bc327a62 ea3a8524 d43fd5a9 88612f5f 52cd7cc1 e0ac43b6 137faa3d 97ae9edc 055bba6e 2868d204 241a206b 0b000084 8c913fdd 4cfb1df5 66c57887 ebb14e7b 3ba5eca1 b3dc590a 8f27f74c a329d744 1685817d 5c0c757e 0dc38766 613b5d7e 6045a9ae 2f66fa32 c25824b6 1ce9b4bb d502c551 b36c3a9e c0fa4e35 4448c6b0 1f94db4c f63e5af4 def6a224 d435bdc8 947489ac 2dee3093 e8b3ac23 37c3aaa1 9448a039 bb0ad5ed 12ccbdf5 3657bf25 0000001c 00000001 01106002 cbbb200a 4f530000 8587abd7 61244aa9 2002-09-02 22:58:27: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:27: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:27: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2002-09-02 22:58:27: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=6(cert) 2002-09-02 22:58:27: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=9(sig) 2002-09-02 22:58:27: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=11(notify) 2002-09-02 22:58:27: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:27: DEBUG: oakley.c:1716:oakley_savecert(): CERT saved: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 30820203 3082016c a0030201 02020126 300d0609 2a864886 f70d0101 05050030 34310d30 0b060355 040a1304 56504e43 31233021 06035504 0b131a43 6f6e666f 726d616e 63652074 65737469 6e672072 6f6f7420 31301e17 0d303230 39303231 35353830 325a170d 31303131 31393135 35383032 5a304631 0b300906 03550406 13024649 31123010 06035504 0a130953 746f6e65 736f6674 31233021 06035504 03131a56 504e4320 74657374 20636c75 73746572 20323030 32303930 3230819f 300d0609 2a864886 f70d0101 01050003 818d0030 81890281 81009ae4 cc85f45c 4d411081 119f6970 0072df11 a61ea384 6141116f 6d8e7fbc e2b50bc7 d7d50036 0132f8c2 75105d4b bbe24f81 f134881c 236914c0 1745a1bc 7c47b374 fb7f591c c7fe1559 c7fab294 7f9142e6 9377ea4b 7aae1e4f 1d00c166 7926bf97 75803efc 408aa4c3 a13d2e41 100f7cb7 4da9f089 2102c196 ea45566c 33470203 010001a3 13301130 0f060355 1d110408 30068704 c15ec262 300d0609 2a864886 f70d0101 05050003 81810021 402bc18d 34fab8b3 4fa39de0 d2c3aa12 5c39ec68 d3bb6b37 3c4148b8 126f008e b0aff8b4 60319390 5d991a82 6629f0a7 2832a1b8 7e268d62 264913f7 df1e7e94 888c33b7 390d196a 9f622db0 2c788669 feb6bfbc 327a62ea 3a8524d4 3fd5a988 612f5f52 cd7cc1e0 ac43b613 7faa3d97 ae9edc05 5bba6e28 68d20424 1a206b 2002-09-02 22:58:27: DEBUG: oakley.c:1720:oakley_savecert(): Certificate: Data: Version: 3 (0x2) Serial Number: 38 (0x26) Signature Algorithm: sha1WithRSAEncryption Issuer: O=VPNC, OU=Conformance testing root 1 Validity Not Before: Sep 2 15:58:02 2002 GMT Not After : Nov 19 15:58:02 2010 GMT Subject: C=FI, O=Stonesoft, CN=VPNC test cluster 20020902 Subject Public Key Info: Public Key Algorithm: rsaEncryption RSA Public Key: (1024 bit) Modulus (1024 bit): 00:9a:e4:cc:85:f4:5c:4d:41:10:81:11:9f:69:70: 00:72:df:11:a6:1e:a3:84:61:41:11:6f:6d:8e:7f: bc:e2:b5:0b:c7:d7:d5:00:36:01:32:f8:c2:75:10: 5d:4b:bb:e2:4f:81:f1:34:88:1c:23:69:14:c0:17: 45:a1:bc:7c:47:b3:74:fb:7f:59:1c:c7:fe:15:59: c7:fa:b2:94:7f:91:42:e6:93:77:ea:4b:7a:ae:1e: 4f:1d:00:c1:66:79:26:bf:97:75:80:3e:fc:40:8a: a4:c3:a1:3d:2e:41:10:0f:7c:b7:4d:a9:f0:89:21: 02:c1:96:ea:45:56:6c:33:47 Exponent: 65537 (0x10001) X509v3 extensions: X509v3 Subject Alternative Name: IP Address:193.94.194.98 Signature Algorithm: sha1WithRSAEncryption 21:40:2b:c1:8d:34:fa:b8:b3:4f:a3:9d:e0:d2:c3:aa:12:5c: 39:ec:68:d3:bb:6b:37:3c:41:48:b8:12:6f:00:8e:b0:af:f8: b4:60:31:93:90:5d:99:1a:82:66:29:f0:a7:28:32:a1:b8:7e: 26:8d:62:26:49:13:f7:df:1e:7e:94:88:8c:33:b7:39:0d:19: 6a:9f:62:2d:b0:2c:78:86:69:fe:b6:bf:bc:32:7a:62:ea:3a: 85:24:d4:3f:d5:a9:88:61:2f:5f:52:cd:7c:c1:e0:ac:43:b6: 13:7f:aa:3d:97:ae:9e:dc:05:5b:ba:6e:28:68:d2:04:24:1a: 20:6b 2002-09-02 22:58:27: DEBUG: isakmp_inf.c:1196:isakmp_check_notify(): Notify Message received 2002-09-02 22:58:27: WARNING: isakmp_inf.c:1213:isakmp_check_notify(): ignore INITIAL-CONTACT notification. 2002-09-02 22:58:27: DEBUG: oakley.c:1175:oakley_validate_auth(): SIGN passed: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 8c913fdd 4cfb1df5 66c57887 ebb14e7b 3ba5eca1 b3dc590a 8f27f74c a329d744 1685817d 5c0c757e 0dc38766 613b5d7e 6045a9ae 2f66fa32 c25824b6 1ce9b4bb d502c551 b36c3a9e c0fa4e35 4448c6b0 1f94db4c f63e5af4 def6a224 d435bdc8 947489ac 2dee3093 e8b3ac23 37c3aaa1 9448a039 bb0ad5ed 12ccbdf5 3657bf252002-09-02 22:58:27: DEBUG: oakley.c:1211:oakley_validate_auth(): CERT validated 2002-09-02 22:58:27: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): ad78724c 5df33ff4 5419bf51 f8e72887 6c28f95b 3931a005 fc0508d0 bd91a2be 83bd8776 69ec3a7a 3190838e 7deb83bb 49ce041a 9b70c044 b9d3a209 503389cf 3a7ebeb6 2687f222 acbd0c5c 15e93d39 455b3aef d6f06263 9b9324ce 8b814096 2159b2d5 52bf0da8 1b2ecec9 718c1ff4 c62d4b55 ddbdfa7d 877c0c8c 5d4aa7bf 5caa5317 6e121cb1 f2b5eb29 1d440a17 753bc15c f4cf0ff4 4eebab98 2ff7348e 1aa4c98f fa045817 6c4e8cda af063663 b1dede33 9f1c23e0 6cfb1ae3 202c3676 8be05dae 0473d97e 716421d8 efe877ec 4bbfb2d4 3fa82beb b5ee4921 eb2860ff 734299a5 e11be3fb 8c8c885e e85867a8 b5901b63 e74829c5 2183209f f796e064 cbbb200a 4f530000 8587abd7 61244aa9 00000001 00000001 00000030 00010801 cbbb200a 4f530000 00000020 00010000 80010005 80020002 80030003 80040002 800b0001 800c0744 011101f4 c15ec262 2002-09-02 22:58:27: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:27: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 7ad3b642 048c792d 1da35183 bffaad48 8303e52e 2002-09-02 22:58:27: DEBUG: oakley.c:1253:oakley_validate_auth(): SIG authenticated 2002-09-02 22:58:27: DEBUG: isakmp_ident.c:1192:ident_r3recv(): peer's ID 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 011101f4 c15ec262 2002-09-02 22:58:27: DEBUG: isakmp.c:609:ph1_main(): === 2002-09-02 22:58:27: DEBUG: ipsec_doi.c:3156:ipsecdoi_setid1(): use ID type of IPv4_address 2002-09-02 22:58:27: DEBUG: isakmp_ident.c:1270:ident_r3send(): generate HASH_R 2002-09-02 22:58:27: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 5caa5317 6e121cb1 f2b5eb29 1d440a17 753bc15c f4cf0ff4 4eebab98 2ff7348e 1aa4c98f fa045817 6c4e8cda af063663 b1dede33 9f1c23e0 6cfb1ae3 202c3676 8be05dae 0473d97e 716421d8 efe877ec 4bbfb2d4 3fa82beb b5ee4921 eb2860ff 734299a5 e11be3fb 8c8c885e e85867a8 b5901b63 e74829c5 2183209f f796e064 ad78724c 5df33ff4 5419bf51 f8e72887 6c28f95b 3931a005 fc0508d0 bd91a2be 83bd8776 69ec3a7a 3190838e 7deb83bb 49ce041a 9b70c044 b9d3a209 503389cf 3a7ebeb6 2687f222 acbd0c5c 15e93d39 455b3aef d6f06263 9b9324ce 8b814096 2159b2d5 52bf0da8 1b2ecec9 718c1ff4 c62d4b55 ddbdfa7d 877c0c8c 5d4aa7bf 8587abd7 61244aa9 cbbb200a 4f530000 00000001 00000001 00000030 00010801 cbbb200a 4f530000 00000020 00010000 80010005 80020002 80030003 80040002 800b0001 800c0744 011101f4 a5e3f905 2002-09-02 22:58:27: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:27: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 474a3099 d112c0a4 a6e57a84 ad8f0193 e20ea15e 2002-09-02 22:58:27: DEBUG: localconf.c:269:getpathname(): filename: /etc/isakmpd/testing/kame.crt.ip 2002-09-02 22:58:27: DEBUG: oakley.c:1367:get_cert_fromlocal(): Certificate: Data: Version: 3 (0x2) Serial Number: 3 (0x3) Signature Algorithm: sha1WithRSAEncryption Issuer: O=VPNC, OU=Conformance testing root 1 Validity Not Before: Jun 18 23:40:23 2001 GMT Not After : Sep 4 23:40:23 2009 GMT Subject: O=VPNC Subject Public Key Info: Public Key Algorithm: rsaEncryption RSA Public Key: (1024 bit) Modulus (1024 bit): 00:c0:c1:42:ee:4a:1a:fd:7e:09:5c:b5:7b:f7:ea: 3a:60:ce:eb:ea:8d:58:94:9f:30:02:6f:96:9c:19: a1:b5:cc:ca:c3:7b:22:76:fe:c9:f9:0c:e1:34:14: e8:0d:ce:b8:14:cf:6e:fd:2c:e6:14:b1:5f:dd:ad: 4d:c5:81:63:a8:bc:9a:f4:ad:75:1d:e3:5c:d7:15: a1:83:de:3d:4b:c7:b0:4e:dd:0a:a6:46:42:45:1d: ac:ec:e7:74:8d:28:1a:ec:ee:85:c8:d0:61:eb:66: 43:88:1f:cf:5f:f5:e5:c4:4d:2d:0f:53:ba:3a:b4: 3b:4f:e6:72:ae:b2:7f:f3:87 Exponent: 65537 (0x10001) X509v3 extensions: X509v3 Subject Alternative Name: IP Address:165.227.249.5 Signature Algorithm: sha1WithRSAEncryption 8a:30:fd:01:9d:ce:78:2e:2e:05:c9:e8:51:04:34:3c:a5:ab: d8:55:38:7b:dd:7d:7b:a4:0f:fa:20:6b:97:83:1c:11:80:c5: b5:b4:3a:2d:bf:ed:ab:cc:b8:0f:97:cd:cb:2d:7f:25:16:af: 70:1f:7b:5e:92:28:3d:c7:28:7b:41:af:47:d5:45:97:e5:58: 5c:c6:89:50:64:70:2b:65:75:1d:b8:e5:1d:28:b3:21:1d:c4: e6:2a:1b:1e:6b:5e:9b:c9:97:81:9e:1c:02:d3:4e:dc:9e:73: 79:9d:6c:44:56:0d:af:85:46:4c:9f:34:c7:4c:39:93:74:d1: c4:1d 2002-09-02 22:58:27: DEBUG: oakley.c:1405:get_cert_fromlocal(): created CERT payload: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 04308201 cc308201 35a00302 01020201 03300d06 092a8648 86f70d01 01050500 3034310d 300b0603 55040a13 0456504e 43312330 21060355 040b131a 436f6e66 6f726d61 6e636520 74657374 696e6720 726f6f74 2031301e 170d3031 30363138 32333430 32335a17 0d303930 39303432 33343032 335a300f 310d300b 06035504 0a130456 504e4330 819f300d 06092a86 4886f70d 01010105 0003818d 00308189 02818100 c0c142ee 4a1afd7e 095cb57b f7ea3a60 ceebea8d 58949f30 026f969c 19a1b5cc cac37b22 76fec9f9 0ce13414 e80dceb8 14cf6efd 2ce614b1 5fddad4d c58163a8 bc9af4ad 751de35c d715a183 de3d4bc7 b04edd0a a6464245 1dacece7 748d281a ecee85c8 d061eb66 43881fcf 5ff5e5c4 4d2d0f53 ba3ab43b 4fe672ae b27ff387 02030100 01a31330 11300f06 03551d11 04083006 8704a5e3 f905300d 06092a86 4886f70d 01010505 00038181 008a30fd 019dce78 2e2e05c9 e8510434 3ca5abd8 55387bdd 7d7ba40f fa206b97 831c1180 c5b5b43a 2dbfedab ccb80f97 cdcb2d7f 2516af70 1f7b5e92 283dc728 7b41af47 d54597e5 585cc689 5064702b 65751db8 e51d28b3 211dc4e6 2a1b1e6b 5e9bc997 819e1c02 d34edc9e 73799d6c 44560daf 85464c9f 34c74c39 9374d1c4 1d 2002-09-02 22:58:27: DEBUG: localconf.c:269:getpathname(): filename: /etc/isakmpd/testing/local.key 2002-09-02 22:58:27: DEBUG: oakley.c:1443:oakley_getsign(): private key: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 3082025e 02010002 818100c0 c142ee4a 1afd7e09 5cb57bf7 ea3a60ce ebea8d58 949f3002 6f969c19 a1b5ccca c37b2276 fec9f90c e13414e8 0dceb814 cf6efd2c e614b15f ddad4dc5 8163a8bc 9af4ad75 1de35cd7 15a183de 3d4bc7b0 4edd0aa6 4642451d acece774 8d281aec ee85c8d0 61eb6643 881fcf5f f5e5c44d 2d0f53ba 3ab43b4f e672aeb2 7ff38702 03010001 0281807d 081fb150 5287a20c d29d4a67 bb00d930 ffe8ea7c ce132062 441deeed d56e8703 f39f58f0 d53f1014 e1b415e7 9ca53dd5 09e515c6 dd0c092e 852dd867 c8116b0d 2a76f035 8fade5e6 b2a61266 b27f1267 1e13d607 9f2bda21 3c29c182 7ff5cff0 9c1a0a31 39daf7f2 aa957544 7b4dcec6 2575ba02 ec525fbb f0d5174c 31324102 4100fcd0 f97e0654 0700cfe7 6e2afa00 35a3376b 2222be11 ab6e15fc c7207e1f 607152a5 413ad83f 5b11777d 765bb78e 58f745f1 24170dc6 990a542e d5d21c7b 96270241 00c32ea9 71eca2e6 e1e4932d a98567bd d3299556 1c07cd2e dff5c872 3f03dc6b 72dc44c8 95a23697 79778e64 4bdefbf4 2644a380 ea90f173 a5d1d4bd a687f573 a1024100 937608b0 3b5cb3a1 03a3479d 05a92d9f ffe91b46 0c7b1df4 de1a4cc3 650d4421 954512a1 12151237 43ed0826 43106250 0899b8a5 41c1beee 495ff013 d7cd362d 0241009c e8d053c3 d71a2193 ae365147 ec2490b3 a7587864 55314fde b96c0ef8 bda4abcc 2487d4b3 798bc09c ba9e2ad8 7258cec2 f366da2b f7cfef08 872c87ca 592ac102 4100dfc6 1c8a991b b2c34f53 6ab9a7f0 124b622a 19add873 67fee5b7 d8d74b24 a14dda4f b5784fb5 19347df4 3bc72e17 2ef602f9 df44f1d8 101ce1b2 8fa5614a e088 2002-09-02 22:58:27: DEBUG: oakley.c:1458:oakley_getsign(): SIGN computed: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 2da9d314 553b3ad1 cd447d97 2969219a 48cbcdd5 76423763 a66dc227 970a01f9 f9aecf98 d62dead1 85c27e98 b17a84ac 317bb29d 3dc230d3 2cd99119 c914556c 8a6bc180 805c3825 2bb51049 a57b1796 148143d2 c0420e78 e57c712b d18fb2a5 543219b2 7911adba 755a50d1 ed14deb3 27c74e7d 4ba7f889 1e982c8a 61eee0c62002-09-02 22:58:27: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 6 2002-09-02 22:58:27: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 465, next type 9 2002-09-02 22:58:27: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 0 2002-09-02 22:58:27: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:27: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2002-09-02 22:58:27: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 3 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 0600000c 011101f4 a5e3f905 090001d5 04308201 cc308201 35a00302 01020201 03300d06 092a8648 86f70d01 01050500 3034310d 300b0603 55040a13 0456504e 43312330 21060355 040b131a 436f6e66 6f726d61 6e636520 74657374 696e6720 726f6f74 2031301e 170d3031 30363138 32333430 32335a17 0d303930 39303432 33343032 335a300f 310d300b 06035504 0a130456 504e4330 819f300d 06092a86 4886f70d 01010105 0003818d 00308189 02818100 c0c142ee 4a1afd7e 095cb57b f7ea3a60 ceebea8d 58949f30 026f969c 19a1b5cc cac37b22 76fec9f9 0ce13414 e80dceb8 14cf6efd 2ce614b1 5fddad4d c58163a8 bc9af4ad 751de35c d715a183 de3d4bc7 b04edd0a a6464245 1dacece7 748d281a ecee85c8 d061eb66 43881fcf 5ff5e5c4 4d2d0f53 ba3ab43b 4fe672ae b27ff387 02030100 01a31330 11300f06 03551d11 04083006 8704a5e3 f905300d 06092a86 4886f70d 01010505 00038181 008a30fd 019dce78 2e2e05c9 e8510434 3ca5abd8 55387bdd 7d7ba40f fa206b97 831c1180 c5b5b43a 2dbfedab ccb80f97 cdcb2d7f 2516af70 1f7b5e92 283dc728 7b41af47 d54597e5 585cc689 5064702b 65751db8 e51d28b3 211dc4e6 2a1b1e6b 5e9bc997 819e1c02 d34edc9e 73799d6c 44560daf 85464c9f 34c74c39 9374d1c4 1d000000 842da9d3 14553b3a d1cd447d 97296921 9a48cbcd d5764237 63a66dc2 27970a01 f9f9aecf 98d62dea d185c27e 98b17a84 ac317bb2 9d3dc230 d32cd991 19c91455 6c8a6bc1 80805c38 252bb510 49a57b17 96148143 d2c0420e 78e57c71 2bd18fb2 a5543219 b27911ad ba755a50 d1ed14de b327c74e 7d4ba7f8 891e982c 8a61eee0 c61c5f02 2002-09-02 22:58:27: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2002-09-02 22:58:27: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:27: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): fa7d9e2d 9c0382b8 2002-09-02 22:58:27: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): fa7d9e2d 9c0382b8 2002-09-02 22:58:27: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2002-09-02 22:58:27: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2002-09-02 22:58:27: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2002-09-02 22:58:27: DEBUG: sockmisc.c:361:sendfromto(): send packet to 193.94.194.98[500] 2002-09-02 22:58:27: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 644 bytes message will be sent. 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 05100201 00000000 00000284 e293de53 5eb3cf8f bfb176a6 c44603bf a8ecac8e 5d6bfc79 2ad48975 93e7161f 01ed5803 cfc0b1bd 628a717c fed176e8 f0d74954 6037c708 b1fb1085 20c7b11b 00345bce 9240dfa3 944f1412 77aabfec 421c8b77 17927c4a 0a9af2ce fcc4cb8d 464c1daa 5570e956 16d845e2 bd6f08ac 01dc19e3 de99cac4 fd924a6a 7115659d d009c219 33f09d6c cfb0ed40 c4e8ecee c983bb36 837b4bd3 3688966e 2c3e2795 2152f4d9 516b365e 401912c1 8ba83c9f fad69d5a d0849f44 56850020 74493750 9319da44 1fec3f21 e3d7ff06 b0517338 2a8a5c1e f7f82f00 f702c02e 1f1b6d91 2fe7e768 213e2e68 30928dbb 03f77ff0 1f53163f 9ccd3469 6d6b24f8 e15535cf 1291f922 6bfb4509 5bcc5265 e05087c3 4e8b1e37 5b11005a 981b2521 a2a8e9f8 3186aecc 0c6b8a2c 21c27ab9 918cdbb5 435da161 4f982744 13e24db4 35718afd 7d36f2a9 224504a5 c1080f3c 1ff9f592 32cadb54 73f6baba b1c414b4 ac09b35f 2070d6bb 190b0616 201e42df 3d0026f6 1d1051e5 ed6efd3e 1b180f1a fdb00168 41276284 0ff4e0db 11d0de71 3c3bf0f0 3c6716f7 28e50aec 6fc13ce0 b663fcbe 24950f90 a058950f 1509e72c 3410746c 71930aa4 ba4feb1a 568f2f9a 233bf9ca 069cf7ca 67d766d0 58887e48 c1c5642b 1b447acd 6c5f214a 08c27311 4162d965 768d0167 54c1419c fe78bc3c b254f6e3 2584ebd1 2b4db4f2 c53be1b9 87a4e4c7 efc2b6dd 78473bd6 66938e00 1fc9db39 05c9d302 ae55f3ca 42e2a5ec e61da362 07940ff4 3049245f 3b0d8609 b951471f 6cb10f3d 6fab6211 deef8cbe 58a69ab6 7a82d487 71789823 e1d9946c d4d3900c 50d46102 45d84be3 32f6d665 ef03cf2e fa7d9e2d 9c0382b8 2002-09-02 22:58:27: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2002-09-02 22:58:27: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): fa7d9e2d 9c0382b8 05403333 2002-09-02 22:58:27: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2002-09-02 22:58:27: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 6885cae9 07895980 2002-09-02 22:58:27: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 05403333 0000001c 00000001 01106002 cbbb200a 4f530000 8587abd7 61244aa92002-09-02 22:58:27: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:27: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 98ed9ba3 5df1b475 6a69db12 102ed24f 96b94d6c 2002-09-02 22:58:27: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:27: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2002-09-02 22:58:27: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 0b000018 98ed9ba3 5df1b475 6a69db12 102ed24f 96b94d6c 0000001c 00000001 01106002 cbbb200a 4f530000 8587abd7 61244aa9 53fcc903 2002-09-02 22:58:27: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2002-09-02 22:58:27: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:27: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 5305d020 d390543b 2002-09-02 22:58:27: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): 5305d020 d390543b 2002-09-02 22:58:27: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2002-09-02 22:58:27: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2002-09-02 22:58:27: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2002-09-02 22:58:27: DEBUG: sockmisc.c:361:sendfromto(): send packet to 193.94.194.98[500] 2002-09-02 22:58:27: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2002-09-02 22:58:27: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08100501 05403333 00000054 1b079f1b 7cd3ff37 002d12c3 bb33442c 38cbd549 1ccca371 3cb26ab5 793923e8 255beb53 bda275a7 02e46166 8881c98a 5305d020 d390543b 2002-09-02 22:58:27: DEBUG: isakmp_inf.c:633:isakmp_info_send_common(): sendto Information notify. 2002-09-02 22:58:27: INFO: isakmp.c:2273:log_ph1established(): ISAKMP-SA established 165.227.249.5[500]-193.94.194.98[500] spi:cbbb200a4f530000:8587abd761244aa9 2002-09-02 22:58:27: DEBUG: isakmp.c:649:ph1_main(): === 2002-09-02 22:58:28: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:28: DEBUG: isakmp.c:232:isakmp_handler(): 724 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 05100201 00000000 000002d4 dae5c6ea eeb204c4 a867a184 c5f39e08 bec5c673 fa9b3f8d 077e31fa 052c2d7c 07e35ca1 f68a8a74 c17c9237 96752b0f 3ffb3f55 1fc3b5e9 ae46a607 4c6cdc71 fc1c4e49 4181c23c 0964ba6d b2bb38ff 33433b18 237444ef 6754f56c 9bdf7041 661457c6 9913d8cc 0d35957c 8b639f7b 6e94a460 d0138c2c 1c1c2c19 3fbd9205 402d0108 3f5b3e11 9740b9c6 8d20e310 51fb70f5 c74692c1 b5b5db97 33bc52f1 04da50ec 93ed6106 d8fd7c6d 19ebb410 e3f4fb39 7fc75738 0c31f0b4 991650b4 d394174b d2d590dc f59bf736 5eca040e 7625fb7e d0a114a8 edf16f74 54076fe9 bb0545c7 801b434f d3587248 2b9bb9c4 13802a55 8605df75 66dbc8ef 73d0d2d7 39a04ca3 6f75fa39 5deab036 49f8cfe2 b8f341b3 cb204ddf a7c5b1f8 1f90481f 28296171 36a5f241 a6dcc38f a9cb9635 0ecdc4f1 037a1d9b af5c99a8 79ee88e8 f7de9070 18bbb025 d0a49901 9f9ff2d0 f8b03fb1 3a2ec4a0 a370229c b6cf4a65 976a0332 ba977995 424c08fa 1a23bc04 e3406d00 3795083a 0f0dd44e de3bbf2b 5efa7f68 39fd073e 738dd6a1 a9b280b6 18e69368 819eee75 201c6305 90b463d4 ca0c241f a6e1cb4a b39160a1 ee2439e1 74b76353 2ce9bcc8 443327f9 55f7e8b4 cfdc5591 d1f2af49 5eaac0e7 9ffe2bf1 49a2ea4b 49e82608 a8fddc00 380aed19 10aa2d29 aee496b9 ca96c99e 764e9fbc f36b48d4 c0cbb6aa ba6aec24 4ad5d0dc f9404387 15a9d8fd 4e794951 c8fdd598 a30e5dce ab7bcf2a 133e59bb bb33b782 323e1029 3f77c27a 3077a6b4 4bfa259b c96d6c65 c6451d95 45e209cb b2302be7 8a770966 4f43db32 6f7e28f6 40c8edea 8cf26eee 4db848a7 3ea34b80 369e202c 15dfaddf 7d3a1a05 1fc60264 49cf2790 403e2532 1c8f07ed 6ec0090c c5c9d9b6 2450044a 4911b282 27285de7 72921945 846996c8 f8582dd4 484c2a6b f7d56e56 0e035e1d c27b9227 199b1365 01d2efa6 1024cc74 e67164fa 2002-09-02 22:58:28: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:420:isakmp_main(): the packet retransmited by peer. 2002-09-02 22:58:28: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:28: DEBUG: isakmp.c:232:isakmp_handler(): 148 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 5036cfda 00000094 bf12db0a 2d128724 d2d90073 5dba91f8 22ea3381 2f873ac7 35b3fa80 275ba0c2 c6fa70f4 e4d04dbf 9c91de2c 8bd5b27b 5f34d674 efe07062 81c02113 7a008164 012586b0 0397bd97 7b56481a 3c5ba7f9 b7c3a84b 9f0b7e11 5e92b7c1 19100002 6715c66f b0c666fe 0fec5570 0239c1e6 d7251dec c7bb1d53 2002-09-02 22:58:28: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:28: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2002-09-02 22:58:28: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): fa7d9e2d 9c0382b8 5036cfda 2002-09-02 22:58:28: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2002-09-02 22:58:28: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): ec328ff9 d6bd72d5 2002-09-02 22:58:28: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2002-09-02 22:58:28: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>193.94.194.98[0] 2002-09-02 22:58:28: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2002-09-02 22:58:28: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): d7251dec c7bb1d53 2002-09-02 22:58:28: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2002-09-02 22:58:28: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:28: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): d7251dec c7bb1d53 2002-09-02 22:58:28: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 01000018 762a0124 58b68a91 61c43861 d059f78c b8df8d89 0a000030 00000001 00000001 00000024 01030401 b019d564 00000018 01030000 80050002 80010001 80020744 80040001 05000014 8e99162b 2794d695 c99e2dc4 fee0e2ac 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 00000000 2002-09-02 22:58:28: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2002-09-02 22:58:28: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2002-09-02 22:58:28: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 5036cfda 00000094 01000018 762a0124 58b68a91 61c43861 d059f78c b8df8d89 0a000030 00000001 00000001 00000024 01030401 b019d564 00000018 01030000 80050002 80010001 80020744 80040001 05000014 8e99162b 2794d695 c99e2dc4 fee0e2ac 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 00000000 2002-09-02 22:58:28: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2002-09-02 22:58:28: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 01000000 0a0017fb 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 01000000 0a080807 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 762a0124 58b68a91 61c43861 d059f78c b8df8d89 2002-09-02 22:58:28: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 5036cfda 0a000030 00000001 00000001 00000024 01030401 b019d564 00000018 01030000 80050002 80010001 80020744 80040001 05000014 8e99162b 2794d695 c99e2dc4 fee0e2ac 0500000c 01000000 0a0017fb 0000000c 01000000 0a0808072002-09-02 22:58:28: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:28: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 762a0124 58b68a91 61c43861 d059f78c b8df8d89 2002-09-02 22:58:28: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 10.0.23.251[0] prefixlen=32 ul_proto=255 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[0] prefixlen=32 ul_proto=255 2002-09-02 22:58:28: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd458: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 22:58:28: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 22:58:28: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.0.23.251[0] 2002-09-02 22:58:28: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 10.0.23.251[0] 2002-09-02 22:58:28: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.8.8.7[0] 2002-09-02 22:58:28: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2002-09-02 22:58:28: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd458: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 22:58:28: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 22:58:28: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd458: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 22:58:28: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 22:58:28: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.8.8.7[0] 2002-09-02 22:58:28: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2002-09-02 22:58:28: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.0.23.251[0] 2002-09-02 22:58:28: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 10.0.23.251[0] 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2002-09-02 22:58:28: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2002-09-02 22:58:28: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=44 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000024 01030401 b019d564 00000018 01030000 80050002 80010001 80020744 80040001 2002-09-02 22:58:28: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2002-09-02 22:58:28: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=36 2002-09-02 22:58:28: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2002-09-02 22:58:28: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=24 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x8000, lorv=1860 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2125:check_attr_ipsec(): life duration was in TLV. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2002-09-02 22:58:28: DEBUG: proposal.c:866:print_proppair0(): 0x80a4a30: next=0x0 tnext=0x0 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x80a4a30 2002-09-02 22:58:28: DEBUG: proposal.c:866:print_proppair0(): 0x80a4a30: next=0x0 tnext=0x0 2002-09-02 22:58:28: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x8000, lorv=1860 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2002-09-02 22:58:28: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=b019d564 spi_p=00000000 encmode=Tunnel reqid=0:0) 2002-09-02 22:58:28: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2002-09-02 22:58:28: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2002-09-02 22:58:28: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2002-09-02 22:58:28: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2002-09-02 22:58:28: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2002-09-02 22:58:28: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 193.94.194.98->165.227.249.5 2002-09-02 22:58:28: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2002-09-02 22:58:28: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 a313325d 94220000 02000100 02189a13 00000000 00000000 03000500 ff200000 10020000 c15ec262 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2002-09-02 22:58:28: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=35166739(0x2189a13) 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=44 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000024 01030401 00000000 00000018 01030000 80050002 80010001 80020744 80040001 2002-09-02 22:58:28: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2002-09-02 22:58:28: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=36 2002-09-02 22:58:28: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:28: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2002-09-02 22:58:28: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=24 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x8000, lorv=1860 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2125:check_attr_ipsec(): life duration was in TLV. 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2002-09-02 22:58:28: DEBUG: proposal.c:866:print_proppair0(): 0x80a4a30: next=0x0 tnext=0x0 2002-09-02 22:58:28: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2002-09-02 22:58:28: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 44, next type 10 2002-09-02 22:58:28: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 5 2002-09-02 22:58:28: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2002-09-02 22:58:28: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2002-09-02 22:58:28: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 5036cfda 8e99162b 2794d695 c99e2dc4 fee0e2ac 0a000030 00000001 00000001 00000024 01030401 02189a13 00000018 01030000 80050002 80010001 80020744 80040001 05000014 b29eed5a 5ffe2dc6 bd28000c af665570 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 2002-09-02 22:58:28: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:28: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 6b91c5c4 c792cd01 afe65069 c7baddb2 c5531598 2002-09-02 22:58:28: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2002-09-02 22:58:28: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:28: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2002-09-02 22:58:28: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 01000018 6b91c5c4 c792cd01 afe65069 c7baddb2 c5531598 0a000030 00000001 00000001 00000024 01030401 02189a13 00000018 01030000 80050002 80010001 80020744 80040001 05000014 b29eed5a 5ffe2dc6 bd28000c af665570 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 0007c303 2002-09-02 22:58:28: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2002-09-02 22:58:28: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:28: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 168965a2 f98a7fd3 2002-09-02 22:58:28: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): 168965a2 f98a7fd3 2002-09-02 22:58:28: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2002-09-02 22:58:28: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2002-09-02 22:58:28: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2002-09-02 22:58:28: DEBUG: sockmisc.c:361:sendfromto(): send packet to 193.94.194.98[500] 2002-09-02 22:58:28: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 148 bytes message will be sent. 2002-09-02 22:58:28: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 5036cfda 00000094 d87bf320 fbae8f1b 73df00e8 09291ad0 2d607c64 f94f238b f3276265 07bed731 8073cf0b c2ba2c21 9c390315 41a74a84 5362664a 9d7d1b59 c753672a 1e055879 c66fd102 ff89b19a 75f73685 23e84ac6 9b6656c9 b9e45cc8 9cef95d7 4fe52a49 36c8f8c7 bcee67f7 27048e2b f1ea13f2 168965a2 f98a7fd3 2002-09-02 22:58:29: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:29: DEBUG: isakmp.c:232:isakmp_handler(): 148 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 5036cfda 00000094 bf12db0a 2d128724 d2d90073 5dba91f8 22ea3381 2f873ac7 35b3fa80 275ba0c2 c6fa70f4 e4d04dbf 9c91de2c 8bd5b27b 5f34d674 efe07062 81c02113 7a008164 012586b0 0397bd97 7b56481a 3c5ba7f9 b7c3a84b 9f0b7e11 5e92b7c1 19100002 6715c66f b0c666fe 0fec5570 0239c1e6 d7251dec c7bb1d53 2002-09-02 22:58:29: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:29: DEBUG: isakmp.c:503:isakmp_main(): the packet retransmited by peer. 2002-09-02 22:58:29: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 22:58:29: DEBUG: isakmp.c:232:isakmp_handler(): 52 bytes message received from 193.94.194.98[500] 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 5036cfda 00000034 da44b12f e51df999 4bcc35bf 837200d5 996b5ab7 5680e9c7 2002-09-02 22:58:29: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:29: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2002-09-02 22:58:29: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 996b5ab7 5680e9c7 2002-09-02 22:58:29: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2002-09-02 22:58:29: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 22:58:29: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 996b5ab7 5680e9c7 2002-09-02 22:58:29: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 00000018 7d70cf21 5af83304 5b6ab98e ae631785 6c1a2606 2002-09-02 22:58:29: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=7 2002-09-02 22:58:29: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2002-09-02 22:58:29: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 5036cfda 00000034 00000018 7d70cf21 5af83304 5b6ab98e ae631785 6c1a2606 2002-09-02 22:58:29: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 22:58:29: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 22:58:29: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2002-09-02 22:58:29: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 22:58:29: DEBUG: isakmp_quick.c:1363:quick_r3recv(): HASH(3) validate:2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 7d70cf21 5af83304 5b6ab98e ae631785 6c1a2606 2002-09-02 22:58:29: DEBUG: oakley.c:659:oakley_compute_hash3(): HASH with: 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 005036cf da8e9916 2b2794d6 95c99e2d c4fee0e2 acb29eed 5a5ffe2d c6bd2800 0caf6655 70 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: oakley.c:669:oakley_compute_hash3(): HASH computed: 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 7d70cf21 5af83304 5b6ab98e ae631785 6c1a2606 2002-09-02 22:58:29: DEBUG: isakmp.c:713:quick_main(): === 2002-09-02 22:58:29: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 0302189a 138e9916 2b2794d6 95c99e2d c4fee0e2 acb29eed 5a5ffe2d c6bd2800 0caf6655 70 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2002-09-02 22:58:29: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 6f67938f e578f474 cb0129f6 db03bd2d d63c6181 c15a00af 890db914 418a8bef f1b7ac61 2154c462 12973911 c023236a f928c3aa e6b49cf7 d59dc3ab 2002-09-02 22:58:29: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 03b019d5 648e9916 2b2794d6 95c99e2d c4fee0e2 acb29eed 5a5ffe2d c6bd2800 0caf6655 70 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2002-09-02 22:58:29: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 75308f21 4760b300 3e226f62 dad4282e 0f831635 a5ad2b49 96f74ec5 de4f45a1 af589f6f 01fbb404 0f0358ec 7aa3cf90 5e6236de 9e772ed8 bbbd0ad0 2002-09-02 22:58:29: DEBUG: oakley.c:392:oakley_compute_keymat(): KEYMAT computed. 2002-09-02 22:58:29: DEBUG: isakmp_quick.c:1541:quick_r3prep(): call pk_sendupdate 2002-09-02 22:58:29: DEBUG: pfkey.c:985:pk_sendupdate(): call pfkey_send_update 2002-09-02 22:58:29: DEBUG: isakmp_quick.c:1546:quick_r3prep(): pfkey update sent. 2002-09-02 22:58:29: DEBUG: pfkey.c:1174:pk_sendadd(): call pfkey_send_add 2002-09-02 22:58:29: DEBUG: isakmp_quick.c:1553:quick_r3prep(): pfkey add sent. 2002-09-02 22:58:29: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey UPDATE message 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 02020003 14000000 a313325d 94220000 02000100 02189a13 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 c15ec262 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 04000300 00000000 00000000 00000000 44070000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 d0050000 00000000 00000000 000000002002-09-02 22:58:29: DEBUG: pfkey.c:1079:pk_recvupdate(): pfkey UPDATE succeeded: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=35166739(0x2189a13) 2002-09-02 22:58:29: INFO: pfkey.c:1086:pk_recvupdate(): IPsec-SA established: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=35166739(0x2189a13) 2002-09-02 22:58:29: DEBUG: pfkey.c:1118:pk_recvupdate(): === 2002-09-02 22:58:29: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey ADD message 2002-09-02 22:58:29: DEBUG: plog.c:204:plogdump(): 02030003 14000000 a313325d 94220000 02000100 b019d564 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 a5e3f905 00000000 00000000 03000600 ff200000 10020000 c15ec262 00000000 00000000 04000300 00000000 00000000 00000000 44070000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 d0050000 00000000 00000000 000000002002-09-02 22:58:29: INFO: pfkey.c:1246:pk_recvadd(): IPsec-SA established: ESP/Tunnel 165.227.249.5->193.94.194.98 spi=2954483044(0xb019d564) 2002-09-02 22:58:29: DEBUG: pfkey.c:1251:pk_recvadd(): === 2002-09-02 22:58:29: DEBUG: grabmyaddr.c:446:update_myaddrs(): msg 1 not interesting 2002-09-02 23:23:18: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey EXPIRE message 2002-09-02 23:23:18: DEBUG: plog.c:204:plogdump(): 02080003 14000200 a313325d 00000000 02000100 b019d564 04020303 00000000 02001300 02000000 00000000 00000000 04000200 04000000 80020000 00000000 854f743d 00000000 864f743d 00000000 04000400 00000000 00000000 00000000 d0050000 00000000 00000000 00000000 03000500 ff800000 10020000 a5e3f905 00000000 00000000 03000600 ff800000 10020000 c15ec262 00000000 000000002002-09-02 23:23:18: INFO: pfkey.c:1293:pk_recvexpire(): IPsec-SA expired: ESP/Tunnel 165.227.249.5->193.94.194.98 spi=2954483044(0xb019d564) 2002-09-02 23:23:18: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey EXPIRE message 2002-09-02 23:23:18: DEBUG: plog.c:204:plogdump(): 02080003 14000100 a313325d 00000000 02000100 02189a13 04020303 00000000 02001300 02000000 00000000 00000000 04000200 06000000 47030000 00000000 854f743d 00000000 864f743d 00000000 04000400 00000000 00000000 00000000 d0050000 00000000 00000000 00000000 03000500 ff800000 10020000 c15ec262 00000000 00000000 03000600 ff800000 10020000 a5e3f905 00000000 000000002002-09-02 23:23:18: INFO: pfkey.c:1293:pk_recvexpire(): IPsec-SA expired: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=35166739(0x2189a13) 2002-09-02 23:23:18: DEBUG: pfkey.c:1305:pk_recvexpire(): no such a SA found: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=35166739(0x2189a13) 2002-09-02 23:23:21: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 23:23:21: DEBUG: isakmp.c:232:isakmp_handler(): 148 bytes message received from 193.94.194.98[500] 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 01b60ec8 00000094 29d65998 2da80cde a14ef5cc 492db2f2 cea1ca24 263801dc e1ca40a7 8c7d35db f44ff2dc 2684a5b2 842746e9 c87109f5 717ad555 2c51c9a3 2194f298 95ecd970 16078ce2 8520e9ae e1a5f6b4 8fccb547 1ebb7768 0d5e9187 a8cbbc62 e13b4715 90f29343 4c95f13f f57d64ba ccb166de cd539af7 7b0f19de 2002-09-02 23:23:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 23:23:21: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2002-09-02 23:23:21: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): fa7d9e2d 9c0382b8 01b60ec8 2002-09-02 23:23:21: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2002-09-02 23:23:21: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbd0c0e6 89bda930 2002-09-02 23:23:21: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2002-09-02 23:23:21: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>193.94.194.98[0] 2002-09-02 23:23:21: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2002-09-02 23:23:21: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cd539af7 7b0f19de 2002-09-02 23:23:21: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2002-09-02 23:23:21: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 23:23:21: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cd539af7 7b0f19de 2002-09-02 23:23:21: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 01000018 b8f6fc36 a0fafba5 1fd92fd5 1f96f8ac 8ca95d2e 0a000030 00000001 00000001 00000024 01030401 b5961ff8 00000018 01030000 80050002 80010001 80020744 80040001 05000014 4e9246d4 c4588ae8 dac9a98b 4f6f4c70 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 00000000 2002-09-02 23:23:21: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2002-09-02 23:23:21: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2002-09-02 23:23:21: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 01b60ec8 00000094 01000018 b8f6fc36 a0fafba5 1fd92fd5 1f96f8ac 8ca95d2e 0a000030 00000001 00000001 00000024 01030401 b5961ff8 00000018 01030000 80050002 80010001 80020744 80040001 05000014 4e9246d4 c4588ae8 dac9a98b 4f6f4c70 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 00000000 2002-09-02 23:23:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2002-09-02 23:23:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 01000000 0a0017fb 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 01000000 0a080807 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): b8f6fc36 a0fafba5 1fd92fd5 1f96f8ac 8ca95d2e 2002-09-02 23:23:21: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 01b60ec8 0a000030 00000001 00000001 00000024 01030401 b5961ff8 00000018 01030000 80050002 80010001 80020744 80040001 05000014 4e9246d4 c4588ae8 dac9a98b 4f6f4c70 0500000c 01000000 0a0017fb 0000000c 01000000 0a0808072002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): b8f6fc36 a0fafba5 1fd92fd5 1f96f8ac 8ca95d2e 2002-09-02 23:23:21: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 10.0.23.251[0] prefixlen=32 ul_proto=255 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[0] prefixlen=32 ul_proto=255 2002-09-02 23:23:21: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd458: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 23:23:21: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 23:23:21: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.0.23.251[0] 2002-09-02 23:23:21: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 10.0.23.251[0] 2002-09-02 23:23:21: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.8.8.7[0] 2002-09-02 23:23:21: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2002-09-02 23:23:21: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd458: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 23:23:21: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 10.0.23.251/32[0] 10.8.8.7/32[0] proto=255 dir=1 2002-09-02 23:23:21: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd458: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 23:23:21: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 23:23:21: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.8.8.7[0] 2002-09-02 23:23:21: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2002-09-02 23:23:21: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd458 masked with /32: 10.0.23.251[0] 2002-09-02 23:23:21: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 10.0.23.251[0] 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[0] 10.0.23.251/32[0] proto=255 dir=2 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2002-09-02 23:23:21: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2002-09-02 23:23:21: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=44 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000024 01030401 b5961ff8 00000018 01030000 80050002 80010001 80020744 80040001 2002-09-02 23:23:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2002-09-02 23:23:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=36 2002-09-02 23:23:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2002-09-02 23:23:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=24 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x8000, lorv=1860 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2125:check_attr_ipsec(): life duration was in TLV. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2002-09-02 23:23:21: DEBUG: proposal.c:866:print_proppair0(): 0x80a4ac0: next=0x0 tnext=0x0 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x80a4ac0 2002-09-02 23:23:21: DEBUG: proposal.c:866:print_proppair0(): 0x80a4ac0: next=0x0 tnext=0x0 2002-09-02 23:23:21: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x8000, lorv=1860 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2002-09-02 23:23:21: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=b5961ff8 spi_p=00000000 encmode=Tunnel reqid=0:0) 2002-09-02 23:23:21: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2002-09-02 23:23:21: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2002-09-02 23:23:21: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2002-09-02 23:23:21: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2002-09-02 23:23:21: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2002-09-02 23:23:21: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 193.94.194.98->165.227.249.5 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2002-09-02 23:23:21: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 ba753c0f 94220000 02000100 05fea57d 00000000 00000000 03000500 ff200000 10020000 c15ec262 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2002-09-02 23:23:21: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=100574589(0x5fea57d) 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=44 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000024 01030401 00000000 00000018 01030000 80050002 80010001 80020744 80040001 2002-09-02 23:23:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2002-09-02 23:23:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=36 2002-09-02 23:23:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2002-09-02 23:23:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=24 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x8000, lorv=1860 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2125:check_attr_ipsec(): life duration was in TLV. 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2002-09-02 23:23:21: DEBUG: proposal.c:866:print_proppair0(): 0x80a4ac0: next=0x0 tnext=0x0 2002-09-02 23:23:21: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2002-09-02 23:23:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 44, next type 10 2002-09-02 23:23:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 5 2002-09-02 23:23:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2002-09-02 23:23:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2002-09-02 23:23:21: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 01b60ec8 4e9246d4 c4588ae8 dac9a98b 4f6f4c70 0a000030 00000001 00000001 00000024 01030401 05fea57d 00000018 01030000 80050002 80010001 80020744 80040001 05000014 edb194b0 99a66534 1deb89ad d7069368 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 96c46c70 6a9b583f 19f6c873 47599b4b af7b3f71 2002-09-02 23:23:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2002-09-02 23:23:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 23:23:21: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2002-09-02 23:23:21: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 01000018 96c46c70 6a9b583f 19f6c873 47599b4b af7b3f71 0a000030 00000001 00000001 00000024 01030401 05fea57d 00000018 01030000 80050002 80010001 80020744 80040001 05000014 edb194b0 99a66534 1deb89ad d7069368 0500000c 01000000 0a0017fb 0000000c 01000000 0a080807 167bc003 2002-09-02 23:23:21: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2002-09-02 23:23:21: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 23:23:21: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 02021dac 342bcd2a 2002-09-02 23:23:21: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 02021dac 342bcd2a 2002-09-02 23:23:21: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2002-09-02 23:23:21: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2002-09-02 23:23:21: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2002-09-02 23:23:21: DEBUG: sockmisc.c:361:sendfromto(): send packet to 193.94.194.98[500] 2002-09-02 23:23:21: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 148 bytes message will be sent. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 01b60ec8 00000094 7cd05be9 fb1a284e 84184dd3 1ab04dc6 d4b709b5 fcfed210 6de510d0 1caa670c 2e7a6453 fe9f0386 2089ef94 620d6a4c cb16f7d2 1fe44d4a 2375ae46 f84db0be ce3bd71e 15c1ef6f 44b35512 a8e96743 c76e5273 4ce0b5c1 9cd6b646 60c86ad1 10bea89d 1b9355ea 3c5fa070 4326220d 02021dac 342bcd2a 2002-09-02 23:23:21: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 23:23:21: DEBUG: isakmp.c:232:isakmp_handler(): 148 bytes message received from 193.94.194.98[500] 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 01b60ec8 00000094 29d65998 2da80cde a14ef5cc 492db2f2 cea1ca24 263801dc e1ca40a7 8c7d35db f44ff2dc 2684a5b2 842746e9 c87109f5 717ad555 2c51c9a3 2194f298 95ecd970 16078ce2 8520e9ae e1a5f6b4 8fccb547 1ebb7768 0d5e9187 a8cbbc62 e13b4715 90f29343 4c95f13f f57d64ba ccb166de cd539af7 7b0f19de 2002-09-02 23:23:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:503:isakmp_main(): the packet retransmited by peer. 2002-09-02 23:23:21: DEBUG: isakmp.c:231:isakmp_handler(): === 2002-09-02 23:23:21: DEBUG: isakmp.c:232:isakmp_handler(): 52 bytes message received from 193.94.194.98[500] 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 01b60ec8 00000034 3a138bd0 48f05811 b5ba11f0 0f5d27ac 4572d97b aa9da568 2002-09-02 23:23:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 23:23:21: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2002-09-02 23:23:21: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 4572d97b aa9da568 2002-09-02 23:23:21: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2002-09-02 23:23:21: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): d0a3e580 b63740dd 5391c585 86004c57 d7b8a73e fb3fe83e 2002-09-02 23:23:21: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 4572d97b aa9da568 2002-09-02 23:23:21: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 00000018 0f4c2c1d cbccd8a4 aa8518e5 82975eb2 fd77b736 2002-09-02 23:23:21: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=55 2002-09-02 23:23:21: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2002-09-02 23:23:21: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cbbb200a 4f530000 8587abd7 61244aa9 08102001 01b60ec8 00000034 00000018 0f4c2c1d cbccd8a4 aa8518e5 82975eb2 fd77b736 2002-09-02 23:23:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2002-09-02 23:23:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2002-09-02 23:23:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1363:quick_r3recv(): HASH(3) validate:2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 0f4c2c1d cbccd8a4 aa8518e5 82975eb2 fd77b736 2002-09-02 23:23:21: DEBUG: oakley.c:659:oakley_compute_hash3(): HASH with: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 0001b60e c84e9246 d4c4588a e8dac9a9 8b4f6f4c 70edb194 b099a665 341deb89 add70693 68 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:669:oakley_compute_hash3(): HASH computed: 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 0f4c2c1d cbccd8a4 aa8518e5 82975eb2 fd77b736 2002-09-02 23:23:21: DEBUG: isakmp.c:713:quick_main(): === 2002-09-02 23:23:21: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 0305fea5 7d4e9246 d4c4588a e8dac9a9 8b4f6f4c 70edb194 b099a665 341deb89 add70693 68 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2002-09-02 23:23:21: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 849f9c8c a0999489 5c890a2e 15795f32 0dda0fe5 863c169a 1ddb7f7d 4bbb5f2a f534251a f7c245e4 be16a8fd 8068fe3b 440b7ff5 fa23a58e a40b4d43 2002-09-02 23:23:21: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 03b5961f f84e9246 d4c4588a e8dac9a9 8b4f6f4c 70edb194 b099a665 341deb89 add70693 68 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2002-09-02 23:23:21: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): cd349041 83fe9eac 4de2661a 23187979 1cd0eedc a4e82114 85828494 9be8b817 b8145bcb 18c647a7 c9221bbb ed3c36e4 08e4c509 0e68a1d8 f644e9a5 2002-09-02 23:23:21: DEBUG: oakley.c:392:oakley_compute_keymat(): KEYMAT computed. 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1541:quick_r3prep(): call pk_sendupdate 2002-09-02 23:23:21: DEBUG: pfkey.c:985:pk_sendupdate(): call pfkey_send_update 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1546:quick_r3prep(): pfkey update sent. 2002-09-02 23:23:21: DEBUG: pfkey.c:1174:pk_sendadd(): call pfkey_send_add 2002-09-02 23:23:21: DEBUG: isakmp_quick.c:1553:quick_r3prep(): pfkey add sent. 2002-09-02 23:23:21: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey UPDATE message 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 02020003 14000000 ba753c0f 94220000 02000100 05fea57d 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 c15ec262 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 04000300 00000000 00000000 00000000 44070000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 d0050000 00000000 00000000 000000002002-09-02 23:23:21: DEBUG: pfkey.c:1079:pk_recvupdate(): pfkey UPDATE succeeded: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=100574589(0x5fea57d) 2002-09-02 23:23:21: INFO: pfkey.c:1086:pk_recvupdate(): IPsec-SA established: ESP/Tunnel 193.94.194.98->165.227.249.5 spi=100574589(0x5fea57d) 2002-09-02 23:23:21: DEBUG: pfkey.c:1118:pk_recvupdate(): === 2002-09-02 23:23:21: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey ADD message 2002-09-02 23:23:21: DEBUG: plog.c:204:plogdump(): 02030003 14000000 ba753c0f 94220000 02000100 b5961ff8 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 a5e3f905 00000000 00000000 03000600 ff200000 10020000 c15ec262 00000000 00000000 04000300 00000000 00000000 00000000 44070000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 d0050000 00000000 00000000 000000002002-09-02 23:23:21: INFO: pfkey.c:1246:pk_recvadd(): IPsec-SA established: ESP/Tunnel 165.227.249.5->193.94.194.98 spi=3046514680(0xb5961ff8) 2002-09-02 23:23:21: DEBUG: pfkey.c:1251:pk_recvadd(): ===