2001-09-13 15:11:09: INFO: main.c:126:main(): @(#)racoon 20001216 sakane@ydc.co.jp 2001-09-13 15:11:09: INFO: main.c:127:main(): @(#)This product linked software developed by the OpenSSL Project for use in the OpenSSL Toolkit. (http://www.openssl.org/) 2001-09-13 15:11:09: DEBUG: pfkey.c:351:pfkey_init(): call pfkey_send_register 2001-09-13 15:11:09: DEBUG: pfkey.c:360:pfkey_init(): call pfkey_send_register 2001-09-13 15:11:09: DEBUG: pfkey.c:369:pfkey_init(): call pfkey_send_register 2001-09-13 15:11:09: DEBUG2: cftoken.l:119:yylex(): begin <5>path 2001-09-13 15:11:09: DEBUG2: cftoken.l:122:yylex(): <5>2001-09-13 15:11:09: DEBUG2: cftoken.l:457:yylex(): <5>2001-09-13 15:11:09: DEBUG2: cftoken.l:126:yylex(): begin <3>; 2001-09-13 15:11:09: DEBUG2: cftoken.l:119:yylex(): begin <5>path 2001-09-13 15:11:09: DEBUG2: cftoken.l:124:yylex(): <5>2001-09-13 15:11:09: DEBUG2: cftoken.l:457:yylex(): <5>2001-09-13 15:11:09: DEBUG2: cftoken.l:126:yylex(): begin <3>; 2001-09-13 15:11:09: DEBUG2: cftoken.l:156:yylex(): begin <13>listen 2001-09-13 15:11:09: DEBUG2: cftoken.l:158:yylex(): <13>2001-09-13 15:11:09: DEBUG2: cftoken.l:472:yylex(): <13>2001-09-13 15:11:09: DEBUG2: cftoken.l:348:yylex(): <13>2001-09-13 15:11:09: DEBUG2: cftoken.l:160:yylex(): <13>2001-09-13 15:11:09: DEBUG2: cftoken.l:255:yylex(): begin <33>remote 2001-09-13 15:11:09: DEBUG2: cftoken.l:256:yylex(): <33>2001-09-13 15:11:09: DEBUG2: cftoken.l:260:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:263:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:285:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:287:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:274:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:275:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:457:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:457:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:272:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:407:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:457:yylex(): <35>2001-09-13 15:11:09: DEBUG2: cftoken.l:295:yylex(): begin <37>proposal 2001-09-13 15:11:09: DEBUG2: cftoken.l:305:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:368:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:307:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:385:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:306:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:395:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:308:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:391:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:295:yylex(): begin <37>proposal 2001-09-13 15:11:09: DEBUG2: cftoken.l:305:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:368:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:307:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:385:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:306:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:396:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:308:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cftoken.l:391:yylex(): <37>2001-09-13 15:11:09: DEBUG2: cfparse.y:1722:set_isakmp_proposal(): lifetime = 28800 2001-09-13 15:11:09: DEBUG2: cfparse.y:1725:set_isakmp_proposal(): lifebyte = 0 2001-09-13 15:11:09: DEBUG2: cfparse.y:1728:set_isakmp_proposal(): strength=extra high 2001-09-13 15:11:09: DEBUG2: cfparse.y:1730:set_isakmp_proposal(): encklen=0 2001-09-13 15:11:09: DEBUG2: cfparse.y:1912:expand_isakmpspec(): p:1 t:1 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 3DES-CBC(5) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): SHA(2) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 1024-bit MODP group(2) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): pre-shared key(1) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1923:expand_isakmpspec(): 2001-09-13 15:11:09: DEBUG2: cfparse.y:1722:set_isakmp_proposal(): lifetime = 28800 2001-09-13 15:11:09: DEBUG2: cfparse.y:1725:set_isakmp_proposal(): lifebyte = 0 2001-09-13 15:11:09: DEBUG2: cfparse.y:1728:set_isakmp_proposal(): strength=extra high 2001-09-13 15:11:09: DEBUG2: cfparse.y:1730:set_isakmp_proposal(): encklen=0 2001-09-13 15:11:09: DEBUG2: cfparse.y:1912:expand_isakmpspec(): p:1 t:1 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 3DES-CBC(5) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): SHA(2) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 1024-bit MODP group(2) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1916:expand_isakmpspec(): RSA signatures(3) 2001-09-13 15:11:09: DEBUG2: cfparse.y:1923:expand_isakmpspec(): 2001-09-13 15:11:09: DEBUG2: cftoken.l:235:yylex(): begin <29>sainfo 2001-09-13 15:11:09: DEBUG2: cftoken.l:236:yylex(): <29>2001-09-13 15:11:09: DEBUG2: cftoken.l:249:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:368:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:250:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:381:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:246:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:247:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:427:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:416:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:243:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:391:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:251:yylex(): <31>2001-09-13 15:11:09: DEBUG2: cftoken.l:388:yylex(): <31>2001-09-13 15:11:09: WARNING: pfkey.c:1977:pk_checkalg(): compression algorithm can not be checked. 2001-09-13 15:11:09: DEBUG2: cfparse.y:2005:cfparse(): parse successed. 2001-09-13 15:11:09: INFO: isakmp.c:1250:isakmp_open(): 165.227.249.5[500] used as isakmp port (fd=6) 2001-09-13 15:11:09: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey X_SPDDUMP message 2001-09-13 15:11:09: DEBUG: plog.c:204:plogdump(): 02120000 0f000100 01000000 85710000 03000500 ff200000 10020000 09090909 00000000 00000000 03000600 ff200000 10020000 0a080807 00000000 00000000 07001200 02000100 1b000000 00000000 28003200 02020000 10020000 40f53939 00000000 00000000 10020000 a5e3f905 00000000 00000000 2001-09-13 15:11:09: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey X_SPDDUMP message 2001-09-13 15:11:09: DEBUG: plog.c:204:plogdump(): 02120000 0f000100 00000000 85710000 03000500 ff200000 10020000 0a080807 00000000 00000000 03000600 ff200000 10020000 09090909 00000000 00000000 07001200 02000200 1c000000 00000000 28003200 02020000 10020000 a5e3f905 00000000 00000000 10020000 40f53939 00000000 00000000 2001-09-13 15:11:09: DEBUG: policy.c:181:cmpspidx(): sub:0xbfbfd64c: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:09: DEBUG: policy.c:182:cmpspidx(): db :0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:12: DEBUG: grabmyaddr.c:452:update_myaddrs(): caught rtm:15, need update interface address list 2001-09-13 15:11:12: DEBUG: grabmyaddr.c:446:update_myaddrs(): msg 14 not interesting 2001-09-13 15:11:21: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:21: DEBUG: isakmp.c:232:isakmp_handler(): 92 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 00000000 00000000 01100200 00000000 0000005c 0d000034 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 0000000c 09002689 dfd6b712 2001-09-13 15:11:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:21: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 64.245.57.57[500]. 2001-09-13 15:11:21: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2001-09-13 15:11:21: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>64.245.57.57[500] 2001-09-13 15:11:21: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2001-09-13 15:11:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-09-13 15:11:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-09-13 15:11:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:21: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-09-13 15:11:21: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 2001-09-13 15:11:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:11:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-09-13 15:11:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:11:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x8000, lorv=180 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:11:21: DEBUG: proposal.c:866:print_proppair0(): 0x8097370: next=0x0 tnext=0x0 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=1, prot-id=ISAKMP, spi-size=0, #trns=1 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=1, trns-id=IKE 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x8000, lorv=180 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:180) 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2001-09-13 15:11:21: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2001-09-13 15:11:21: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: 69c674d59fc738ba 2001-09-13 15:11:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 48, next type 0 2001-09-13 15:11:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:21: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:21: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:21: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:21: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 80 bytes message will be sent. 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 01100200 00000000 00000050 00000034 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 2001-09-13 15:11:21: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:21: DEBUG: isakmp.c:232:isakmp_handler(): 180 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 04100200 00000000 000000b4 0a000084 4c88ad45 454b43fb 419b56b1 5c87bb29 736595e2 c32f60f3 a3c8191c f8c2b455 3632c3fa 2ddbda25 60afd560 3fabc846 0d78e7e4 128fa709 f95060fb 87a5835b 63e76a94 a3335844 82223d47 47ba60be ea57ab93 a633cd62 ee8e5816 88c46e36 2190336c 7671c4b4 315732e6 bad765e8 9b08254e 75807ea4 d61b46e1 ab0e964d 00000014 bee54e6e 1d87dc19 9d93e07e 6846eb6a 2001-09-13 15:11:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:21: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-09-13 15:11:21: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-09-13 15:11:21: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:21: DEBUG: isakmp.c:609:ph1_main(): === 2001-09-13 15:11:21: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 7ba0d346 d2ddb51e 6722a5b4 556b8fe1 4c59d116 1ff68d05 341c67ab f9925096 db3b376c ef3013fc f7f237ab 0973511e b2b361dd d7e9effc 9f425868 2db2a121 160df056 91f12bfa cc36313c 7462cdde 78b3be8a 33cad26d f0600c92 1826d926 06e34451 648f85f4 9cd42335 672f3c4a 84ad258c fb6c869a 71b6642e d881744a2001-09-13 15:11:21: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 3c5f9b39 ec595d5e 5193ada2 06cb9c1b 300d15bd a998fe7f 8d2b7ddf dd8365ac d85afc45 470b4ecc 55cf398d 97b4114a c40079a0 913bb519 f1e215dc 1ddbc669 7dfeb093 b813aeba 4eac13d7 6f68c7bf 33ba8e04 af4e1b77 0127c68b f35e732b 59fa54a0 d30bc57a 9464103d 0eaf8281 2e19fcf4 192e8486 3e0c58b9 f27d9ff12001-09-13 15:11:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2001-09-13 15:11:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2001-09-13 15:11:21: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 0 2001-09-13 15:11:21: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:21: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:21: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:21: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:21: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 200 bytes message will be sent. 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 04100200 00000000 000000c8 0a000084 3c5f9b39 ec595d5e 5193ada2 06cb9c1b 300d15bd a998fe7f 8d2b7ddf dd8365ac d85afc45 470b4ecc 55cf398d 97b4114a c40079a0 913bb519 f1e215dc 1ddbc669 7dfeb093 b813aeba 4eac13d7 6f68c7bf 33ba8e04 af4e1b77 0127c68b f35e732b 59fa54a0 d30bc57a 9464103d 0eaf8281 2e19fcf4 192e8486 3e0c58b9 f27d9ff1 0d000014 c8c83dac 797cb3bd 3c5ab130 bcfc42c9 00000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 2001-09-13 15:11:21: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): a2d984d1 926594db 632748bb 25946a66 6e800fb8 8e969d9d a316808c cd7d1f4d e74c4f9f 6652866e e02d002d cccdb39e 864cf02d 0be17e5d 911c36c3 0f3a311b 4c733229 de30c588 7b7af7c8 74f8e3ca 18544821 73056f8f 8b1091e8 a880742b c36b5cdd cfc37c84 88c82e8f a49a5741 69ae70d2 2018b713 e7a9d7fa 9c0d793c2001-09-13 15:11:21: DEBUG: oakley.c:1924:oakley_skeyid(): psk found: 2001-09-13 15:11:21: DEBUG2: plog.c:204:plogdump(): 6d656b6d 69746173 6469676f 6174 2001-09-13 15:11:21: DEBUG: oakley.c:1938:oakley_skeyid(): nonce 1: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): bee54e6e 1d87dc19 9d93e07e 6846eb6a 2001-09-13 15:11:21: DEBUG: oakley.c:1944:oakley_skeyid(): nonce 2: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): c8c83dac 797cb3bd 3c5ab130 bcfc42c9 2001-09-13 15:11:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:21: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 9c1361b9 1bdb2269 2ab7a518 f569238b cbe406cf 2001-09-13 15:11:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:21: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): e5a39eb5 5e5e306e 07d18444 13f570e9 dcb67960 2001-09-13 15:11:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:21: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): e2acbcd5 555ffccc b88043bc 9b8f20c7 646093a9 2001-09-13 15:11:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:21: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 25eabb3a 75b98f25 2a89d775 79c76e20 9cbea585 2001-09-13 15:11:21: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2001-09-13 15:11:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:21: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 00 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 2001-09-13 15:11:21: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:21: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 270f6387 35b476ad df63a513 98de2459 95009d7a 2001-09-13 15:11:21: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 270f6387 2001-09-13 15:11:21: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:11:21: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2001-09-13 15:11:21: DEBUG: plog.c:204:plogdump(): 21161d36 bcfc7d6e 2001-09-13 15:11:22: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:22: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 05100201 00000000 00000044 5ac0e081 4cb76e31 a9b26f01 4e031b93 56e4b02e ccccdaa8 fd3e7a50 cb1136e0 3edb320d 4d898191 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:22: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 3edb320d 4d898191 2001-09-13 15:11:22: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:22: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 270f6387 2001-09-13 15:11:22: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 3edb320d 4d898191 2001-09-13 15:11:22: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 0800000c 01000000 40f53939 00000018 c2344faa dc54df3f 597b8b88 2919c21b 3b080c6d 00000000 2001-09-13 15:11:22: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2001-09-13 15:11:22: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:22: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 05100201 00000000 00000044 0800000c 01000000 40f53939 00000018 c2344faa dc54df3f 597b8b88 2919c21b 3b080c6d 00000000 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: oakley.c:1123:oakley_validate_auth(): HASH received:2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): c2344faa dc54df3f 597b8b88 2919c21b 3b080c6d 2001-09-13 15:11:22: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 4c88ad45 454b43fb 419b56b1 5c87bb29 736595e2 c32f60f3 a3c8191c f8c2b455 3632c3fa 2ddbda25 60afd560 3fabc846 0d78e7e4 128fa709 f95060fb 87a5835b 63e76a94 a3335844 82223d47 47ba60be ea57ab93 a633cd62 ee8e5816 88c46e36 2190336c 7671c4b4 315732e6 bad765e8 9b08254e 75807ea4 d61b46e1 ab0e964d 3c5f9b39 ec595d5e 5193ada2 06cb9c1b 300d15bd a998fe7f 8d2b7ddf dd8365ac d85afc45 470b4ecc 55cf398d 97b4114a c40079a0 913bb519 f1e215dc 1ddbc669 7dfeb093 b813aeba 4eac13d7 6f68c7bf 33ba8e04 af4e1b77 0127c68b f35e732b 59fa54a0 d30bc57a 9464103d 0eaf8281 2e19fcf4 192e8486 3e0c58b9 f27d9ff1 42281fd5 783d95eb 69c674d5 9fc738ba 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 01000000 40f53939 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): c2344faa dc54df3f 597b8b88 2919c21b 3b080c6d 2001-09-13 15:11:22: DEBUG: oakley.c:1154:oakley_validate_auth(): HASH for PSK validated. 2001-09-13 15:11:22: DEBUG: isakmp_ident.c:1192:ident_r3recv(): peer's ID 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 01000000 40f53939 2001-09-13 15:11:22: DEBUG: isakmp.c:609:ph1_main(): === 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:3156:ipsecdoi_setid1(): use ID type of IPv4_address 2001-09-13 15:11:22: DEBUG: isakmp_ident.c:1270:ident_r3send(): generate HASH_R 2001-09-13 15:11:22: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 3c5f9b39 ec595d5e 5193ada2 06cb9c1b 300d15bd a998fe7f 8d2b7ddf dd8365ac d85afc45 470b4ecc 55cf398d 97b4114a c40079a0 913bb519 f1e215dc 1ddbc669 7dfeb093 b813aeba 4eac13d7 6f68c7bf 33ba8e04 af4e1b77 0127c68b f35e732b 59fa54a0 d30bc57a 9464103d 0eaf8281 2e19fcf4 192e8486 3e0c58b9 f27d9ff1 4c88ad45 454b43fb 419b56b1 5c87bb29 736595e2 c32f60f3 a3c8191c f8c2b455 3632c3fa 2ddbda25 60afd560 3fabc846 0d78e7e4 128fa709 f95060fb 87a5835b 63e76a94 a3335844 82223d47 47ba60be ea57ab93 a633cd62 ee8e5816 88c46e36 2190336c 7671c4b4 315732e6 bad765e8 9b08254e 75807ea4 d61b46e1 ab0e964d 69c674d5 9fc738ba 42281fd5 783d95eb 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 011101f4 a5e3f905 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 72065ba5 49fab0be 196d07c0 c35f8cf6 2075afd7 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 8 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 0 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-09-13 15:11:22: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 0800000c 011101f4 a5e3f905 00000018 72065ba5 49fab0be 196d07c0 c35f8cf6 2075afd7 92197503 2001-09-13 15:11:22: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-09-13 15:11:22: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 270f6387 2001-09-13 15:11:22: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): e1ab41f6 089c6679 2001-09-13 15:11:22: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): e1ab41f6 089c6679 2001-09-13 15:11:22: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-09-13 15:11:22: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 68 bytes message will be sent. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 05100201 00000000 00000044 8bbfc65d 112e43d8 fdb48010 35aece78 b5115b1d 12d26bd8 6c214370 53d1ce16 e1ab41f6 089c6679 2001-09-13 15:11:22: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-09-13 15:11:22: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): e1ab41f6 089c6679 6d1d1565 2001-09-13 15:11:22: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:11:22: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 308e999e 017cf669 2001-09-13 15:11:22: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 6d1d1565 0000001c 00000001 01106002 42281fd5 783d95eb 69c674d5 9fc738ba2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): b76d35ed 723c92b9 8c4148f5 ecfe7a35 350eb0c7 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-09-13 15:11:22: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 0b000018 b76d35ed 723c92b9 8c4148f5 ecfe7a35 350eb0c7 0000001c 00000001 01106002 42281fd5 783d95eb 69c674d5 9fc738ba e6148b03 2001-09-13 15:11:22: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-09-13 15:11:22: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 270f6387 2001-09-13 15:11:22: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 3d2afb43 6b8d5462 2001-09-13 15:11:22: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 3d2afb43 6b8d5462 2001-09-13 15:11:22: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-09-13 15:11:22: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 08100501 6d1d1565 00000054 2b20c28a d6f091a7 cf4b22c6 16ca2f5f 7f21eb56 172bbcf2 db9a7678 5a77cf47 4187bd8d 5cfafd31 c6075b18 9b57e562 3d2afb43 6b8d5462 2001-09-13 15:11:22: DEBUG: isakmp_inf.c:633:isakmp_info_send_common(): sendto Information notify. 2001-09-13 15:11:22: INFO: isakmp.c:2273:log_ph1established(): ISAKMP-SA established 165.227.249.5[500]-64.245.57.57[500] spi:42281fd5783d95eb:69c674d59fc738ba 2001-09-13 15:11:22: DEBUG: isakmp.c:649:ph1_main(): === 2001-09-13 15:11:22: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:22: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 08100501 6c9dbbcf 00000044 48ea89e9 fa2a5425 77addc2d f9eed72b 3fab3615 3a258ad1 53168220 e0427c45 b9fa0e61 d4ff061d 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: isakmp_inf.c:114:isakmp_info_recv(): receive Information. 2001-09-13 15:11:22: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-09-13 15:11:22: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): e1ab41f6 089c6679 6c9dbbcf 2001-09-13 15:11:22: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:11:22: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): e9b10983 fd494355 2001-09-13 15:11:22: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:22: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): b9fa0e61 d4ff061d 2001-09-13 15:11:22: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:22: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 1cfca1d6 2d75ddbf b96951fd 15c3591f 219966f6 270f6387 2001-09-13 15:11:22: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): b9fa0e61 d4ff061d 2001-09-13 15:11:22: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 0b000018 147dc8a5 6709947f 6d148850 f75088cb 7ad4cf9d 0000000c 00000001 01006002 00000000 2001-09-13 15:11:22: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2001-09-13 15:11:22: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:22: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 42281fd5 783d95eb 69c674d5 9fc738ba 08100501 6c9dbbcf 00000044 0b000018 147dc8a5 6709947f 6d148850 f75088cb 7ad4cf9d 0000000c 00000001 01006002 00000000 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=11(notify) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: isakmp_inf.c:797:isakmp_info_recv_n(): notification message 24578:INITIAL-CONTACT, doi=1 proto_id=1 spi=(size=0). 2001-09-13 15:11:22: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:22: DEBUG: isakmp.c:232:isakmp_handler(): 92 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 00000000 00000000 01100200 00000000 0000005c 0d000034 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 0000000c 09002689 dfd6b712 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 64.245.57.57[500]. 2001-09-13 15:11:22: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2001-09-13 15:11:22: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>64.245.57.57[500] 2001-09-13 15:11:22: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-09-13 15:11:22: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x8000, lorv=180 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:11:22: DEBUG: proposal.c:866:print_proppair0(): 0x80976d0: next=0x0 tnext=0x0 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=1, prot-id=ISAKMP, spi-size=0, #trns=1 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=1, trns-id=IKE 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x8000, lorv=180 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:180) 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2001-09-13 15:11:22: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: fa3be20a77de695a 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 48, next type 0 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 80 bytes message will be sent. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 01100200 00000000 00000050 00000034 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 2001-09-13 15:11:22: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:22: DEBUG: isakmp.c:232:isakmp_handler(): 180 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 04100200 00000000 000000b4 0a000084 f5e6c905 487d257c 3ad1f171 5dc29d68 4e215e67 7d2575b8 92081ce9 c0277d00 9e019d8d 89fafe51 0b4c6a99 ee1ad4bc 7a4ea909 ea7ae787 01476495 7fbc81fb 15a34a01 393ec6e2 32732eb5 6a656ea8 34da97e0 7fc45b60 70773908 5c8b5331 7b44664f 19335fcd d401ef72 37c21ab7 aeb7dd45 4e39664e 301c6d98 f77c502f 00000014 015171d7 17c2a17f ca22305c cba37932 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: isakmp.c:609:ph1_main(): === 2001-09-13 15:11:22: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 6f574372 33477e5e d691812e 76aaab19 be975838 28d1df6b f69c5f61 2494451f 4f1d96f2 c0355870 0ba7670e dc813416 3d01c76c d9196845 0e4fc0a1 0eb91924 5721e818 2788c12d a2b76637 47b823c6 9c8e2c35 a1d04922 68148b85 8b6e3fef a6e0a5ff 33cae934 e7c180bf 5c136a40 80ea14c1 192fa35d 6b128d52 d1f668842001-09-13 15:11:22: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): a49ffe6a 8b64b119 fd7b59af 92db41a7 54098f57 78cf725d 5750e15a 14f1133e 5c1d665b 2aab2e83 258b9416 053c6839 2825d82c 3df88272 9aaa0062 8046e53e b303ff3a 5c787927 b8fc0b27 b43c5ab0 ca2215b6 cf7abb93 d3f13a7d 52516333 f1cc8556 1bb942a7 e74b8607 cb054ebc dda9508f 6d71f174 e24e0439 fd4d35392001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 0 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 200 bytes message will be sent. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 04100200 00000000 000000c8 0a000084 a49ffe6a 8b64b119 fd7b59af 92db41a7 54098f57 78cf725d 5750e15a 14f1133e 5c1d665b 2aab2e83 258b9416 053c6839 2825d82c 3df88272 9aaa0062 8046e53e b303ff3a 5c787927 b8fc0b27 b43c5ab0 ca2215b6 cf7abb93 d3f13a7d 52516333 f1cc8556 1bb942a7 e74b8607 cb054ebc dda9508f 6d71f174 e24e0439 fd4d3539 0d000014 ecc7f0f7 fac16669 612ed977 189a5616 00000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 2001-09-13 15:11:22: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): cfe1bc81 5ebf436c 4191c97f 7d8d5236 5a9ab97d b9c97226 0afcb712 d60c3232 a1ecce26 a473d579 807ca5dc 2c35d7c8 c8bd423d 2c8421a0 b6707aa2 882ae178 2fff5df0 825b41db c8e9e5bc d93c988c 69d6079e 737375ad 02b0ec19 fa363495 734364ec 9e507322 73fb45c9 0313d5f5 aeb9ad84 b16c862d da6f4b8e 931ee9182001-09-13 15:11:22: DEBUG: oakley.c:1924:oakley_skeyid(): psk found: 2001-09-13 15:11:22: DEBUG2: plog.c:204:plogdump(): 6d656b6d 69746173 6469676f 6174 2001-09-13 15:11:22: DEBUG: oakley.c:1938:oakley_skeyid(): nonce 1: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 015171d7 17c2a17f ca22305c cba37932 2001-09-13 15:11:22: DEBUG: oakley.c:1944:oakley_skeyid(): nonce 2: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): ecc7f0f7 fac16669 612ed977 189a5616 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8bd6455b 6e41baca a48c786b 20fdeda3 8f32873f 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 4af90bcf 5a2d3055 4dab91f3 e36a251f d07db77c 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): ca7b9613 b78e62ae cefeb14d d94329a2 1f585798 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 46d08ce6 295b1b06 e4880017 6aed2a65 abb50d38 2001-09-13 15:11:22: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 00 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 6d71963e 3c4c4770 e9311fae ed222c44 c0071db7 2001-09-13 15:11:22: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:22: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:11:22: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 53aaba4f 990ddc99 2001-09-13 15:11:22: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:22: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 05100201 00000000 00000044 5ffbd12c c277b591 5861c715 cee27edd dd7b0ac0 ed8e2bed ba5956c6 7e828370 5db1b51c 51e7e5a5 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:22: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 5db1b51c 51e7e5a5 2001-09-13 15:11:22: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:22: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:22: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 5db1b51c 51e7e5a5 2001-09-13 15:11:22: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 0800000c 01000000 40f53939 00000018 a9f03fd0 bcf78591 d7610469 94841827 901b4f27 00000000 2001-09-13 15:11:22: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2001-09-13 15:11:22: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:22: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 05100201 00000000 00000044 0800000c 01000000 40f53939 00000018 a9f03fd0 bcf78591 d7610469 94841827 901b4f27 00000000 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:11:22: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:22: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:22: DEBUG: oakley.c:1123:oakley_validate_auth(): HASH received:2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): a9f03fd0 bcf78591 d7610469 94841827 901b4f27 2001-09-13 15:11:22: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): f5e6c905 487d257c 3ad1f171 5dc29d68 4e215e67 7d2575b8 92081ce9 c0277d00 9e019d8d 89fafe51 0b4c6a99 ee1ad4bc 7a4ea909 ea7ae787 01476495 7fbc81fb 15a34a01 393ec6e2 32732eb5 6a656ea8 34da97e0 7fc45b60 70773908 5c8b5331 7b44664f 19335fcd d401ef72 37c21ab7 aeb7dd45 4e39664e 301c6d98 f77c502f a49ffe6a 8b64b119 fd7b59af 92db41a7 54098f57 78cf725d 5750e15a 14f1133e 5c1d665b 2aab2e83 258b9416 053c6839 2825d82c 3df88272 9aaa0062 8046e53e b303ff3a 5c787927 b8fc0b27 b43c5ab0 ca2215b6 cf7abb93 d3f13a7d 52516333 f1cc8556 1bb942a7 e74b8607 cb054ebc dda9508f 6d71f174 e24e0439 fd4d3539 8e79d080 d471d534 fa3be20a 77de695a 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 01000000 40f53939 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): a9f03fd0 bcf78591 d7610469 94841827 901b4f27 2001-09-13 15:11:22: DEBUG: oakley.c:1154:oakley_validate_auth(): HASH for PSK validated. 2001-09-13 15:11:22: DEBUG: isakmp_ident.c:1192:ident_r3recv(): peer's ID 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 01000000 40f53939 2001-09-13 15:11:22: DEBUG: isakmp.c:609:ph1_main(): === 2001-09-13 15:11:22: DEBUG: ipsec_doi.c:3156:ipsecdoi_setid1(): use ID type of IPv4_address 2001-09-13 15:11:22: DEBUG: isakmp_ident.c:1270:ident_r3send(): generate HASH_R 2001-09-13 15:11:22: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): a49ffe6a 8b64b119 fd7b59af 92db41a7 54098f57 78cf725d 5750e15a 14f1133e 5c1d665b 2aab2e83 258b9416 053c6839 2825d82c 3df88272 9aaa0062 8046e53e b303ff3a 5c787927 b8fc0b27 b43c5ab0 ca2215b6 cf7abb93 d3f13a7d 52516333 f1cc8556 1bb942a7 e74b8607 cb054ebc dda9508f 6d71f174 e24e0439 fd4d3539 f5e6c905 487d257c 3ad1f171 5dc29d68 4e215e67 7d2575b8 92081ce9 c0277d00 9e019d8d 89fafe51 0b4c6a99 ee1ad4bc 7a4ea909 ea7ae787 01476495 7fbc81fb 15a34a01 393ec6e2 32732eb5 6a656ea8 34da97e0 7fc45b60 70773908 5c8b5331 7b44664f 19335fcd d401ef72 37c21ab7 aeb7dd45 4e39664e 301c6d98 f77c502f fa3be20a 77de695a 8e79d080 d471d534 00000001 00000001 00000028 01010001 00000020 01010000 80010005 80020002 80030001 80040002 800b0001 800c00b4 011101f4 a5e3f905 2001-09-13 15:11:22: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:22: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 202b17c0 10a89ba0 03b71d69 f93f2e86 49cd922c 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 8 2001-09-13 15:11:22: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 0 2001-09-13 15:11:22: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:22: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-09-13 15:11:22: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 0800000c 011101f4 a5e3f905 00000018 202b17c0 10a89ba0 03b71d69 f93f2e86 49cd922c 1d3ae203 2001-09-13 15:11:22: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-09-13 15:11:22: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:22: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 38b85b17 99f9af80 2001-09-13 15:11:22: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 38b85b17 99f9af80 2001-09-13 15:11:22: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-09-13 15:11:22: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:22: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:22: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 68 bytes message will be sent. 2001-09-13 15:11:22: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 05100201 00000000 00000044 a79ac8a4 3b858b48 d71e641b ed36ba9c 746b3694 3155f7ee 968f6172 4eba5437 38b85b17 99f9af80 2001-09-13 15:11:22: INFO: isakmp.c:2273:log_ph1established(): ISAKMP-SA established 165.227.249.5[500]-64.245.57.57[500] spi:8e79d080d471d534:fa3be20a77de695a 2001-09-13 15:11:22: DEBUG: isakmp.c:649:ph1_main(): === 2001-09-13 15:11:26: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:26: DEBUG: isakmp.c:232:isakmp_handler(): 284 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 bd716464 0000011c 4cfcfb09 200e04eb 6a973556 e6fb6e67 3b319aee b02f6fed 25ccf855 c4217a0a ef6accbe 9ae434c8 fc7cc337 869caba6 361877e2 1c880fb0 3dafe2b3 67b5c059 26e6c915 64163b9a dbc45328 a3e163be d630270b 3d68c619 f399499c e4cbaabb a219be47 1f2ae8a5 8eca4ea1 21119df6 1d1d1e71 b61634fd 079a2124 e6e70960 5e9a0b59 302c59e5 fad78919 bd90c013 9f8e9333 f645bfad f9bac1a9 9ab43f2f b47d8886 534d4b8a 88348674 01690c58 2e5e8b11 09da44e8 4dec74b4 6add940b 7e6f52cc 0f3512d4 ec75d747 d0b9b1e0 1a5829f5 da3eda1e 20871960 f315ebc4 447643ba 27f2262f 691b2c29 9c60c986 20b0eef1 c4064b88 87c5d7d1 7b7fdfd6 2001-09-13 15:11:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:26: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-09-13 15:11:26: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 38b85b17 99f9af80 bd716464 2001-09-13 15:11:26: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:11:26: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 73bca480 b1ba0abd 2001-09-13 15:11:26: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2001-09-13 15:11:26: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>64.245.57.57[0] 2001-09-13 15:11:26: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:26: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 87c5d7d1 7b7fdfd6 2001-09-13 15:11:26: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:26: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:26: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 87c5d7d1 7b7fdfd6 2001-09-13 15:11:26: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 01000018 5057b26e f315faaf 7f0a5fef 67d246b7 f8f1a772 0a000038 00000001 00000001 0000002c 01030401 2ba14151 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 7edb3717 b5ab6c1a 3b23c152 dc88a02b 05000084 61f82d2f b4584ae3 7c8bd1ba bde795dd 81f58386 eaeacb3f f1ab9370 ada04aed c04c3088 e535e45c a96aff93 435ffa48 539aad38 0c7f5da1 cfc8085a 3bd7b3f7 5d2131a9 14f7ca98 d7afc155 7eace3f0 421b1ef1 3d906440 7995c163 807e1769 f79df173 1ca64c32 0c01a86e b1ccaa21 13686734 73a15fec a42ca4f6 c3ded07d 0500000c 01000000 09090909 0000000c 01000000 0a0808072001-09-13 15:11:26: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=8 2001-09-13 15:11:26: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:26: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 bd716464 0000011c 01000018 5057b26e f315faaf 7f0a5fef 67d246b7 f8f1a772 0a000038 00000001 00000001 0000002c 01030401 2ba14151 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 7edb3717 b5ab6c1a 3b23c152 dc88a02b 05000084 61f82d2f b4584ae3 7c8bd1ba bde795dd 81f58386 eaeacb3f f1ab9370 ada04aed c04c3088 e535e45c a96aff93 435ffa48 539aad38 0c7f5da1 cfc8085a 3bd7b3f7 5d2131a9 14f7ca98 d7afc155 7eace3f0 421b1ef1 3d906440 7995c163 807e1769 f79df173 1ca64c32 0c01a86e b1ccaa21 13686734 73a15fec a42ca4f6 c3ded07d 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:11:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:11:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 01000000 09090909 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 01000000 0a080807 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 5057b26e f315faaf 7f0a5fef 67d246b7 f8f1a772 2001-09-13 15:11:26: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): bd716464 0a000038 00000001 00000001 0000002c 01030401 2ba14151 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 7edb3717 b5ab6c1a 3b23c152 dc88a02b 05000084 61f82d2f b4584ae3 7c8bd1ba bde795dd 81f58386 eaeacb3f f1ab9370 ada04aed c04c3088 e535e45c a96aff93 435ffa48 539aad38 0c7f5da1 cfc8085a 3bd7b3f7 5d2131a9 14f7ca98 d7afc155 7eace3f0 421b1ef1 3d906440 7995c163 807e1769 f79df173 1ca64c32 0c01a86e b1ccaa21 13686734 73a15fec a42ca4f6 c3ded07d 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 5057b26e f315faaf 7f0a5fef 67d246b7 f8f1a772 2001-09-13 15:11:26: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 9.9.9.9[0] prefixlen=32 ul_proto=255 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[0] prefixlen=32 ul_proto=255 2001-09-13 15:11:26: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:26: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:26: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:26: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:26: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:26: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:26: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:26: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:26: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:26: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:26: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:26: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:26: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:26: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2001-09-13 15:11:26: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:11:26: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01030401 2ba14151 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 2001-09-13 15:11:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:11:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-09-13 15:11:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:11:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:11:26: DEBUG: proposal.c:866:print_proppair0(): 0x8097ab0: next=0x0 tnext=0x0 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x8097ab0 2001-09-13 15:11:26: DEBUG: proposal.c:866:print_proppair0(): 0x8097ab0: next=0x0 tnext=0x0 2001-09-13 15:11:26: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2001-09-13 15:11:26: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=2ba14151 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:11:26: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2001-09-13 15:11:26: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:11:26: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2001-09-13 15:11:26: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2001-09-13 15:11:26: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2001-09-13 15:11:26: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 64.245.57.57->165.227.249.5 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2001-09-13 15:11:26: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 4b71df78 86710000 02000100 0def8e2a ff06b8e7 a5e3f914 03000500 ff200000 10020000 40f53939 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2001-09-13 15:11:26: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=233803306(0xdef8e2a) 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01030401 00000000 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 2001-09-13 15:11:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:11:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-09-13 15:11:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:11:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:11:26: DEBUG: proposal.c:866:print_proppair0(): 0x8097ab0: next=0x0 tnext=0x0 2001-09-13 15:11:26: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:11:26: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 7fe30451 4e43a4a8 172dcf5f c6c3ac34 2fb4330d 946a262d 31e85de2 4a154110 dfb9c62a 7bd11da9 1d3be150 06d2d2d1 f3cd35f1 9099c208 b187967f 5a6db66c 5f4acca3 f6e16745 10d3cc4b 4a5163c2 68bedeb6 8ed3d55c a9058e43 540f03ab 814ea4a7 b407aef2 f6ec7eee 9cccc449 d8808ff1 95e16cd6 47c82001 06e5bfa62001-09-13 15:11:26: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 187b6fb9 9ef0e360 4e451028 4e0ea823 bfaf5480 315ce0cb 23d82f7d bd3ce2d1 57c47746 8df30e21 d848919e ca75929c 8785c7ec 922ceb0e 2e48fbb4 8f5d75fc 0ca21ea9 ae878ed8 616d1d5c 811df006 71e80151 cad842ea 15a391e7 9a5e04ac 8ac20fe9 2a32c51c de8e3175 6f0a95db 16cc2087 b26c1643 12e5c539 a1fa9e802001-09-13 15:11:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 10 2001-09-13 15:11:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 4 2001-09-13 15:11:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 5 2001-09-13 15:11:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2001-09-13 15:11:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2001-09-13 15:11:26: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): bd716464 7edb3717 b5ab6c1a 3b23c152 dc88a02b 0a000038 00000001 00000001 0000002c 01030401 0def8e2a 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 b61991d8 55bc5d61 27cf8426 4af38a60 05000084 187b6fb9 9ef0e360 4e451028 4e0ea823 bfaf5480 315ce0cb 23d82f7d bd3ce2d1 57c47746 8df30e21 d848919e ca75929c 8785c7ec 922ceb0e 2e48fbb4 8f5d75fc 0ca21ea9 ae878ed8 616d1d5c 811df006 71e80151 cad842ea 15a391e7 9a5e04ac 8ac20fe9 2a32c51c de8e3175 6f0a95db 16cc2087 b26c1643 12e5c539 a1fa9e80 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 4dc01af0 9b5d90b3 3036d976 f625b259 dcc8a7ad 2001-09-13 15:11:26: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2001-09-13 15:11:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:26: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-09-13 15:11:26: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 8 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 01000018 4dc01af0 9b5d90b3 3036d976 f625b259 dcc8a7ad 0a000038 00000001 00000001 0000002c 01030401 0def8e2a 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 b61991d8 55bc5d61 27cf8426 4af38a60 05000084 187b6fb9 9ef0e360 4e451028 4e0ea823 bfaf5480 315ce0cb 23d82f7d bd3ce2d1 57c47746 8df30e21 d848919e ca75929c 8785c7ec 922ceb0e 2e48fbb4 8f5d75fc 0ca21ea9 ae878ed8 616d1d5c 811df006 71e80151 cad842ea 15a391e7 9a5e04ac 8ac20fe9 2a32c51c de8e3175 6f0a95db 16cc2087 b26c1643 12e5c539 a1fa9e80 0500000c 01000000 09090909 0000000c 01000000 0a080807 427d5ff3 9d5bf107 2001-09-13 15:11:26: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-09-13 15:11:26: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:26: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): f7e2cac2 8a19bfb9 2001-09-13 15:11:26: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): f7e2cac2 8a19bfb9 2001-09-13 15:11:26: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-09-13 15:11:26: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:26: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:26: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:26: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 292 bytes message will be sent. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 bd716464 00000124 5e19bc15 b39a1fe8 b8225ac4 6e5dd817 0d48ec1a c7d2212a edb78dc4 cf294ee6 a7502dcc 451e7768 b5ae09cc 27605a6d d50faa4d 8043f0f7 407bd881 cbfad9b7 8a4d93a0 63296a1f 085f4581 66c762fb 2d252a7c daf549fd d8bf42d4 44ee6c48 e7c72919 6c37ac4f e2dbca9c b7a0bb9c 4f507fd6 be4983ce 0869578c 5d04c9ff 41c28098 85614255 0422a38d 337b7ea8 c9cf01c0 88f5df51 77c971a7 04deff86 3e241bef c6526dc0 25f9d17c fb26c6f0 026a0ac5 23248614 9ae99448 31467d8f 658df5d6 24847cbc 4ff44092 a63018ff 2601dc4a 91a66b63 ce4ac2e3 c05faf08 d9b86b0c 65b934be a1b7597b 63e30d3d a574bce2 bae6f146 40548a59 d9d8e90e f7e2cac2 8a19bfb9 2001-09-13 15:11:26: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:26: DEBUG: isakmp.c:232:isakmp_handler(): 52 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 bd716464 00000034 49be8f5e 282cb250 69b78080 3e944e4b ed02b199 f9866254 2001-09-13 15:11:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:26: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:26: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): ed02b199 f9866254 2001-09-13 15:11:26: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:26: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:26: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): ed02b199 f9866254 2001-09-13 15:11:26: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 00000018 0acc7263 d6af14f4 505e350a 5342330f dcdc6c26 2001-09-13 15:11:26: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=39 2001-09-13 15:11:26: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:26: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 bd716464 00000034 00000018 0acc7263 d6af14f4 505e350a 5342330f dcdc6c26 2001-09-13 15:11:26: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:26: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:26: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1363:quick_r3recv(): HASH(3) validate:2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 0acc7263 d6af14f4 505e350a 5342330f dcdc6c26 2001-09-13 15:11:26: DEBUG: oakley.c:659:oakley_compute_hash3(): HASH with: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 00bd7164 647edb37 17b5ab6c 1a3b23c1 52dc88a0 2bb61991 d855bc5d 6127cf84 264af38a 60 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:669:oakley_compute_hash3(): HASH computed: 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 0acc7263 d6af14f4 505e350a 5342330f dcdc6c26 2001-09-13 15:11:26: DEBUG: isakmp.c:713:quick_main(): === 2001-09-13 15:11:26: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): d6f84797 645c875a d19f1b4e bba55731 cb0846f1 faa279ec fddecca1 4fd991c8 9e4bf2cb abf0066a 514e48d6 500b21e9 86889ac4 0d9ea8e4 75411007 f9497d3e 27e76635 14b750f4 017df732 3992c3aa 0884600a ec695a55 fc71e346 48c7ccbf 3b699371 7a64686a bea880bf a635eec8 510ae762 d017a71c 7832e2a4 ea3643692001-09-13 15:11:26: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): d6f84797 645c875a d19f1b4e bba55731 cb0846f1 faa279ec fddecca1 4fd991c8 9e4bf2cb abf0066a 514e48d6 500b21e9 86889ac4 0d9ea8e4 75411007 f9497d3e 27e76635 14b750f4 017df732 3992c3aa 0884600a ec695a55 fc71e346 48c7ccbf 3b699371 7a64686a bea880bf a635eec8 510ae762 d017a71c 7832e2a4 ea364369 030def8e 2a7edb37 17b5ab6c 1a3b23c1 52dc88a0 2bb61991 d855bc5d 6127cf84 264af38a 60 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2001-09-13 15:11:26: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): ec7bf575 5bb5c2b4 234530cc e0a42e95 ff8414cf 88f66327 bb805492 2428762b 777a66c9 93cb43a9 164b3f68 0697c06c 7a84b643 ff19f36e 1c8eaebd 2001-09-13 15:11:26: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): d6f84797 645c875a d19f1b4e bba55731 cb0846f1 faa279ec fddecca1 4fd991c8 9e4bf2cb abf0066a 514e48d6 500b21e9 86889ac4 0d9ea8e4 75411007 f9497d3e 27e76635 14b750f4 017df732 3992c3aa 0884600a ec695a55 fc71e346 48c7ccbf 3b699371 7a64686a bea880bf a635eec8 510ae762 d017a71c 7832e2a4 ea364369 032ba141 517edb37 17b5ab6c 1a3b23c1 52dc88a0 2bb61991 d855bc5d 6127cf84 264af38a 60 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2001-09-13 15:11:26: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): ce2ddfb3 728ff00b f32ac536 bd55f71a d18f848d 8b304ca5 a15376f6 4ac631ce 0195dd5d 6118c6cf e7fbf87e 9832d79e 3a705b0e e3f5c0ee 18b5ae56 2001-09-13 15:11:26: DEBUG: oakley.c:392:oakley_compute_keymat(): KEYMAT computed. 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1541:quick_r3prep(): call pk_sendupdate 2001-09-13 15:11:26: DEBUG: pfkey.c:985:pk_sendupdate(): call pfkey_send_update 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1546:quick_r3prep(): pfkey update sent. 2001-09-13 15:11:26: DEBUG: pfkey.c:1174:pk_sendadd(): call pfkey_send_add 2001-09-13 15:11:26: DEBUG: isakmp_quick.c:1553:quick_r3prep(): pfkey add sent. 2001-09-13 15:11:26: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey UPDATE message 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 02020003 14000000 4b71df78 86710000 02000100 0def8e2a 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 40f53939 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 04000300 00000000 00000000 00000000 b4000000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 000000002001-09-13 15:11:26: DEBUG: pfkey.c:1079:pk_recvupdate(): pfkey UPDATE succeeded: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=233803306(0xdef8e2a) 2001-09-13 15:11:26: INFO: pfkey.c:1086:pk_recvupdate(): IPsec-SA established: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=233803306(0xdef8e2a) 2001-09-13 15:11:26: DEBUG: pfkey.c:1118:pk_recvupdate(): === 2001-09-13 15:11:26: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey ADD message 2001-09-13 15:11:26: DEBUG: plog.c:204:plogdump(): 02030003 14000000 4b71df78 86710000 02000100 2ba14151 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 a5e3f905 00000000 00000000 03000600 ff200000 10020000 40f53939 00000000 00000000 04000300 00000000 00000000 00000000 b4000000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 000000002001-09-13 15:11:26: INFO: pfkey.c:1246:pk_recvadd(): IPsec-SA established: ESP/Tunnel 165.227.249.5->64.245.57.57 spi=731988305(0x2ba14151) 2001-09-13 15:11:26: DEBUG: pfkey.c:1251:pk_recvadd(): === 2001-09-13 15:11:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:48: DEBUG: isakmp.c:232:isakmp_handler(): 284 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 a9f6e568 0000011c 43da5fcc 4113a5aa ab80b040 d0d35c74 4aa65250 d05c73fc 0609ebee 8a8cbe9e 0154ce25 06606c33 e2eae211 03a34066 67734898 c2f4aebe 41b2dc54 3166e3bc 64075111 c1cae9b3 26765790 4cdf3804 504fb1ea 409d24b1 4ac13ad7 295d3b9d 1380533a 3d04caa2 38251317 f29cc12a 328ce5c9 70005085 bb5f41ab 416b13ba 73224b4b 7fdffd27 20138125 17562b6e db0b4448 d31d7aa4 042190ef e529c2e5 c06a03b8 562c16a6 569b1df5 5ef4d045 d0af627f c366e058 d9a04674 d261dd63 549b4def f992df64 c3f17769 ef20db88 e6af8456 bd52088e 3681f0db 4fc516da 26cbf8d9 340f0b64 0ced7a77 7618feb2 4aaf7bae 7ae34f4c c7e82cee e6f953fa 2001-09-13 15:11:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:48: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-09-13 15:11:48: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 38b85b17 99f9af80 a9f6e568 2001-09-13 15:11:48: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:11:48: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 41761d7c 5b7d75cf 2001-09-13 15:11:48: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2001-09-13 15:11:48: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>64.245.57.57[0] 2001-09-13 15:11:48: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:48: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): c7e82cee e6f953fa 2001-09-13 15:11:48: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:48: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:48: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): c7e82cee e6f953fa 2001-09-13 15:11:48: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 01000018 52da7785 facfabfe 9f2398f4 58527e09 015acfd7 0a000038 00000001 00000001 0000002c 01030401 48f6b99a 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 3623fb6a e2fc01a7 011043ac 4d3d532c 05000084 200018fd 6073bcba 8fd25ff3 a6dc6d7b d545a4a0 c5c8683a 2461bbe5 9d213d44 cd4b351f 87e12443 cb91cee4 872879e3 7a24860e f2f82567 ba02479e bcd51826 f675bd20 0490b1a2 475bfcdc 7a7d62e6 209952e2 498c97a4 fc2f6934 5397d3d2 40a39fd5 b802ae21 fa715c6e 1ca16bef d337d22a 6a8122c2 f7c633e9 d42d3c47 0500000c 01000000 09090909 0000000c 01000000 0a0808072001-09-13 15:11:48: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=8 2001-09-13 15:11:48: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:48: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 a9f6e568 0000011c 01000018 52da7785 facfabfe 9f2398f4 58527e09 015acfd7 0a000038 00000001 00000001 0000002c 01030401 48f6b99a 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 3623fb6a e2fc01a7 011043ac 4d3d532c 05000084 200018fd 6073bcba 8fd25ff3 a6dc6d7b d545a4a0 c5c8683a 2461bbe5 9d213d44 cd4b351f 87e12443 cb91cee4 872879e3 7a24860e f2f82567 ba02479e bcd51826 f675bd20 0490b1a2 475bfcdc 7a7d62e6 209952e2 498c97a4 fc2f6934 5397d3d2 40a39fd5 b802ae21 fa715c6e 1ca16bef d337d22a 6a8122c2 f7c633e9 d42d3c47 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:11:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:11:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 01000000 09090909 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 01000000 0a080807 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 52da7785 facfabfe 9f2398f4 58527e09 015acfd7 2001-09-13 15:11:48: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): a9f6e568 0a000038 00000001 00000001 0000002c 01030401 48f6b99a 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 3623fb6a e2fc01a7 011043ac 4d3d532c 05000084 200018fd 6073bcba 8fd25ff3 a6dc6d7b d545a4a0 c5c8683a 2461bbe5 9d213d44 cd4b351f 87e12443 cb91cee4 872879e3 7a24860e f2f82567 ba02479e bcd51826 f675bd20 0490b1a2 475bfcdc 7a7d62e6 209952e2 498c97a4 fc2f6934 5397d3d2 40a39fd5 b802ae21 fa715c6e 1ca16bef d337d22a 6a8122c2 f7c633e9 d42d3c47 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 52da7785 facfabfe 9f2398f4 58527e09 015acfd7 2001-09-13 15:11:48: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 9.9.9.9[0] prefixlen=32 ul_proto=255 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[0] prefixlen=32 ul_proto=255 2001-09-13 15:11:48: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:48: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:48: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:48: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:48: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:48: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:48: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:48: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:11:48: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:48: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:48: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:48: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2001-09-13 15:11:48: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:48: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 9.9.9.9[0] 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2001-09-13 15:11:48: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:11:48: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01030401 48f6b99a 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 2001-09-13 15:11:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:11:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-09-13 15:11:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:11:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:11:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097d00: next=0x0 tnext=0x0 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x8097d00 2001-09-13 15:11:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097d00: next=0x0 tnext=0x0 2001-09-13 15:11:48: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2001-09-13 15:11:48: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=48f6b99a spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:11:48: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2001-09-13 15:11:48: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:11:48: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2001-09-13 15:11:48: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2001-09-13 15:11:48: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2001-09-13 15:11:48: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 64.245.57.57->165.227.249.5 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2001-09-13 15:11:48: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 cf3b0663 86710000 02000100 0a4d6340 00000000 00000000 03000500 ff200000 10020000 40f53939 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2001-09-13 15:11:48: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=172843840(0xa4d6340) 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01030401 00000000 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 2001-09-13 15:11:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:11:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-09-13 15:11:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:11:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:11:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097d00: next=0x0 tnext=0x0 2001-09-13 15:11:48: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:11:48: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 66ccb5bd f769293c 35ee9e8f f767a312 7731b000 a169fc6c 46cdac15 9f8894f2 759fbc7c 35d96e63 214e44be 80d1d356 2fa69ecf 0fb2edb9 651de801 cd3581d6 be504679 642e11a6 77d24e8c 2b0e3b71 325593a3 e9db5edb b266e350 fd97e6a7 3b9d0c53 83517cc6 2930b513 a1f4eac7 4fb2ca99 9ae19e0c 275a6b99 9fb8071d2001-09-13 15:11:48: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): fc88c9cd 56d1ad2d c0f196b6 9bb9edde 4c5cd3a9 6aa236aa 614e5b39 a06d340b 261eccf8 8f353cdf 85d150f4 dad83c27 849959c6 97e82345 0b9b487b 4b814886 18433ed5 7e070524 ace8e9df 858f1099 33e11ef2 bee93a93 942d5d21 7de0dfbf 14309fcf f360c284 b3bdbe1c 3b20f7d5 702286ba 50b04487 897b2a6e a3ce49492001-09-13 15:11:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 10 2001-09-13 15:11:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 4 2001-09-13 15:11:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 5 2001-09-13 15:11:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2001-09-13 15:11:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2001-09-13 15:11:48: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): a9f6e568 3623fb6a e2fc01a7 011043ac 4d3d532c 0a000038 00000001 00000001 0000002c 01030401 0a4d6340 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 a240a680 705cf0ea b86ea39e c9f6877d 05000084 fc88c9cd 56d1ad2d c0f196b6 9bb9edde 4c5cd3a9 6aa236aa 614e5b39 a06d340b 261eccf8 8f353cdf 85d150f4 dad83c27 849959c6 97e82345 0b9b487b 4b814886 18433ed5 7e070524 ace8e9df 858f1099 33e11ef2 bee93a93 942d5d21 7de0dfbf 14309fcf f360c284 b3bdbe1c 3b20f7d5 702286ba 50b04487 897b2a6e a3ce4949 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): d3b7acda a0b4723b 7840faaa eaba6afb 087d4b04 2001-09-13 15:11:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2001-09-13 15:11:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:48: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-09-13 15:11:48: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 8 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 01000018 d3b7acda a0b4723b 7840faaa eaba6afb 087d4b04 0a000038 00000001 00000001 0000002c 01030401 0a4d6340 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 a240a680 705cf0ea b86ea39e c9f6877d 05000084 fc88c9cd 56d1ad2d c0f196b6 9bb9edde 4c5cd3a9 6aa236aa 614e5b39 a06d340b 261eccf8 8f353cdf 85d150f4 dad83c27 849959c6 97e82345 0b9b487b 4b814886 18433ed5 7e070524 ace8e9df 858f1099 33e11ef2 bee93a93 942d5d21 7de0dfbf 14309fcf f360c284 b3bdbe1c 3b20f7d5 702286ba 50b04487 897b2a6e a3ce4949 0500000c 01000000 09090909 0000000c 01000000 0a080807 f0192140 16d8ad07 2001-09-13 15:11:48: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-09-13 15:11:48: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:48: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 1dbb1d9a bd306c99 2001-09-13 15:11:48: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 1dbb1d9a bd306c99 2001-09-13 15:11:48: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-09-13 15:11:48: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:11:48: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:11:48: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:11:48: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 292 bytes message will be sent. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 a9f6e568 00000124 7f57c66a d72b31ee 8685463e 7b7c8cf4 77d168c3 2cc3f6bc da020c0f f7891570 ff797bca d65fd321 81c6d180 12d23d68 7b8458b0 f820e042 2fe73be5 8c3cec3c 8edcba04 10b533b3 336c5ca0 2f698aac 4f46c62b c819ad16 4c59bb3c 1adf6f2d 024f5278 4e4d23c9 7bf1239a 5e0e31e0 1ef01efc 92d20837 45f99f9c f07b172b c064f9e6 a6f4660a f998b540 5273d4b0 ffc7ba17 e472da36 4535651a 7902c6db 6631c79c 104dc135 1ffdbcd0 208fb9c0 4896dbb6 31c2b906 92fe3faa 4b8803ac 446c6f8f 6a3e1c19 740cc8de c537c211 8f1ecf66 66d7a520 a8b752c0 3d116f4b ba2fefa1 00296a14 318a51b9 c8d394e5 114f21e0 909f648b fb878448 64c7eb97 1dbb1d9a bd306c99 2001-09-13 15:11:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:11:48: DEBUG: isakmp.c:232:isakmp_handler(): 52 bytes message received from 64.245.57.57[500] 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 a9f6e568 00000034 2de9e54f b0e86d2f d191d424 a707607e af841531 fdac7ed6 2001-09-13 15:11:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:48: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:11:48: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): af841531 fdac7ed6 2001-09-13 15:11:48: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:11:48: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:11:48: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): af841531 fdac7ed6 2001-09-13 15:11:48: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 00000018 91d79a7d 818b3197 416e75e2 0c3949ae 806fe8ae 2001-09-13 15:11:48: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=175 2001-09-13 15:11:48: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:11:48: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 a9f6e568 00000034 00000018 91d79a7d 818b3197 416e75e2 0c3949ae 806fe8ae 2001-09-13 15:11:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:11:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:11:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1363:quick_r3recv(): HASH(3) validate:2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 91d79a7d 818b3197 416e75e2 0c3949ae 806fe8ae 2001-09-13 15:11:48: DEBUG: oakley.c:659:oakley_compute_hash3(): HASH with: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 00a9f6e5 683623fb 6ae2fc01 a7011043 ac4d3d53 2ca240a6 80705cf0 eab86ea3 9ec9f687 7d 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:669:oakley_compute_hash3(): HASH computed: 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 91d79a7d 818b3197 416e75e2 0c3949ae 806fe8ae 2001-09-13 15:11:48: DEBUG: isakmp.c:713:quick_main(): === 2001-09-13 15:11:48: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): c08d9c3e dab915bb 08e08047 51635ef4 dcd63721 1ab1a713 21597b1e ce92b95e 9261331d 671ea59e c4f0b0d0 3de6e525 9bc76e89 aab08bf8 df5eab06 8ebdf2cc d6820258 e1a2a637 4b248bc2 81fca539 29aa48d2 06dc673d 0a9b9b18 6b7f08dc 2585bddc 0d2a307f ebbe66d3 90e03136 8c831bc4 29a8c382 ff6a7f09 986eb3ba2001-09-13 15:11:48: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): c08d9c3e dab915bb 08e08047 51635ef4 dcd63721 1ab1a713 21597b1e ce92b95e 9261331d 671ea59e c4f0b0d0 3de6e525 9bc76e89 aab08bf8 df5eab06 8ebdf2cc d6820258 e1a2a637 4b248bc2 81fca539 29aa48d2 06dc673d 0a9b9b18 6b7f08dc 2585bddc 0d2a307f ebbe66d3 90e03136 8c831bc4 29a8c382 ff6a7f09 986eb3ba 030a4d63 403623fb 6ae2fc01 a7011043 ac4d3d53 2ca240a6 80705cf0 eab86ea3 9ec9f687 7d 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2001-09-13 15:11:48: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): dc8b7b47 790afc85 db86bb00 cbd7579b b0cc8700 48d7efc3 48e05e1c c5ded31d a8b0caa2 d26dca23 73698316 b9282993 9fcb87f6 38664fa8 68349ddd 2001-09-13 15:11:48: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): c08d9c3e dab915bb 08e08047 51635ef4 dcd63721 1ab1a713 21597b1e ce92b95e 9261331d 671ea59e c4f0b0d0 3de6e525 9bc76e89 aab08bf8 df5eab06 8ebdf2cc d6820258 e1a2a637 4b248bc2 81fca539 29aa48d2 06dc673d 0a9b9b18 6b7f08dc 2585bddc 0d2a307f ebbe66d3 90e03136 8c831bc4 29a8c382 ff6a7f09 986eb3ba 0348f6b9 9a3623fb 6ae2fc01 a7011043 ac4d3d53 2ca240a6 80705cf0 eab86ea3 9ec9f687 7d 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2001-09-13 15:11:48: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 67685e95 6b75192d 4f1450e5 c4d64f9f 5d2b1d65 bb1e6e71 d46ae1b2 302a6b95 777b1ee4 187f7643 398907ea e3afe632 cd390ad2 dbc416d9 9c9151a1 2001-09-13 15:11:48: DEBUG: oakley.c:392:oakley_compute_keymat(): KEYMAT computed. 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1541:quick_r3prep(): call pk_sendupdate 2001-09-13 15:11:48: DEBUG: pfkey.c:985:pk_sendupdate(): call pfkey_send_update 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1546:quick_r3prep(): pfkey update sent. 2001-09-13 15:11:48: DEBUG: pfkey.c:1174:pk_sendadd(): call pfkey_send_add 2001-09-13 15:11:48: DEBUG: isakmp_quick.c:1553:quick_r3prep(): pfkey add sent. 2001-09-13 15:11:48: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey UPDATE message 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 02020003 14000000 cf3b0663 86710000 02000100 0a4d6340 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 40f53939 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 04000300 00000000 00000000 00000000 b4000000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 000000002001-09-13 15:11:48: DEBUG: pfkey.c:1079:pk_recvupdate(): pfkey UPDATE succeeded: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=172843840(0xa4d6340) 2001-09-13 15:11:48: INFO: pfkey.c:1086:pk_recvupdate(): IPsec-SA established: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=172843840(0xa4d6340) 2001-09-13 15:11:48: DEBUG: pfkey.c:1118:pk_recvupdate(): === 2001-09-13 15:11:48: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey ADD message 2001-09-13 15:11:48: DEBUG: plog.c:204:plogdump(): 02030003 14000000 cf3b0663 86710000 02000100 48f6b99a 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 a5e3f905 00000000 00000000 03000600 ff200000 10020000 40f53939 00000000 00000000 04000300 00000000 00000000 00000000 b4000000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 000000002001-09-13 15:11:48: INFO: pfkey.c:1246:pk_recvadd(): IPsec-SA established: ESP/Tunnel 165.227.249.5->64.245.57.57 spi=1224128922(0x48f6b99a) 2001-09-13 15:11:48: DEBUG: pfkey.c:1251:pk_recvadd(): === 2001-09-13 15:12:19: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:12:19: DEBUG: isakmp.c:232:isakmp_handler(): 284 bytes message received from 64.245.57.57[500] 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 aa8cc817 0000011c 6d64d698 42db63b8 cbfb5466 b2c67270 8b188a45 afc0244d b85222c3 3758fa31 78289a1b 563f3615 05a993b8 d6dea217 af24fb43 d95d486c 1df49099 647dc3f3 8c0ad0f2 a97fab1e f74aa46d b653686e 1ed8b8ba 77ff62bb e5d2fd74 13d52894 9147500f f02483ab 1d3e0ae3 d0c96073 3142a9dd 49e1e7bb 2142b05d 7a69fd33 58930979 048118ee b53160e6 cb40fbac 24f72c81 98310d28 2d812c6f ff68e10a 8e65bccc 39031d7c 15a4c542 d2f3e1cd 764b81fd acfdc347 1855ca6d 4d15681f 2d1b08f8 2427b521 63ba1ee8 eee9a804 10443408 f30d5446 3dfd0b38 10773e22 ed74c36c f0a70bce a5e7a09f bacda8ac 3db5c518 ac7eae1d a8252abd 99411d84 2001-09-13 15:12:19: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:12:19: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-09-13 15:12:19: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 38b85b17 99f9af80 aa8cc817 2001-09-13 15:12:19: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-09-13 15:12:19: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): c9cb9c71 ccfead02 2001-09-13 15:12:19: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2001-09-13 15:12:19: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>64.245.57.57[0] 2001-09-13 15:12:19: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:12:19: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): a8252abd 99411d84 2001-09-13 15:12:19: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:12:19: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:12:19: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): a8252abd 99411d84 2001-09-13 15:12:19: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 01000018 d03d4c12 cf2ecfa6 abf76f3f 25a4a312 affebbd5 0a000038 00000001 00000001 0000002c 01030401 b97031a1 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 b5c4dad9 b6674846 0c63108d d3bdedf8 05000084 1f149682 0f0b8e97 8ab9cd07 49f9c138 80a23720 8095f39e 7b9b6318 bc2d2d82 99237695 c3cf9edb 7539ad90 946eb8e3 2a701ea9 8f4318f8 6d622a09 b6262b92 3049325e d64fc125 68a09c5f 97c58de0 7ada4ef1 efe6eb4e e2e1fd13 c4656459 7609942b bd84044c 02885826 b8127b21 a3ef1dfd bf6ee8e4 67dc3b85 43dc063f 0500000c 01000000 09090909 0000000c 01000000 0a0808072001-09-13 15:12:19: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=8 2001-09-13 15:12:19: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:12:19: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 aa8cc817 0000011c 01000018 d03d4c12 cf2ecfa6 abf76f3f 25a4a312 affebbd5 0a000038 00000001 00000001 0000002c 01030401 b97031a1 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 b5c4dad9 b6674846 0c63108d d3bdedf8 05000084 1f149682 0f0b8e97 8ab9cd07 49f9c138 80a23720 8095f39e 7b9b6318 bc2d2d82 99237695 c3cf9edb 7539ad90 946eb8e3 2a701ea9 8f4318f8 6d622a09 b6262b92 3049325e d64fc125 68a09c5f 97c58de0 7ada4ef1 efe6eb4e e2e1fd13 c4656459 7609942b bd84044c 02885826 b8127b21 a3ef1dfd bf6ee8e4 67dc3b85 43dc063f 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:12:19: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-09-13 15:12:19: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 01000000 09090909 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 01000000 0a080807 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): d03d4c12 cf2ecfa6 abf76f3f 25a4a312 affebbd5 2001-09-13 15:12:19: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): aa8cc817 0a000038 00000001 00000001 0000002c 01030401 b97031a1 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 b5c4dad9 b6674846 0c63108d d3bdedf8 05000084 1f149682 0f0b8e97 8ab9cd07 49f9c138 80a23720 8095f39e 7b9b6318 bc2d2d82 99237695 c3cf9edb 7539ad90 946eb8e3 2a701ea9 8f4318f8 6d622a09 b6262b92 3049325e d64fc125 68a09c5f 97c58de0 7ada4ef1 efe6eb4e e2e1fd13 c4656459 7609942b bd84044c 02885826 b8127b21 a3ef1dfd bf6ee8e4 67dc3b85 43dc063f 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): d03d4c12 cf2ecfa6 abf76f3f 25a4a312 affebbd5 2001-09-13 15:12:19: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 9.9.9.9[0] prefixlen=32 ul_proto=255 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[0] prefixlen=32 ul_proto=255 2001-09-13 15:12:19: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:12:19: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:12:19: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 9.9.9.9[0] 2001-09-13 15:12:19: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 9.9.9.9[0] 2001-09-13 15:12:19: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 10.8.8.7[0] 2001-09-13 15:12:19: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2001-09-13 15:12:19: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:12:19: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 9.9.9.9/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-09-13 15:12:19: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd4e0: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:12:19: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:12:19: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 10.8.8.7[0] 2001-09-13 15:12:19: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2001-09-13 15:12:19: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd4e0 masked with /32: 9.9.9.9[0] 2001-09-13 15:12:19: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 9.9.9.9[0] 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[0] 9.9.9.9/32[0] proto=255 dir=2 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2001-09-13 15:12:19: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:12:19: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01030401 b97031a1 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 2001-09-13 15:12:19: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:12:19: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-09-13 15:12:19: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:12:19: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:12:19: DEBUG: proposal.c:866:print_proppair0(): 0x8097f50: next=0x0 tnext=0x0 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x8097f50 2001-09-13 15:12:19: DEBUG: proposal.c:866:print_proppair0(): 0x8097f50: next=0x0 tnext=0x0 2001-09-13 15:12:19: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2001-09-13 15:12:19: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=b97031a1 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:12:19: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2001-09-13 15:12:19: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-09-13 15:12:19: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2001-09-13 15:12:19: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2001-09-13 15:12:19: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2001-09-13 15:12:19: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 64.245.57.57->165.227.249.5 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2001-09-13 15:12:19: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 67478d61 86710000 02000100 06c82538 00000000 00000000 03000500 ff200000 10020000 40f53939 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2001-09-13 15:12:19: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=113780024(0x6c82538) 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01030401 00000000 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 2001-09-13 15:12:19: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-09-13 15:12:19: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-09-13 15:12:19: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-09-13 15:12:19: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=32 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Group Description, flag=0x8000, lorv=2 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-09-13 15:12:19: DEBUG: proposal.c:866:print_proppair0(): 0x8097f50: next=0x0 tnext=0x0 2001-09-13 15:12:19: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-09-13 15:12:19: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 66044aa8 5eaa2338 0cbdf3d6 14df8994 fe0678de 6944160f e0e7ef59 9453a1a7 88d7668a 99695bd3 f0038fd0 7c17ce64 eebfe109 bcb193d4 cb1eb15b 4d0ee175 3a68e902 778d4282 f374ad35 3d9b57fc dfef7db7 83f33d22 a2817109 a5ce9ddc 969c0e83 b5ad0a84 985af6f6 773a2ef6 ceafe325 fe72230c 80564a32 bba37a162001-09-13 15:12:19: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 9a61a1c3 8bdc65f6 9efdf09c 6b623e5d a85c8abf 48eb2b02 4d466e69 a72aeffa 78ab978b b8103975 6955ee50 38e56c0a abd686f5 eb712561 f6a1d79e caf4a821 d714ca68 f335c03c 7a10675b 856c4273 b1bcec62 f296d58c 4648a315 0c669f84 5744d7c2 673597d3 0385666a 84fa78c3 567012c9 687e170e 4e41b45f 334a366e2001-09-13 15:12:19: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 10 2001-09-13 15:12:19: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 4 2001-09-13 15:12:19: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 5 2001-09-13 15:12:19: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2001-09-13 15:12:19: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2001-09-13 15:12:19: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): aa8cc817 b5c4dad9 b6674846 0c63108d d3bdedf8 0a000038 00000001 00000001 0000002c 01030401 06c82538 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 864fcbac 4fe9edac b6837d32 f2590c0d 05000084 9a61a1c3 8bdc65f6 9efdf09c 6b623e5d a85c8abf 48eb2b02 4d466e69 a72aeffa 78ab978b b8103975 6955ee50 38e56c0a abd686f5 eb712561 f6a1d79e caf4a821 d714ca68 f335c03c 7a10675b 856c4273 b1bcec62 f296d58c 4648a315 0c669f84 5744d7c2 673597d3 0385666a 84fa78c3 567012c9 687e170e 4e41b45f 334a366e 0500000c 01000000 09090909 0000000c 01000000 0a080807 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 23f8d96a 3a436097 c062be30 8894df39 e8bdf8fa 2001-09-13 15:12:19: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2001-09-13 15:12:19: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:12:19: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-09-13 15:12:19: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 8 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 01000018 23f8d96a 3a436097 c062be30 8894df39 e8bdf8fa 0a000038 00000001 00000001 0000002c 01030401 06c82538 00000020 01030000 80010001 00020004 000000b4 80040001 80050002 80030002 04000014 864fcbac 4fe9edac b6837d32 f2590c0d 05000084 9a61a1c3 8bdc65f6 9efdf09c 6b623e5d a85c8abf 48eb2b02 4d466e69 a72aeffa 78ab978b b8103975 6955ee50 38e56c0a abd686f5 eb712561 f6a1d79e caf4a821 d714ca68 f335c03c 7a10675b 856c4273 b1bcec62 f296d58c 4648a315 0c669f84 5744d7c2 673597d3 0385666a 84fa78c3 567012c9 687e170e 4e41b45f 334a366e 0500000c 01000000 09090909 0000000c 01000000 0a080807 c00d9caf ddf51c07 2001-09-13 15:12:19: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-09-13 15:12:19: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:12:19: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): a9d940e3 1c8f7884 2001-09-13 15:12:19: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): a9d940e3 1c8f7884 2001-09-13 15:12:19: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-09-13 15:12:19: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-09-13 15:12:19: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-09-13 15:12:19: DEBUG: sockmisc.c:361:sendfromto(): send packet to 64.245.57.57[500] 2001-09-13 15:12:19: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 292 bytes message will be sent. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 aa8cc817 00000124 0e3fa6c1 938d3c40 6fb73a15 bc08618e a87945d6 bf6dfb5d 932630db 3800eeed 68a1e0f5 bdc0f35c 1a38dab8 8cba4007 2d8423e6 6b0859fc 2cd95ce3 28294671 f8fe9d40 3c2e9480 c0cb7f86 b0e29646 da16b054 5a6de52a 28187775 5f8573c1 ac155533 a13a5f43 45fee08c 4ea064aa babfb4e0 f3d595d4 12b73855 222e0329 815fb881 62bf0087 489afb32 e4722d2d 9cc59bf5 1dfe7082 84af588e 4eb5eaff 0d3bbd5c df02358e 94fc3068 6eb3964a a7e5b219 99dd0b27 702f6072 26f8ee90 9c10f048 8d099605 0603dd0c 5441f064 5c09fb4c ee3569b4 1447af61 d262eef3 f80ea409 cd577873 56e5968f 3197b8c5 42c1589d 2663c87b dc134b67 a27638b6 a9d940e3 1c8f7884 2001-09-13 15:12:19: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-09-13 15:12:19: DEBUG: isakmp.c:232:isakmp_handler(): 52 bytes message received from 64.245.57.57[500] 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 aa8cc817 00000034 61fb628d 93495e77 4e3931a2 6f07d7fa dcc9edf9 f5131bbc 2001-09-13 15:12:19: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:12:19: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-09-13 15:12:19: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): dcc9edf9 f5131bbc 2001-09-13 15:12:19: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-09-13 15:12:19: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 46cf3d5e 8c5e4368 701ad491 4b095544 36958643 6d71963e 2001-09-13 15:12:19: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): dcc9edf9 f5131bbc 2001-09-13 15:12:19: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 00000018 41a14b57 8951beb5 7b1f4f46 5f4863c8 1e8217e7 2001-09-13 15:12:19: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=232 2001-09-13 15:12:19: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-09-13 15:12:19: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 8e79d080 d471d534 fa3be20a 77de695a 08102001 aa8cc817 00000034 00000018 41a14b57 8951beb5 7b1f4f46 5f4863c8 1e8217e7 2001-09-13 15:12:19: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-09-13 15:12:19: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-09-13 15:12:19: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1363:quick_r3recv(): HASH(3) validate:2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 41a14b57 8951beb5 7b1f4f46 5f4863c8 1e8217e7 2001-09-13 15:12:19: DEBUG: oakley.c:659:oakley_compute_hash3(): HASH with: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 00aa8cc8 17b5c4da d9b66748 460c6310 8dd3bded f8864fcb ac4fe9ed acb6837d 32f2590c 0d 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:669:oakley_compute_hash3(): HASH computed: 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 41a14b57 8951beb5 7b1f4f46 5f4863c8 1e8217e7 2001-09-13 15:12:19: DEBUG: isakmp.c:713:quick_main(): === 2001-09-13 15:12:19: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 6e435392 57f6e421 d62b518b af2a40cc 168e9d24 c2224482 5248db1b 37468b7c 5c937816 fc34a233 118cbd5b 56ccd274 748b8da4 63b8b20b 780ddfdd dbbcea41 d02e6bb6 0b920075 4f729c24 803fdefe 3e951486 0bc5e6f0 7b7cecad c90ddb30 3c933f00 dd50d680 886ab0db c6b2c1e5 fa6b5b96 d046ffb2 12aa6c29 3dd8c8002001-09-13 15:12:19: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 6e435392 57f6e421 d62b518b af2a40cc 168e9d24 c2224482 5248db1b 37468b7c 5c937816 fc34a233 118cbd5b 56ccd274 748b8da4 63b8b20b 780ddfdd dbbcea41 d02e6bb6 0b920075 4f729c24 803fdefe 3e951486 0bc5e6f0 7b7cecad c90ddb30 3c933f00 dd50d680 886ab0db c6b2c1e5 fa6b5b96 d046ffb2 12aa6c29 3dd8c800 0306c825 38b5c4da d9b66748 460c6310 8dd3bded f8864fcb ac4fe9ed acb6837d 32f2590c 0d 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2001-09-13 15:12:19: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): ab6037a6 68de1b65 0963aa8f e44447a3 899620d3 26bd3a1f 9bb05ede 9139520b 4ed86560 bd1ce256 69fa6dfc b5a6fde4 b10472bd 427cb9f1 2c6ab6c8 2001-09-13 15:12:19: DEBUG: oakley.c:462:oakley_compute_keymat_x(): KEYMAT compute with 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 6e435392 57f6e421 d62b518b af2a40cc 168e9d24 c2224482 5248db1b 37468b7c 5c937816 fc34a233 118cbd5b 56ccd274 748b8da4 63b8b20b 780ddfdd dbbcea41 d02e6bb6 0b920075 4f729c24 803fdefe 3e951486 0bc5e6f0 7b7cecad c90ddb30 3c933f00 dd50d680 886ab0db c6b2c1e5 fa6b5b96 d046ffb2 12aa6c29 3dd8c800 03b97031 a1b5c4da d9b66748 460c6310 8dd3bded f8864fcb ac4fe9ed acb6837d 32f2590c 0d 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:475:oakley_compute_keymat_x(): dupkeymat=3 2001-09-13 15:12:19: DEBUG: oakley.c:491:oakley_compute_keymat_x(): generating K1...K3 for KEYMAT. 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): ed921021 beb79041 7e75a0e7 63de8897 7b25d4b6 e183cca1 bbe062c3 87f4039a 1014faa1 2a31d2c7 14e722dc 08952f30 518b0d77 84604e6e c27eafaf 2001-09-13 15:12:19: DEBUG: oakley.c:392:oakley_compute_keymat(): KEYMAT computed. 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1541:quick_r3prep(): call pk_sendupdate 2001-09-13 15:12:19: DEBUG: pfkey.c:985:pk_sendupdate(): call pfkey_send_update 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1546:quick_r3prep(): pfkey update sent. 2001-09-13 15:12:19: DEBUG: pfkey.c:1174:pk_sendadd(): call pfkey_send_add 2001-09-13 15:12:19: DEBUG: isakmp_quick.c:1553:quick_r3prep(): pfkey add sent. 2001-09-13 15:12:19: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey UPDATE message 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 02020003 14000000 67478d61 86710000 02000100 06c82538 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 40f53939 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 04000300 00000000 00000000 00000000 b4000000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 000000002001-09-13 15:12:19: DEBUG: pfkey.c:1079:pk_recvupdate(): pfkey UPDATE succeeded: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=113780024(0x6c82538) 2001-09-13 15:12:19: INFO: pfkey.c:1086:pk_recvupdate(): IPsec-SA established: ESP/Tunnel 64.245.57.57->165.227.249.5 spi=113780024(0x6c82538) 2001-09-13 15:12:19: DEBUG: pfkey.c:1118:pk_recvupdate(): === 2001-09-13 15:12:19: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey ADD message 2001-09-13 15:12:19: DEBUG: plog.c:204:plogdump(): 02030003 14000000 67478d61 86710000 02000100 b97031a1 04000303 00000000 02001300 02000000 00000000 00000000 03000500 ff200000 10020000 a5e3f905 00000000 00000000 03000600 ff200000 10020000 40f53939 00000000 00000000 04000300 00000000 00000000 00000000 b4000000 00000000 00000000 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 000000002001-09-13 15:12:19: INFO: pfkey.c:1246:pk_recvadd(): IPsec-SA established: ESP/Tunnel 165.227.249.5->64.245.57.57 spi=3111137697(0xb97031a1) 2001-09-13 15:12:19: DEBUG: pfkey.c:1251:pk_recvadd(): === 2001-09-13 15:13:51: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey EXPIRE message 2001-09-13 15:13:51: DEBUG: plog.c:204:plogdump(): 02080003 14000200 4b71df78 00000000 02000100 2ba14151 04020303 00000000 02001300 02000000 00000000 00000000 04000200 05000000 40050000 00000000 0e2fa13b 00000000 1a2fa13b 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 00000000 03000500 ff800000 10020000 a5e3f905 00000000 00000000 03000600 ff800000 10020000 40f53939 00000000 000000002001-09-13 15:13:51: INFO: pfkey.c:1293:pk_recvexpire(): IPsec-SA expired: ESP/Tunnel 165.227.249.5->64.245.57.57 spi=731988305(0x2ba14151) 2001-09-13 15:13:51: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey EXPIRE message 2001-09-13 15:13:51: DEBUG: plog.c:204:plogdump(): 02080003 14000100 4b71df78 00000000 02000100 0def8e2a 04020303 00000000 02001300 02000000 00000000 00000000 04000200 05000000 c5010000 00000000 0e2fa13b 00000000 1a2fa13b 00000000 04000400 00000000 00000000 00000000 90000000 00000000 00000000 00000000 03000500 ff800000 10020000 40f53939 00000000 00000000 03000600 ff800000 10020000 a5e3f905 00000000 000000002001-09-13 15:13