2001-12-21 05:20:07: INFO: main.c:126:main(): @(#)racoon 20001216 sakane@ydc.co.jp 2001-12-21 05:20:07: 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-12-21 05:20:07: DEBUG: pfkey.c:351:pfkey_init(): call pfkey_send_register 2001-12-21 05:20:07: DEBUG: pfkey.c:360:pfkey_init(): call pfkey_send_register 2001-12-21 05:20:07: DEBUG: pfkey.c:369:pfkey_init(): call pfkey_send_register 2001-12-21 05:20:07: DEBUG2: cftoken.l:119:yylex(): begin <5>path 2001-12-21 05:20:07: DEBUG2: cftoken.l:122:yylex(): <5>2001-12-21 05:20:07: DEBUG2: cftoken.l:457:yylex(): <5>2001-12-21 05:20:07: DEBUG2: cftoken.l:126:yylex(): begin <3>; 2001-12-21 05:20:07: DEBUG2: cftoken.l:119:yylex(): begin <5>path 2001-12-21 05:20:07: DEBUG2: cftoken.l:124:yylex(): <5>2001-12-21 05:20:07: DEBUG2: cftoken.l:457:yylex(): <5>2001-12-21 05:20:07: DEBUG2: cftoken.l:126:yylex(): begin <3>; 2001-12-21 05:20:07: DEBUG2: cftoken.l:156:yylex(): begin <13>listen 2001-12-21 05:20:07: DEBUG2: cftoken.l:158:yylex(): <13>2001-12-21 05:20:07: DEBUG2: cftoken.l:472:yylex(): <13>2001-12-21 05:20:07: DEBUG2: cftoken.l:348:yylex(): <13>2001-12-21 05:20:07: DEBUG2: cftoken.l:160:yylex(): <13>2001-12-21 05:20:07: DEBUG2: cftoken.l:255:yylex(): begin <33>remote 2001-12-21 05:20:07: DEBUG2: cftoken.l:256:yylex(): <33>2001-12-21 05:20:07: DEBUG2: cftoken.l:260:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:263:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:285:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:287:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:274:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:275:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:457:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:457:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:272:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:405:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:457:yylex(): <35>2001-12-21 05:20:07: DEBUG2: cftoken.l:295:yylex(): begin <37>proposal 2001-12-21 05:20:07: DEBUG2: cftoken.l:305:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:368:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:307:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:385:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:306:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:395:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:308:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:391:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:295:yylex(): begin <37>proposal 2001-12-21 05:20:07: DEBUG2: cftoken.l:305:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:368:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:307:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:385:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:306:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:396:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:308:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cftoken.l:391:yylex(): <37>2001-12-21 05:20:07: DEBUG2: cfparse.y:1722:set_isakmp_proposal(): lifetime = 28800 2001-12-21 05:20:07: DEBUG2: cfparse.y:1725:set_isakmp_proposal(): lifebyte = 0 2001-12-21 05:20:07: DEBUG2: cfparse.y:1728:set_isakmp_proposal(): strength=extra high 2001-12-21 05:20:07: DEBUG2: cfparse.y:1730:set_isakmp_proposal(): encklen=0 2001-12-21 05:20:07: DEBUG2: cfparse.y:1912:expand_isakmpspec(): p:1 t:1 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 3DES-CBC(5) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): SHA(2) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 1024-bit MODP group(2) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): pre-shared key(1) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1923:expand_isakmpspec(): 2001-12-21 05:20:07: DEBUG2: cfparse.y:1722:set_isakmp_proposal(): lifetime = 28800 2001-12-21 05:20:07: DEBUG2: cfparse.y:1725:set_isakmp_proposal(): lifebyte = 0 2001-12-21 05:20:07: DEBUG2: cfparse.y:1728:set_isakmp_proposal(): strength=extra high 2001-12-21 05:20:07: DEBUG2: cfparse.y:1730:set_isakmp_proposal(): encklen=0 2001-12-21 05:20:07: DEBUG2: cfparse.y:1912:expand_isakmpspec(): p:1 t:1 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 3DES-CBC(5) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): SHA(2) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): 1024-bit MODP group(2) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1916:expand_isakmpspec(): RSA signatures(3) 2001-12-21 05:20:07: DEBUG2: cfparse.y:1923:expand_isakmpspec(): 2001-12-21 05:20:07: DEBUG2: cftoken.l:235:yylex(): begin <29>sainfo 2001-12-21 05:20:07: DEBUG2: cftoken.l:236:yylex(): <29>2001-12-21 05:20:07: DEBUG2: cftoken.l:249:yylex(): <31>2001-12-21 05:20:07: DEBUG2: cftoken.l:368:yylex(): <31>2001-12-21 05:20:07: DEBUG2: cftoken.l:250:yylex(): <31>2001-12-21 05:20:07: DEBUG2: cftoken.l:381:yylex(): <31>2001-12-21 05:20:07: DEBUG2: cftoken.l:251:yylex(): <31>2001-12-21 05:20:07: DEBUG2: cftoken.l:388:yylex(): <31>2001-12-21 05:20:07: WARNING: pfkey.c:1977:pk_checkalg(): compression algorithm can not be checked. 2001-12-21 05:20:07: DEBUG2: cfparse.y:2005:cfparse(): parse successed. 2001-12-21 05:20:07: INFO: isakmp.c:1250:isakmp_open(): 165.227.249.5[500] used as isakmp port (fd=6) 2001-12-21 05:20:07: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey X_SPDDUMP message 2001-12-21 05:20:07: DEBUG: plog.c:204:plogdump(): 02120000 0f000100 01000000 6a4e0000 03000500 ff200000 10020000 d8b12f64 00000000 00000000 03000600 ff200000 10020000 0a080807 00000000 00000000 07001200 02000100 13000000 00000000 28003200 02020000 10020000 d8b12d88 00000000 00000000 10020000 a5e3f905 00000000 00000000 2001-12-21 05:20:07: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey X_SPDDUMP message 2001-12-21 05:20:07: DEBUG: plog.c:204:plogdump(): 02120000 0f000100 00000000 6a4e0000 03000500 ff200000 10020000 0a080807 00000000 00000000 03000600 ff200000 10020000 d8b12f64 00000000 00000000 07001200 02000200 14000000 00000000 28003200 02020000 10020000 a5e3f905 00000000 00000000 10020000 d8b12d88 00000000 00000000 2001-12-21 05:20:07: DEBUG: policy.c:181:cmpspidx(): sub:0xbfbfd684: 10.8.8.7/32[0] 216.177.47.100/32[0] proto=255 dir=2 2001-12-21 05:20:07: DEBUG: policy.c:182:cmpspidx(): db :0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:09: DEBUG: grabmyaddr.c:452:update_myaddrs(): caught rtm:15, need update interface address list 2001-12-21 05:20:09: DEBUG: grabmyaddr.c:446:update_myaddrs(): msg 14 not interesting 2001-12-21 05:20:45: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:45: DEBUG: isakmp.c:232:isakmp_handler(): 130 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 00000000 00000000 01100200 00000000 00000082 0d000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 0d00001a 20e9f3b7 12e60bb1 d6c3f5fa f41b6c1f 00008d00 84530000 00144485 152d18b6 bbcd0be8 a8469579 ddcc 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 216.177.45.136[500]. 2001-12-21 05:20:45: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2001-12-21 05:20:45: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>216.177.45.136[500] 2001-12-21 05:20:45: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:20:45: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:20:45: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:20:45: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=36 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:45: DEBUG: proposal.c:866:print_proppair0(): 0x8097370: next=0x0 tnext=0x0 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=1, prot-id=ISAKMP, spi-size=0, #trns=1 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=1, trns-id=IKE 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:3600) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2001-12-21 05:20:45: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: 759d47efc154caf1 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 0 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 01100200 00000000 00000054 00000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:20:45: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:45: DEBUG: isakmp.c:232:isakmp_handler(): 172 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 04100200 00000000 000000ac 0a000084 e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 0000000c d18eca1c 3c6dbdb1 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:20:45: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 69e3103f 182e678f 2a95e5eb 8af2caa1 6a38ca5c 7981710e d101489c 60a291d0 5a40c3fd 27f5838e 48355aa5 ea98bb91 a9fbfc03 a0b30bb0 15159387 73bb4ad9 7aaae1aa ab2eac24 1d59c36f 2e488859 44894536 680ec849 ab81e20d 8a186eb3 60b5162c 9450bac6 4de78f9b 73ec73b9 86f51f4a db3d23e5 56db111f 85d58ed72001-12-21 05:20:45: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 37c7718c 98cf3727 0fb4b7bf b17783ca 99a359f6 9c8ba289 687d789a fb8a341a 3d069ff5 78e84c4f a9625b6f d2fcc92b 0e6ecd9d a973f449 bc008cff 7c9840e1 2d0232d9 7d03cd74 d8f517fe ce9549b1 029edccb 452a76db 14062323 0a11d4ba 8b4f27ba 664673c1 cfc31243 f7ca9204 9659ad87 b35a7b7b 681f63c6 418724222001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 0 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 200 bytes message will be sent. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 04100200 00000000 000000c8 0a000084 37c7718c 98cf3727 0fb4b7bf b17783ca 99a359f6 9c8ba289 687d789a fb8a341a 3d069ff5 78e84c4f a9625b6f d2fcc92b 0e6ecd9d a973f449 bc008cff 7c9840e1 2d0232d9 7d03cd74 d8f517fe ce9549b1 029edccb 452a76db 14062323 0a11d4ba 8b4f27ba 664673c1 cfc31243 f7ca9204 9659ad87 b35a7b7b 681f63c6 41872422 0d000014 ba093ccb 09300b5f 865e0a74 fd7435c8 00000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 2001-12-21 05:20:45: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 03186b8a e5ad2fdb 1d9c5ae9 6504da42 6ac0f706 489dacd7 8ddfa4b3 d835df16 0834519e fd0ed25a 1b69871b 0e8870b8 a823cf9e 3741f35c a2a2e78b 71aa629b da651ce4 5b01b63e 3027bd7d 9c691b3a 44b8b3e8 84757612 d21af5b2 ae98fde3 2b989c13 e5bd46de f672a037 02537141 4dc92b0a 11998901 aa4fb930 81177c4d2001-12-21 05:20:45: DEBUG: oakley.c:1924:oakley_skeyid(): psk found: 2001-12-21 05:20:45: DEBUG2: plog.c:204:plogdump(): 6d656b6d 69746173 6469676f 6174 2001-12-21 05:20:45: DEBUG: oakley.c:1938:oakley_skeyid(): nonce 1: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): d18eca1c 3c6dbdb1 2001-12-21 05:20:45: DEBUG: oakley.c:1944:oakley_skeyid(): nonce 2: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): ba093ccb 09300b5f 865e0a74 fd7435c8 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 9db5c7a8 f7ede95c eb7c1cb4 428dd975 3e2ba7f0 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): a42bbef3 93113f36 9eaa648f 49d9a2c1 705b7c38 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 057966e5 58eb5f29 edd96445 56edba9c 59594559 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 27d16846 af9b6591 62b2fce6 225e2e79 fd566ce4 2001-12-21 05:20:45: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 00 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 1e64998b 732da8e6 46ee6c30 f9c3dda7 15a38521 2001-12-21 05:20:45: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 1e64998b 2001-12-21 05:20:45: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:45: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): d6b5fc98 12780e82 2001-12-21 05:20:45: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:45: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 05100201 00000000 00000044 7567eb35 57b9012a 4af9a5ad 71cc28a6 bb381230 2ab613b0 3855ff4f 5242c618 1b1cbeb4 884fde6f 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:20:45: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 1b1cbeb4 884fde6f 2001-12-21 05:20:45: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:20:45: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 1e64998b 2001-12-21 05:20:45: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 1b1cbeb4 884fde6f 2001-12-21 05:20:45: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 0800000c 011101f4 d8b12d88 00000018 0d42335a 33913ca2 dfa1360d e35a7100 c60b6447 00000000 2001-12-21 05:20:45: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2001-12-21 05:20:45: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-12-21 05:20:45: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 05100201 00000000 00000044 0800000c 011101f4 d8b12d88 00000018 0d42335a 33913ca2 dfa1360d e35a7100 c60b6447 00000000 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: oakley.c:1123:oakley_validate_auth(): HASH received:2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 0d42335a 33913ca2 dfa1360d e35a7100 c60b6447 2001-12-21 05:20:45: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 37c7718c 98cf3727 0fb4b7bf b17783ca 99a359f6 9c8ba289 687d789a fb8a341a 3d069ff5 78e84c4f a9625b6f d2fcc92b 0e6ecd9d a973f449 bc008cff 7c9840e1 2d0232d9 7d03cd74 d8f517fe ce9549b1 029edccb 452a76db 14062323 0a11d4ba 8b4f27ba 664673c1 cfc31243 f7ca9204 9659ad87 b35a7b7b 681f63c6 41872422 dcf763ed 21c361f0 759d47ef c154caf1 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 011101f4 d8b12d88 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 0d42335a 33913ca2 dfa1360d e35a7100 c60b6447 2001-12-21 05:20:45: DEBUG: oakley.c:1154:oakley_validate_auth(): HASH for PSK validated. 2001-12-21 05:20:45: DEBUG: isakmp_ident.c:1192:ident_r3recv(): peer's ID 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 011101f4 d8b12d88 2001-12-21 05:20:45: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:3156:ipsecdoi_setid1(): use ID type of FQDN 2001-12-21 05:20:45: DEBUG: isakmp_ident.c:1270:ident_r3send(): generate HASH_R 2001-12-21 05:20:45: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 37c7718c 98cf3727 0fb4b7bf b17783ca 99a359f6 9c8ba289 687d789a fb8a341a 3d069ff5 78e84c4f a9625b6f d2fcc92b 0e6ecd9d a973f449 bc008cff 7c9840e1 2d0232d9 7d03cd74 d8f517fe ce9549b1 029edccb 452a76db 14062323 0a11d4ba 8b4f27ba 664673c1 cfc31243 f7ca9204 9659ad87 b35a7b7b 681f63c6 41872422 e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 759d47ef c154caf1 dcf763ed 21c361f0 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 02000000 74657374 2d6b616d 652e7670 6e632e6f 7267 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 2b1b6fdd 30624409 12718c7f 1fb52423 9b826c9b 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 22, next type 8 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 0 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:45: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 6 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 0800001a 02000000 74657374 2d6b616d 652e7670 6e632e6f 72670000 00182b1b 6fdd3062 44091271 8c7f1fb5 24239b82 6c9b36cd 7bdf9e05 2001-12-21 05:20:45: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:45: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 1e64998b 2001-12-21 05:20:45: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 3b778ac0 1347aa65 2001-12-21 05:20:45: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 3b778ac0 1347aa65 2001-12-21 05:20:45: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:45: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 05100201 00000000 00000054 1585c799 887f2977 a99de1c4 1c02f1c9 aa70cc7e b277b0ff ca7104f7 2ecad208 a9746ac6 6df3922c 6ce434a1 c9166b1a 3b778ac0 1347aa65 2001-12-21 05:20:45: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-12-21 05:20:45: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 3b778ac0 1347aa65 92537f27 2001-12-21 05:20:45: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:45: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): d8b1d999 43739c9d 2001-12-21 05:20:45: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 92537f27 0000001c 00000001 01106002 dcf763ed 21c361f0 759d47ef c154caf12001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): e1eb87d9 29d9b7ef 1d2252b3 b4e1f1d6 edbd7149 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:45: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 4 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 0b000018 e1eb87d9 29d9b7ef 1d2252b3 b4e1f1d6 edbd7149 0000001c 00000001 01106002 dcf763ed 21c361f0 759d47ef c154caf1 105d3c03 2001-12-21 05:20:45: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:45: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 1e64998b 2001-12-21 05:20:45: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 466c290f ef884db8 2001-12-21 05:20:45: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 466c290f ef884db8 2001-12-21 05:20:45: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:45: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 08100501 92537f27 00000054 56b09ec7 a246da01 8fa3cbfa b9b4e655 aa05a4c6 c9d2b33e eda65894 8176e9a2 9bd8deb8 38a2b171 fef5e35b c95cc88a 466c290f ef884db8 2001-12-21 05:20:45: DEBUG: isakmp_inf.c:633:isakmp_info_send_common(): sendto Information notify. 2001-12-21 05:20:45: INFO: isakmp.c:2273:log_ph1established(): ISAKMP-SA established 165.227.249.5[500]-216.177.45.136[500] spi:dcf763ed21c361f0:759d47efc154caf1 2001-12-21 05:20:45: DEBUG: isakmp.c:649:ph1_main(): === 2001-12-21 05:20:45: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:45: DEBUG: isakmp.c:232:isakmp_handler(): 156 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 08102001 3fcc9655 0000009c f973b103 b8c4ae90 e7b85902 dc54f619 4b37568a 6f3041ec f2194ca5 a63fe589 aeaf4c97 9e3c0abd 99a4471c 28667b4b cb289266 6c9de074 1f3fba91 06a0453e b65bc472 e98be101 fe3f6a33 cfc027c5 04d9a75b 77d268ba 2072b0e7 e441db60 dc1a9ea0 c7c53ee9 c7f7575f 8ac03041 6fb4da9c 5efcd840 ab798824 f8d4cdd7 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-12-21 05:20:45: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 3b778ac0 1347aa65 3fcc9655 2001-12-21 05:20:45: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:45: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): c29bfc74 75ed30ca 2001-12-21 05:20:45: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2001-12-21 05:20:45: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>216.177.45.136[0] 2001-12-21 05:20:45: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:20:45: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): ab798824 f8d4cdd7 2001-12-21 05:20:45: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:20:45: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 1e64998b 2001-12-21 05:20:45: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): ab798824 f8d4cdd7 2001-12-21 05:20:45: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 01000018 569016d1 d52c2bf3 99742794 1c912833 a5c947e5 0a000034 00000001 00000001 00000028 01030401 5e9782d2 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c eb4e98ec ede51b34 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 5e9782d22001-12-21 05:20:45: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=211 2001-12-21 05:20:45: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-12-21 05:20:45: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 08102001 3fcc9655 0000009c 01000018 569016d1 d52c2bf3 99742794 1c912833 a5c947e5 0a000034 00000001 00000001 00000028 01030401 5e9782d2 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c eb4e98ec ede51b34 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 5e9782d2 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=11(notify) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: isakmp_inf.c:1196:isakmp_check_notify(): Notify Message received 2001-12-21 05:20:45: WARNING: isakmp_inf.c:1213:isakmp_check_notify(): ignore INITIAL-CONTACT notification. 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 011101f4 d8b12f64 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 011101f4 0a080807 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 569016d1 d52c2bf3 99742794 1c912833 a5c947e5 2001-12-21 05:20:45: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 3fcc9655 0a000034 00000001 00000001 00000028 01030401 5e9782d2 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c eb4e98ec ede51b34 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 5e9782d2 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 569016d1 d52c2bf3 99742794 1c912833 a5c947e5 2001-12-21 05:20:45: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 216.177.47.100[500] prefixlen=32 ul_proto=17 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[500] prefixlen=32 ul_proto=17 2001-12-21 05:20:45: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 216.177.47.100/32[500] 10.8.8.7/32[500] proto=17 dir=1 2001-12-21 05:20:45: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:45: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd518 masked with /32: 216.177.47.100[500] 2001-12-21 05:20:45: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 216.177.47.100[0] 2001-12-21 05:20:45: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd518 masked with /32: 10.8.8.7[500] 2001-12-21 05:20:45: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2001-12-21 05:20:45: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:45: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:45: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:45: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 216.177.47.100/32[0] proto=255 dir=2 2001-12-21 05:20:45: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd518 masked with /32: 10.8.8.7[500] 2001-12-21 05:20:45: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2001-12-21 05:20:45: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd518 masked with /32: 216.177.47.100[500] 2001-12-21 05:20:45: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 216.177.47.100[0] 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2001-12-21 05:20:45: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:45: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01030401 5e9782d2 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=28 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:45: DEBUG: proposal.c:866:print_proppair0(): 0x8097780: next=0x0 tnext=0x0 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x8097780 2001-12-21 05:20:45: DEBUG: proposal.c:866:print_proppair0(): 0x8097780: next=0x0 tnext=0x0 2001-12-21 05:20:45: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2001-12-21 05:20:45: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=5e9782d2 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:45: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2001-12-21 05:20:45: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:45: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2001-12-21 05:20:45: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2001-12-21 05:20:45: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2001-12-21 05:20:45: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 216.177.45.136->165.227.249.5 2001-12-21 05:20:45: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2001-12-21 05:20:45: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 1117e70e 6b4e0000 02000100 04adad44 dcf763ed 21c361f0 03000500 ff200000 10020000 d8b12d88 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2001-12-21 05:20:45: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 216.177.45.136->165.227.249.5 spi=78490948(0x4adad44) 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01030401 00000000 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-12-21 05:20:45: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:45: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:45: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=28 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:45: DEBUG: proposal.c:866:print_proppair0(): 0x8097780: next=0x0 tnext=0x0 2001-12-21 05:20:45: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 48, next type 10 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 5 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2001-12-21 05:20:45: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 3fcc9655 eb4e98ec ede51b34 0a000034 00000001 00000001 00000028 01030401 04adad44 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 05000014 8214b215 0093dc6f fd517086 0ca0f680 0500000c 011101f4 d8b12f64 0000000c 011101f4 0a080807 2001-12-21 05:20:45: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:45: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 4a9a0493 784bac2f 435428c0 a9372d65 674f7675 2001-12-21 05:20:45: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:45: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:45: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 8 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 01000018 4a9a0493 784bac2f 435428c0 a9372d65 674f7675 0a000034 00000001 00000001 00000028 01030401 04adad44 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 05000014 8214b215 0093dc6f fd517086 0ca0f680 0500000c 011101f4 d8b12f64 0000000c 011101f4 0a080807 d0b16833 be0074072001-12-21 05:20:45: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:45: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 662a0f9a 8ed1c7f3 e4608f60 6a600b02 3ff50655 1e64998b 2001-12-21 05:20:45: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 84f52cba fe20d4a9 2001-12-21 05:20:45: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): 84f52cba fe20d4a9 2001-12-21 05:20:45: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:45: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:45: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 156 bytes message will be sent. 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 08102001 3fcc9655 0000009c 54d2e58c 359e52c5 6ef5ee9b 95ad3f4b 0cdd1475 cfa6fa79 94839a34 64202836 f5146a60 a297e67c f4b0592e bf0f1bf2 057387ab 61f2d519 be618f31 a061f3c3 00d28535 afc7cafa e7f8b06c f040d63e 4cf6110c b073c00a 3247b472 ce9702bc 2f4abb41 fb0468b1 472adffc 46e584ca 0a106127 97f6f4a0 84f52cba fe20d4a9 2001-12-21 05:20:45: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:45: DEBUG: isakmp.c:232:isakmp_handler(): 40 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:45: DEBUG: plog.c:204:plogdump(): dcf763ed 21c361f0 759d47ef c154caf1 0b100200 00000000 00000028 0000000c 00000001 0100001e 2001-12-21 05:20:45: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:48: DEBUG: isakmp.c:232:isakmp_handler(): 130 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 00000000 00000000 01100200 00000000 00000082 0d000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 0d00001a 20e9f3b7 12e60bb1 d6c3f5fa f41b6c1f 00008d00 84530000 00144485 152d18b6 bbcd0be8 a8469579 ddcc 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 216.177.45.136[500]. 2001-12-21 05:20:48: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2001-12-21 05:20:48: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>216.177.45.136[500] 2001-12-21 05:20:48: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:20:48: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:20:48: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:20:48: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=36 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097840: next=0x0 tnext=0x0 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=1, prot-id=ISAKMP, spi-size=0, #trns=1 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=1, trns-id=IKE 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:3600) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2001-12-21 05:20:48: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: 1a1d97a27ee3501d 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 0 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 01100200 00000000 00000054 00000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:20:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:48: DEBUG: isakmp.c:232:isakmp_handler(): 172 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 04100200 00000000 000000ac 0a000084 e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 0000000c 78c2880f 4ee403dd 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:20:48: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 6f3090b4 1a3ab942 dfc7b3e8 6463b839 62ad6c20 7c24d1b5 1ae305c1 0d5ed11b a2a1d24b be21f022 e6bb315c 21df52ca b4b459dd 70529007 f18af831 f11741c8 8068bfe9 8749ebc3 5ba42ea3 cf56afee 89956bb3 ba2da870 c9ebc079 7d6b8497 3473fdf6 14bbfc2a 2fc5b909 cb40e311 836c28f7 e097db26 dc010c0b 2084d6242001-12-21 05:20:48: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 9192ad98 34ddc46a 47fba814 fc74ff64 8f1384bb d9e884ba 51dc6364 a588b15c 5483b324 441ed348 e97c617a 3ca60c07 3b69d90a 1fe76eb1 8520e7ea 2d6a5eba 9bcfebb8 b597ce03 2009d008 fe3b7689 01884626 b2524a7c 156aa351 5a6e0542 2e63b440 baa8b685 f50b818d 5b34203e 15e93423 c3884215 7d64de25 62cded7a2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 0 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 200 bytes message will be sent. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 04100200 00000000 000000c8 0a000084 9192ad98 34ddc46a 47fba814 fc74ff64 8f1384bb d9e884ba 51dc6364 a588b15c 5483b324 441ed348 e97c617a 3ca60c07 3b69d90a 1fe76eb1 8520e7ea 2d6a5eba 9bcfebb8 b597ce03 2009d008 fe3b7689 01884626 b2524a7c 156aa351 5a6e0542 2e63b440 baa8b685 f50b818d 5b34203e 15e93423 c3884215 7d64de25 62cded7a 0d000014 a8ec9676 f6721b1c a990bbb9 40f4ec57 00000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 2001-12-21 05:20:48: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 3878ca3a f15012cc fee22b64 50067391 bff8b6cd d60fcf44 3cbcd4bc 1a26aa28 b3c5ac84 14eaa3fc 047f9eaa 768c35ea 2ea5148f 92abc17d 5d7edd8f 961b97d1 f55813a2 b99ae4b3 c02b607c 713e7a64 bd078073 eddea889 265cd840 231d51a2 09054f43 6e96c5ae f62f87cf 33e140fa f9867a74 886c8257 f83af75b ccff20742001-12-21 05:20:48: DEBUG: oakley.c:1924:oakley_skeyid(): psk found: 2001-12-21 05:20:48: DEBUG2: plog.c:204:plogdump(): 6d656b6d 69746173 6469676f 6174 2001-12-21 05:20:48: DEBUG: oakley.c:1938:oakley_skeyid(): nonce 1: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 78c2880f 4ee403dd 2001-12-21 05:20:48: DEBUG: oakley.c:1944:oakley_skeyid(): nonce 2: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): a8ec9676 f6721b1c a990bbb9 40f4ec57 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): a133f6ed 527f2a78 d9fe8a14 303b3f2b c4eb740e 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): c5c07f8d 87104097 6f476e64 0f96d3be 63bc5f79 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 4302ed9c d9e500f4 eeaa2827 642a7325 35bad6a9 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): cee8d327 53e2999c c749ec09 1b631161 506d7efc 2001-12-21 05:20:48: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 00 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): ffb6d9f1 a3b8ca25 d242a937 ba1b22b1 ea61edd2 2001-12-21 05:20:48: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 ffb6d9f1 2001-12-21 05:20:48: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:48: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 6818e986 7308e5f5 2001-12-21 05:20:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:48: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 05100201 00000000 00000044 86c3584d ee2be825 02c3b4cb b6505d25 109e233c a9046bc5 4913dce0 39429c25 7f534002 4ae2c7c5 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:20:48: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 7f534002 4ae2c7c5 2001-12-21 05:20:48: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:20:48: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 ffb6d9f1 2001-12-21 05:20:48: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 7f534002 4ae2c7c5 2001-12-21 05:20:48: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 0800000c 011101f4 d8b12d88 00000018 182e2c78 dbf83ad2 cba44928 37b1e0af 009d814b 00000000 2001-12-21 05:20:48: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2001-12-21 05:20:48: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-12-21 05:20:48: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 05100201 00000000 00000044 0800000c 011101f4 d8b12d88 00000018 182e2c78 dbf83ad2 cba44928 37b1e0af 009d814b 00000000 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: oakley.c:1123:oakley_validate_auth(): HASH received:2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 182e2c78 dbf83ad2 cba44928 37b1e0af 009d814b 2001-12-21 05:20:48: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 9192ad98 34ddc46a 47fba814 fc74ff64 8f1384bb d9e884ba 51dc6364 a588b15c 5483b324 441ed348 e97c617a 3ca60c07 3b69d90a 1fe76eb1 8520e7ea 2d6a5eba 9bcfebb8 b597ce03 2009d008 fe3b7689 01884626 b2524a7c 156aa351 5a6e0542 2e63b440 baa8b685 f50b818d 5b34203e 15e93423 c3884215 7d64de25 62cded7a aa0dc204 26f71e5d 1a1d97a2 7ee3501d 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 011101f4 d8b12d88 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 182e2c78 dbf83ad2 cba44928 37b1e0af 009d814b 2001-12-21 05:20:48: DEBUG: oakley.c:1154:oakley_validate_auth(): HASH for PSK validated. 2001-12-21 05:20:48: DEBUG: isakmp_ident.c:1192:ident_r3recv(): peer's ID 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 011101f4 d8b12d88 2001-12-21 05:20:48: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:3156:ipsecdoi_setid1(): use ID type of FQDN 2001-12-21 05:20:48: DEBUG: isakmp_ident.c:1270:ident_r3send(): generate HASH_R 2001-12-21 05:20:48: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 9192ad98 34ddc46a 47fba814 fc74ff64 8f1384bb d9e884ba 51dc6364 a588b15c 5483b324 441ed348 e97c617a 3ca60c07 3b69d90a 1fe76eb1 8520e7ea 2d6a5eba 9bcfebb8 b597ce03 2009d008 fe3b7689 01884626 b2524a7c 156aa351 5a6e0542 2e63b440 baa8b685 f50b818d 5b34203e 15e93423 c3884215 7d64de25 62cded7a e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 1a1d97a2 7ee3501d aa0dc204 26f71e5d 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 02000000 74657374 2d6b616d 652e7670 6e632e6f 7267 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): a444f898 de2e3837 07c63c78 a3402d8b eae99be3 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 22, next type 8 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 0 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:48: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 6 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 0800001a 02000000 74657374 2d6b616d 652e7670 6e632e6f 72670000 0018a444 f898de2e 383707c6 3c78a340 2d8beae9 9be3b3a3 b5a33e05 2001-12-21 05:20:48: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:48: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 ffb6d9f1 2001-12-21 05:20:48: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): c4bfa485 d6d1152f 2001-12-21 05:20:48: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): c4bfa485 d6d1152f 2001-12-21 05:20:48: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:48: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 05100201 00000000 00000054 c45fb929 ef810cd7 37c5edf8 ce0cec9e 81053900 2aac3775 0ae2e614 f292d0e0 d14eb378 f6fa49ab ef491c6a 2d031eba c4bfa485 d6d1152f 2001-12-21 05:20:48: INFO: isakmp.c:2273:log_ph1established(): ISAKMP-SA established 165.227.249.5[500]-216.177.45.136[500] spi:aa0dc20426f71e5d:1a1d97a27ee3501d 2001-12-21 05:20:48: DEBUG: isakmp.c:649:ph1_main(): === 2001-12-21 05:20:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:48: DEBUG: isakmp.c:232:isakmp_handler(): 156 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 08102001 532e6e1e 0000009c 838aeacd fca9d719 6d1277df ab7fb0b8 2842337d 42e33e67 e363e18c b7a9b46c d9d6ce9e cf1383f8 54e6cf9b a8955aa8 24ecc20f 5920e7ad f6a72b73 ed462308 9d583012 8c46226f 9d9f2df6 de17c0bb 5ebce677 3ca6d2e7 ebcd98fc 4bf22d3c 39463410 216bf86a c4f1c26a 168068e7 c5253377 b9899e7c 940b5b9e 20d3ccba 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-12-21 05:20:48: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): c4bfa485 d6d1152f 532e6e1e 2001-12-21 05:20:48: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:48: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): fb5d568d 70d7fa60 2001-12-21 05:20:48: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2001-12-21 05:20:48: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>216.177.45.136[0] 2001-12-21 05:20:48: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:20:48: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 940b5b9e 20d3ccba 2001-12-21 05:20:48: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:20:48: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 ffb6d9f1 2001-12-21 05:20:48: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 940b5b9e 20d3ccba 2001-12-21 05:20:48: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 01000018 4bc5c49d 25e726ca cea44a8a f4bbc10a dd2e6857 0a000034 00000001 00000001 00000028 01030401 73541a99 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c 9f4e7a3f 8cb8f0ae 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 73541a992001-12-21 05:20:48: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=154 2001-12-21 05:20:48: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-12-21 05:20:48: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 08102001 532e6e1e 0000009c 01000018 4bc5c49d 25e726ca cea44a8a f4bbc10a dd2e6857 0a000034 00000001 00000001 00000028 01030401 73541a99 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c 9f4e7a3f 8cb8f0ae 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 73541a99 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=11(notify) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: isakmp_inf.c:1196:isakmp_check_notify(): Notify Message received 2001-12-21 05:20:48: WARNING: isakmp_inf.c:1213:isakmp_check_notify(): ignore INITIAL-CONTACT notification. 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 011101f4 d8b12f64 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 011101f4 0a080807 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 4bc5c49d 25e726ca cea44a8a f4bbc10a dd2e6857 2001-12-21 05:20:48: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 532e6e1e 0a000034 00000001 00000001 00000028 01030401 73541a99 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c 9f4e7a3f 8cb8f0ae 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 73541a99 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 4bc5c49d 25e726ca cea44a8a f4bbc10a dd2e6857 2001-12-21 05:20:48: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 216.177.47.100[500] prefixlen=32 ul_proto=17 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[500] prefixlen=32 ul_proto=17 2001-12-21 05:20:48: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 216.177.47.100/32[500] 10.8.8.7/32[500] proto=17 dir=1 2001-12-21 05:20:48: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:48: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd518 masked with /32: 216.177.47.100[500] 2001-12-21 05:20:48: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 216.177.47.100[0] 2001-12-21 05:20:48: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd518 masked with /32: 10.8.8.7[500] 2001-12-21 05:20:48: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2001-12-21 05:20:48: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:48: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:48: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:48: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 216.177.47.100/32[0] proto=255 dir=2 2001-12-21 05:20:48: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd518 masked with /32: 10.8.8.7[500] 2001-12-21 05:20:48: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2001-12-21 05:20:48: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd518 masked with /32: 216.177.47.100[500] 2001-12-21 05:20:48: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 216.177.47.100[0] 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2001-12-21 05:20:48: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:48: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01030401 73541a99 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=28 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097c00: next=0x0 tnext=0x0 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x8097c00 2001-12-21 05:20:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097c00: next=0x0 tnext=0x0 2001-12-21 05:20:48: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2001-12-21 05:20:48: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=73541a99 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:48: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2001-12-21 05:20:48: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:48: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2001-12-21 05:20:48: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2001-12-21 05:20:48: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2001-12-21 05:20:48: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 216.177.45.136->165.227.249.5 2001-12-21 05:20:48: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2001-12-21 05:20:48: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 f3b33876 6b4e0000 02000100 0f0d4dd0 aa0dc204 26f71e5d 03000500 ff200000 10020000 d8b12d88 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2001-12-21 05:20:48: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 216.177.45.136->165.227.249.5 spi=252530128(0xf0d4dd0) 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01030401 00000000 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-12-21 05:20:48: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:48: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:48: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=28 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:48: DEBUG: proposal.c:866:print_proppair0(): 0x8097c00: next=0x0 tnext=0x0 2001-12-21 05:20:48: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 48, next type 10 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 5 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2001-12-21 05:20:48: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 532e6e1e 9f4e7a3f 8cb8f0ae 0a000034 00000001 00000001 00000028 01030401 0f0d4dd0 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 05000014 b790ed09 27e4337b 19a0cae5 229e468f 0500000c 011101f4 d8b12f64 0000000c 011101f4 0a080807 2001-12-21 05:20:48: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:48: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 6db3a9ac 66c3b86b 8305548b 089d62f4 f4e47abb 2001-12-21 05:20:48: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:48: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:48: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 8 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 01000018 6db3a9ac 66c3b86b 8305548b 089d62f4 f4e47abb 0a000034 00000001 00000001 00000028 01030401 0f0d4dd0 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 05000014 b790ed09 27e4337b 19a0cae5 229e468f 0500000c 011101f4 d8b12f64 0000000c 011101f4 0a080807 d0494ca2 08f24b072001-12-21 05:20:48: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:48: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 001892a4 bf324b41 7cb78393 5939e7fa 43d9c930 ffb6d9f1 2001-12-21 05:20:48: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 3483d81b 13eecba0 2001-12-21 05:20:48: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): 3483d81b 13eecba0 2001-12-21 05:20:48: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:48: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:48: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 156 bytes message will be sent. 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 08102001 532e6e1e 0000009c 41d8bd40 ff8fe013 296810bc e9a15dd6 bf402314 7cdf969c bef3ce8b f486fd40 d05da5d6 3860880e 8232d3f1 2c6559fe 50211574 bd2d5b8e 10b4bb50 6b85729a e55be6a9 7853b67e 9189bf19 4fbb96c5 0e5f4fe7 8175acf2 8c7e6675 b7754eab 379ad496 3e5d3e2d f7173509 4de60f7a 527782ca 0c4b81e2 3483d81b 13eecba0 2001-12-21 05:20:48: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:48: DEBUG: isakmp.c:232:isakmp_handler(): 40 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:48: DEBUG: plog.c:204:plogdump(): aa0dc204 26f71e5d 1a1d97a2 7ee3501d 0b100200 00000000 00000028 0000000c 00000001 0100001e 2001-12-21 05:20:48: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:54: DEBUG: isakmp.c:232:isakmp_handler(): 130 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 00000000 00000000 01100200 00000000 00000082 0d000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 0d00001a 20e9f3b7 12e60bb1 d6c3f5fa f41b6c1f 00008d00 84530000 00144485 152d18b6 bbcd0be8 a8469579 ddcc 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 216.177.45.136[500]. 2001-12-21 05:20:54: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2001-12-21 05:20:54: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>216.177.45.136[500] 2001-12-21 05:20:54: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:20:54: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:20:54: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:20:54: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=36 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:54: DEBUG: proposal.c:866:print_proppair0(): 0x8097cc0: next=0x0 tnext=0x0 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=1, prot-id=ISAKMP, spi-size=0, #trns=1 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=1, trns-id=IKE 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:3600) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2001-12-21 05:20:54: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: 01ebe7ed72ae282f 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 0 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 01100200 00000000 00000054 00000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:20:54: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:54: DEBUG: isakmp.c:232:isakmp_handler(): 172 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 04100200 00000000 000000ac 0a000084 e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 0000000c 90bff94d aa75e045 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:20:54: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 7f8f7c2e fc79bb58 963ffe0b 90b03209 9adc78da ba253915 310ece16 16efd286 e1309d2e 56092d46 73eca429 2662be81 5638ad04 8de7a3a6 ed3fce2e 3561609d b4e95e55 de0b0872 03b6b5e4 25d1dfe7 8cfd5e41 70db5738 54649a59 43523643 1686ae26 2d8e9af0 8e4bbe67 f16bf9ee 191556b6 c14414ed a10ed1d6 e033e43e2001-12-21 05:20:54: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 15995691 62544171 14c44695 fbe2c9b1 62d3d4fe dd825466 1032034a 1b38acea 655aaba0 c84acdb5 e23fb49e c92de6b8 cdfafce0 645c5f03 c8aed00e 67d38153 acd7dd2d 8dcd531b 2fbe7097 37ff3b3d 8adc2dc2 da299637 2fa70d63 6be9287b ff876770 867eac4c bc13a08a 36a124ad 9554b405 d7093203 053eca00 2d068e942001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 0 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 200 bytes message will be sent. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 04100200 00000000 000000c8 0a000084 15995691 62544171 14c44695 fbe2c9b1 62d3d4fe dd825466 1032034a 1b38acea 655aaba0 c84acdb5 e23fb49e c92de6b8 cdfafce0 645c5f03 c8aed00e 67d38153 acd7dd2d 8dcd531b 2fbe7097 37ff3b3d 8adc2dc2 da299637 2fa70d63 6be9287b ff876770 867eac4c bc13a08a 36a124ad 9554b405 d7093203 053eca00 2d068e94 0d000014 97647b4a ff1fcc18 ed2a00e5 faa2930c 00000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 2001-12-21 05:20:54: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 9dba56dc 3759e845 bee839f5 767c2862 667b6be6 659d4ba6 32a41edf 8f623299 7fbbbb07 52a073df 07264b5c f61d2386 a8e4af67 94e957b0 4a51f295 202793c7 e4fea628 0cd9ff35 d56f780d 44ecdba6 f143145c 7a805361 15c27c02 586eabf9 3e861a3b af24890c 18242df9 2c04926f 1947e223 4cbbc91f 59cc40ee 0c51fcd12001-12-21 05:20:54: DEBUG: oakley.c:1924:oakley_skeyid(): psk found: 2001-12-21 05:20:54: DEBUG2: plog.c:204:plogdump(): 6d656b6d 69746173 6469676f 6174 2001-12-21 05:20:54: DEBUG: oakley.c:1938:oakley_skeyid(): nonce 1: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 90bff94d aa75e045 2001-12-21 05:20:54: DEBUG: oakley.c:1944:oakley_skeyid(): nonce 2: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 97647b4a ff1fcc18 ed2a00e5 faa2930c 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): fa55b4b8 8ce802ad 64db6ecd c2a5e96a 8ff44f35 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 1986b156 cb6ffbc4 cc89fa8a e43b2f51 9a584323 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 7b024d37 25033ac9 e50c884b 4144ae9e f833f199 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): b693dc0e 9c3c27a7 d10e9c2d 15714d70 4d5a5faf 2001-12-21 05:20:54: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 00 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 665efd2d 84fafe6d 133a6c4c 8f85e183 77fa090f 2001-12-21 05:20:54: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 665efd2d 2001-12-21 05:20:54: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:54: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 13d05400 596f9712 2001-12-21 05:20:54: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:54: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 05100201 00000000 00000044 7d6a2d73 89d24efd 2e3624bd a0ef7a3e 29e95c69 030b9147 d1021302 95a30a56 691b9064 4909f600 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:20:54: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 691b9064 4909f600 2001-12-21 05:20:54: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:20:54: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 665efd2d 2001-12-21 05:20:54: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 691b9064 4909f600 2001-12-21 05:20:54: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 0800000c 011101f4 d8b12d88 00000018 1036a616 207f3018 e2512a04 e7d41c76 9ef02416 00000000 2001-12-21 05:20:54: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=1 2001-12-21 05:20:54: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-12-21 05:20:54: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 05100201 00000000 00000044 0800000c 011101f4 d8b12d88 00000018 1036a616 207f3018 e2512a04 e7d41c76 9ef02416 00000000 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: oakley.c:1123:oakley_validate_auth(): HASH received:2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 1036a616 207f3018 e2512a04 e7d41c76 9ef02416 2001-12-21 05:20:54: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 15995691 62544171 14c44695 fbe2c9b1 62d3d4fe dd825466 1032034a 1b38acea 655aaba0 c84acdb5 e23fb49e c92de6b8 cdfafce0 645c5f03 c8aed00e 67d38153 acd7dd2d 8dcd531b 2fbe7097 37ff3b3d 8adc2dc2 da299637 2fa70d63 6be9287b ff876770 867eac4c bc13a08a 36a124ad 9554b405 d7093203 053eca00 2d068e94 f8393a42 4ec58901 01ebe7ed 72ae282f 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 011101f4 d8b12d88 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 1036a616 207f3018 e2512a04 e7d41c76 9ef02416 2001-12-21 05:20:54: DEBUG: oakley.c:1154:oakley_validate_auth(): HASH for PSK validated. 2001-12-21 05:20:54: DEBUG: isakmp_ident.c:1192:ident_r3recv(): peer's ID 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 011101f4 d8b12d88 2001-12-21 05:20:54: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:3156:ipsecdoi_setid1(): use ID type of FQDN 2001-12-21 05:20:54: DEBUG: isakmp_ident.c:1270:ident_r3send(): generate HASH_R 2001-12-21 05:20:54: DEBUG: oakley.c:834:oakley_ph1hash_common(): HASH with: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 15995691 62544171 14c44695 fbe2c9b1 62d3d4fe dd825466 1032034a 1b38acea 655aaba0 c84acdb5 e23fb49e c92de6b8 cdfafce0 645c5f03 c8aed00e 67d38153 acd7dd2d 8dcd531b 2fbe7097 37ff3b3d 8adc2dc2 da299637 2fa70d63 6be9287b ff876770 867eac4c bc13a08a 36a124ad 9554b405 d7093203 053eca00 2d068e94 e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 01ebe7ed 72ae282f f8393a42 4ec58901 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 02000000 74657374 2d6b616d 652e7670 6e632e6f 7267 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:844:oakley_ph1hash_common(): HASH computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): b0c24bcb f89d37ac 006b2fb7 bfd7dd5d b651c0e6 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 22, next type 8 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 0 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:54: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 6 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 0800001a 02000000 74657374 2d6b616d 652e7670 6e632e6f 72670000 0018b0c2 4bcbf89d 37ac006b 2fb7bfd7 dd5db651 c0e635dd 13891105 2001-12-21 05:20:54: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:54: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 665efd2d 2001-12-21 05:20:54: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5ac1e6d8 0b20080a 2001-12-21 05:20:54: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5ac1e6d8 0b20080a 2001-12-21 05:20:54: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:54: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 05100201 00000000 00000054 0a56e1a5 3f9ae628 768cebf7 5610face 930ebc08 032ece0f 52f3d489 b5f48e13 85ca39dc 64f9c2e9 ff9d0f56 88a18570 5ac1e6d8 0b20080a 2001-12-21 05:20:54: INFO: isakmp.c:2273:log_ph1established(): ISAKMP-SA established 165.227.249.5[500]-216.177.45.136[500] spi:f8393a424ec58901:01ebe7ed72ae282f 2001-12-21 05:20:54: DEBUG: isakmp.c:649:ph1_main(): === 2001-12-21 05:20:54: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:54: DEBUG: isakmp.c:232:isakmp_handler(): 156 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 08102001 796a9d39 0000009c b00e05ed 6e0d5a5f 0a58831f 0ae934a6 b03dad73 71f21f08 2b324c8f 2a5503bb 522d141a 786bd848 629c6b10 5c0ae0c5 dc88a37e f73bc898 07f1cace 4185cb82 01a91cc9 96baa3bd ea7c79cd a692947d a46fa0a5 3396844c 83c43fdd 41c2ac90 24ce8159 4bc1fd32 d261ac1e c27af0fa fe077448 b044d78f 59ae4ef0 d6e1d407 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: oakley.c:2423:oakley_newiv2(): compute IV for phase2 2001-12-21 05:20:54: DEBUG: oakley.c:2424:oakley_newiv2(): phase1 last IV: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5ac1e6d8 0b20080a 796a9d39 2001-12-21 05:20:54: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:20:54: DEBUG: oakley.c:2450:oakley_newiv2(): phase2 IV computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): c7f96f33 b6bdaf89 2001-12-21 05:20:54: DEBUG: isakmp.c:948:isakmp_ph2begin_r(): === 2001-12-21 05:20:54: INFO: isakmp.c:953:isakmp_ph2begin_r(): responde new phase 2 negotiation: 165.227.249.5[0]<=>216.177.45.136[0] 2001-12-21 05:20:54: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:20:54: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 59ae4ef0 d6e1d407 2001-12-21 05:20:54: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:20:54: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 665efd2d 2001-12-21 05:20:54: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 59ae4ef0 d6e1d407 2001-12-21 05:20:54: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 01000018 a28f5d48 fd8e52a2 5bec0c58 7be79341 fae9223f 0a000034 00000001 00000001 00000028 01030401 651d60d0 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c 22dc4fd3 586a1988 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 651d60d02001-12-21 05:20:54: DEBUG: oakley.c:2547:oakley_do_decrypt(): padding len=209 2001-12-21 05:20:54: DEBUG: oakley.c:2561:oakley_do_decrypt(): skip to trim padding. 2001-12-21 05:20:54: DEBUG: oakley.c:2576:oakley_do_decrypt(): decrypted. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 08102001 796a9d39 0000009c 01000018 a28f5d48 fd8e52a2 5bec0c58 7be79341 fae9223f 0a000034 00000001 00000001 00000028 01030401 651d60d0 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c 22dc4fd3 586a1988 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 651d60d0 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=8(hash) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=5(id) 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=11(notify) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: isakmp_inf.c:1196:isakmp_check_notify(): Notify Message received 2001-12-21 05:20:54: WARNING: isakmp_inf.c:1213:isakmp_check_notify(): ignore INITIAL-CONTACT notification. 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:978:quick_r1recv(): received IDci2:2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 011101f4 d8b12f64 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:982:quick_r1recv(): received IDcr2:2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 011101f4 0a080807 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:997:quick_r1recv(): HASH(1) validate:2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): a28f5d48 fd8e52a2 5bec0c58 7be79341 fae9223f 2001-12-21 05:20:54: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 796a9d39 0a000034 00000001 00000001 00000028 01030401 651d60d0 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 0500000c 22dc4fd3 586a1988 0500000c 011101f4 d8b12f64 0b00000c 011101f4 0a080807 00000010 00000001 03046002 651d60d0 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): a28f5d48 fd8e52a2 5bec0c58 7be79341 fae9223f 2001-12-21 05:20:54: DEBUG: sainfo.c:98:getsainfo(): anonymous sainfo selected. 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:1700:get_sainfo_r(): get sa info: anonymous 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:1848:get_proposal_r(): get a src address from ID payload 216.177.47.100[500] prefixlen=32 ul_proto=17 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:1853:get_proposal_r(): get dst address from ID payload 10.8.8.7[500] prefixlen=32 ul_proto=17 2001-12-21 05:20:54: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 216.177.47.100/32[500] 10.8.8.7/32[500] proto=17 dir=1 2001-12-21 05:20:54: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:54: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd518 masked with /32: 216.177.47.100[500] 2001-12-21 05:20:54: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c408 masked with /32: 216.177.47.100[0] 2001-12-21 05:20:54: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd518 masked with /32: 10.8.8.7[500] 2001-12-21 05:20:54: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c408 masked with /32: 10.8.8.7[0] 2001-12-21 05:20:54: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:54: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c408: 216.177.47.100/32[0] 10.8.8.7/32[0] proto=255 dir=1 2001-12-21 05:20:54: DEBUG: policy.c:211:cmpspidx_wild(): sub:0xbfbfd518: 10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:54: DEBUG: policy.c:212:cmpspidx_wild(): db: 0x809c808: 10.8.8.7/32[0] 216.177.47.100/32[0] proto=255 dir=2 2001-12-21 05:20:54: DEBUG: policy.c:239:cmpspidx_wild(): 0xbfbfd518 masked with /32: 10.8.8.7[500] 2001-12-21 05:20:54: DEBUG: policy.c:241:cmpspidx_wild(): 0x809c808 masked with /32: 10.8.8.7[0] 2001-12-21 05:20:54: DEBUG: policy.c:255:cmpspidx_wild(): 0xbfbfd518 masked with /32: 216.177.47.100[500] 2001-12-21 05:20:54: DEBUG: policy.c:257:cmpspidx_wild(): 0x809c808 masked with /32: 216.177.47.100[0] 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:1887:get_proposal_r(): suitable SP found:10.8.8.7/32[500] 216.177.47.100/32[500] proto=17 dir=2 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:1979:get_proposal_r(): my single bundle: 2001-12-21 05:20:54: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:54: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01030401 651d60d0 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=28 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:54: DEBUG: proposal.c:866:print_proppair0(): 0x80a50b0: next=0x0 tnext=0x0 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:887:get_ph2approval(): begin compare proposals. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:893:get_ph2approval(): pair[1]: 0x80a50b0 2001-12-21 05:20:54: DEBUG: proposal.c:866:print_proppair0(): 0x80a50b0: next=0x0 tnext=0x0 2001-12-21 05:20:54: DEBUG: proposal.c:667:aproppair2saprop(): prop#=1 prot-id=ESP spi-size=4 #trns=1 trns#=1 trns-id=3DES 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:3595:ipsecdoi_t2satrns(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:929:get_ph2approvalx(): peer's single bundle: 2001-12-21 05:20:54: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=651d60d0 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:54: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:932:get_ph2approvalx(): my single bundle: 2001-12-21 05:20:54: DEBUG: proposal.c:799:printsaproto(): (proto_id=ESP spisize=4 spi=00000000 spi_p=00000000 encmode=Tunnel reqid=0:0) 2001-12-21 05:20:54: DEBUG: proposal.c:833:printsatrns(): (trns_id=3DES encklen=0 authtype=2) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:950:get_ph2approvalx(): matched 2001-12-21 05:20:54: DEBUG: isakmp.c:978:isakmp_ph2begin_r(): === 2001-12-21 05:20:54: DEBUG: pfkey.c:824:pk_sendgetspi(): call pfkey_send_getspi 2001-12-21 05:20:54: DEBUG: pfkey.c:837:pk_sendgetspi(): pfkey GETSPI sent: ESP/Tunnel 216.177.45.136->165.227.249.5 2001-12-21 05:20:54: DEBUG: isakmp_quick.c:1093:quick_r1prep(): pfkey getspi sent. 2001-12-21 05:20:54: DEBUG: pfkey.c:190:pfkey_handler(): get pfkey GETSPI message 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 02010003 0a000000 d6616a36 6b4e0000 02000100 0769b0b8 f8393a42 4ec58901 03000500 ff200000 10020000 d8b12d88 00000000 00000000 03000600 ff200000 10020000 a5e3f905 00000000 00000000 2001-12-21 05:20:54: DEBUG: pfkey.c:898:pk_recvgetspi(): pfkey GETSPI succeeded: ESP/Tunnel 216.177.45.136->165.227.249.5 spi=124367032(0x769b0b8) 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=48 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 00000001 00000001 00000028 01030401 00000000 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=40 2001-12-21 05:20:54: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:20:54: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:20:54: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=28 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Authentication Algorithm, flag=0x8000, lorv=2 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=SA Life Duration, flag=0x0000, lorv=4 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:2037:check_attr_ipsec(): type=Encription Mode, flag=0x8000, lorv=Tunnel 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:20:54: DEBUG: proposal.c:866:print_proppair0(): 0x80a50b0: next=0x0 tnext=0x0 2001-12-21 05:20:54: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 48, next type 10 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 5 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 5 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 8, next type 0 2001-12-21 05:20:54: DEBUG: oakley.c:715:oakley_compute_hash1(): HASH with: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 796a9d39 22dc4fd3 586a1988 0a000034 00000001 00000001 00000028 01030401 0769b0b8 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 05000014 ed2bdf0c 417925c7 14dea134 ad055326 0500000c 011101f4 d8b12f64 0000000c 011101f4 0a080807 2001-12-21 05:20:54: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:20:54: DEBUG: oakley.c:725:oakley_compute_hash1(): HASH computed: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 37c6bf6b d41b7b48 d8f8e988 7d5fb5e9 dd7104ec 2001-12-21 05:20:54: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 20, next type 1 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:54: DEBUG: oakley.c:2610:oakley_do_encrypt(): begin encryption. 2001-12-21 05:20:54: DEBUG: oakley.c:2617:oakley_do_encrypt(): pad length = 8 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 01000018 37c6bf6b d41b7b48 d8f8e988 7d5fb5e9 dd7104ec 0a000034 00000001 00000001 00000028 01030401 0769b0b8 0000001c 01030000 80050002 80010001 00020004 00007080 80040001 05000014 ed2bdf0c 417925c7 14dea134 ad055326 0500000c 011101f4 d8b12f64 0000000c 011101f4 0a080807 a0d5aa3d 64b6e5072001-12-21 05:20:54: DEBUG: oakley.c:2652:oakley_do_encrypt(): encrypt(3des). 2001-12-21 05:20:54: DEBUG: oakley.c:2655:oakley_do_encrypt(): with key: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): 5de915eb 7c19bb21 4e48a509 5f323406 2f54557d 665efd2d 2001-12-21 05:20:54: DEBUG: oakley.c:2664:oakley_do_encrypt(): encrypted payload by IV: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f11369a3 4eadf75d 2001-12-21 05:20:54: DEBUG: oakley.c:2671:oakley_do_encrypt(): save IV for next: 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f11369a3 4eadf75d 2001-12-21 05:20:54: DEBUG: oakley.c:2688:oakley_do_encrypt(): encrypted. 2001-12-21 05:20:54: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:20:54: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 156 bytes message will be sent. 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 08102001 796a9d39 0000009c 76ef4d33 45a7f1e2 fdfd913c f31316b5 4f0044f4 aa0e0a6d d60cb70a d1cda785 96e2d4b1 748d1f9f ca50f307 084fc562 6f7d9e1d 8048c964 b96a6e6b 0526e3b6 aeda203c 79e59c98 0ab07ca0 d522d0ac 01b10837 f21b03ce 6b3a4c26 b9723239 c48e2853 6eb3178d d611bb35 53f55338 936828b7 1c0e156e f11369a3 4eadf75d 2001-12-21 05:20:54: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:20:54: DEBUG: isakmp.c:232:isakmp_handler(): 40 bytes message received from 216.177.45.136[500] 2001-12-21 05:20:54: DEBUG: plog.c:204:plogdump(): f8393a42 4ec58901 01ebe7ed 72ae282f 0b100200 00000000 00000028 0000000c 00000001 0100001e 2001-12-21 05:20:54: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:20:55: ERROR: pfkey.c:773:pfkey_timeover(): 216.177.45.136 give up to get IPsec-SA due to time up to wait. 2001-12-21 05:20:58: ERROR: pfkey.c:773:pfkey_timeover(): 216.177.45.136 give up to get IPsec-SA due to time up to wait. 2001-12-21 05:21:04: ERROR: pfkey.c:773:pfkey_timeover(): 216.177.45.136 give up to get IPsec-SA due to time up to wait. 2001-12-21 05:21:06: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:21:06: DEBUG: isakmp.c:232:isakmp_handler(): 130 bytes message received from 216.177.45.136[500] 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 35f876fb d758d3fb 00000000 00000000 01100200 00000000 00000082 0d000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 0d00001a 20e9f3b7 12e60bb1 d6c3f5fa f41b6c1f 00008d00 84530000 00144485 152d18b6 bbcd0be8 a8469579 ddcc 2001-12-21 05:21:06: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:21:06: DEBUG: remoteconf.c:127:getrmconf(): anonymous configuration selected for 216.177.45.136[500]. 2001-12-21 05:21:06: DEBUG: isakmp.c:840:isakmp_ph1begin_r(): === 2001-12-21 05:21:06: INFO: isakmp.c:845:isakmp_ph1begin_r(): responde new phase 1 negotiation: 165.227.249.5[500]<=>216.177.45.136[500] 2001-12-21 05:21:06: INFO: isakmp.c:850:isakmp_ph1begin_r(): begin Identity Protection mode. 2001-12-21 05:21:06: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=1(sa) 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=13(vid) 2001-12-21 05:21:06: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:21:06: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:21:06: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:21:06: DEBUG: vendorid.c:79:check_vendorid(): Vender ID received 2001-12-21 05:21:06: DEBUG: vendorid.c:96:check_vendorid(): Vendor ID mismatch. 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1052:get_proppair(): total SA len=52 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:21:06: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=2(prop) 2001-12-21 05:21:06: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1105:get_proppair(): proposal #1 len=44 2001-12-21 05:21:06: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=3(trns) 2001-12-21 05:21:06: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1246:get_transform(): transform #1 len=36 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1805:check_attr_isakmp(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1148:get_proppair(): pair 1: 2001-12-21 05:21:06: DEBUG: proposal.c:866:print_proppair0(): 0x80976c0: next=0x0 tnext=0x0 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:1183:get_proppair(): proposal #1: 1 transform 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:318:get_ph1approvalx(): prop#=1, prot-id=ISAKMP, spi-size=0, #trns=1 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:323:get_ph1approvalx(): trns#=1, trns-id=IKE 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Encryption Algorithm, flag=0x8000, lorv=3DES-CBC 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Hash Algorithm, flag=0x8000, lorv=SHA 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Authentication Method, flag=0x8000, lorv=pre-shared key 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Group Description, flag=0x8000, lorv=1024-bit MODP group 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Type, flag=0x8000, lorv=seconds 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:421:t2isakmpsa(): type=Life Duration, flag=0x0000, lorv=4 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:334:get_ph1approvalx(): Compared: DB:Peer 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:335:get_ph1approvalx(): (lifetime = 28800:3600) 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:337:get_ph1approvalx(): (lifebyte = 0:0) 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:339:get_ph1approvalx(): enctype = 3DES-CBC:3DES-CBC 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:344:get_ph1approvalx(): (encklen = 0:0) 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:346:get_ph1approvalx(): hashtype = SHA:SHA 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:351:get_ph1approvalx(): authmethod = pre-shared key:pre-shared key 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:356:get_ph1approvalx(): dh_group = 1024-bit MODP group:1024-bit MODP group 2001-12-21 05:21:06: DEBUG: ipsec_doi.c:378:get_ph1approvalx(): acceptable proposal found. 2001-12-21 05:21:06: DEBUG: isakmp.c:1876:isakmp_newcookie(): new cookie: 162b149d4b495389 2001-12-21 05:21:06: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 52, next type 0 2001-12-21 05:21:06: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:21:06: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:21:06: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:21:06: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:21:06: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 84 bytes message will be sent. 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 35f876fb d758d3fb 162b149d 4b495389 01100200 00000000 00000054 00000038 00000001 00000001 0000002c 01010001 00000024 01010000 80010005 80020002 80030001 80040002 800b0001 000c0004 00000e10 2001-12-21 05:21:06: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:21:06: DEBUG: isakmp.c:232:isakmp_handler(): 172 bytes message received from 216.177.45.136[500] 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 35f876fb d758d3fb 162b149d 4b495389 04100200 00000000 000000ac 0a000084 e74ee4bb 34f27d3b 322ddf27 5d932004 14a71f2c bac62f16 410197d1 4cc73d42 1e71859d 0629fdf8 67be68a8 baa2f717 ccd1bdb6 23893e16 20b80151 62005ff4 5f9a0cbe 8f600532 f6244638 b232ed68 80528671 c8c97710 6d1c77d6 d3e63a5b ef4b7cad b63a38e5 68e715eb f8e93b93 a3ced90d 23ca2c12 92db26e2 b90a7025 0000000c 00cfc3d8 ad4b5986 2001-12-21 05:21:06: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:21:06: DEBUG: isakmp.c:1011:isakmp_parsewoh(): begin. 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=4(ke) 2001-12-21 05:21:06: DEBUG: isakmp.c:1038:isakmp_parsewoh(): seen nptype=10(nonce) 2001-12-21 05:21:06: DEBUG: isakmp.c:1076:isakmp_parsewoh(): succeed. 2001-12-21 05:21:06: DEBUG: isakmp.c:609:ph1_main(): === 2001-12-21 05:21:06: DEBUG: oakley.c:228:oakley_dh_generate(): compute DH's private. 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 5ca8d352 23124818 19d29318 f47038ee 7db404c0 8253e04c d683c993 e6583b79 782c5bbd 0b3fce93 99974fe3 a64ebd1a 7046afb0 e6dd6e58 6c06cf44 3cb6734d 2f8bf4cd 33eff5d9 998724d7 c4d9a4bd 626b24b1 661376df 5c29c39a 78809fc6 74f55123 a3f7ca48 1c66e04e bc87a63c 32b07634 50eccdbc 36911d85 7c0511db2001-12-21 05:21:06: DEBUG: oakley.c:230:oakley_dh_generate(): compute DH's public. 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): db3ac7b7 27dc6b2e a48c20d8 c0291455 85c12ee3 bb6a31d0 275bce01 75621606 04d00c4b 45e03ef8 06a035c9 3a95a356 2be1cc1b 5579a53d b269c5fb 8d24ae9f d6ea69fb d934e700 02c772a3 2cb296a1 8dc48a29 522c830d 3093c82a ed10377f 147400c4 8ff4da71 302eade3 b876a579 3133982f 71de2469 11061a49 f6d752132001-12-21 05:21:06: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 128, next type 10 2001-12-21 05:21:06: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 13 2001-12-21 05:21:06: DEBUG: isakmp.c:1989:set_isakmp_payload(): add payload of len 16, next type 0 2001-12-21 05:21:06: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:21:06: DEBUG: sockmisc.c:357:sendfromto(): sockname 165.227.249.5[500] 2001-12-21 05:21:06: DEBUG: sockmisc.c:359:sendfromto(): send packet from 165.227.249.5[500] 2001-12-21 05:21:06: DEBUG: sockmisc.c:361:sendfromto(): send packet to 216.177.45.136[500] 2001-12-21 05:21:06: DEBUG: isakmp.c:1327:isakmp_send(): 1 times of 200 bytes message will be sent. 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 35f876fb d758d3fb 162b149d 4b495389 04100200 00000000 000000c8 0a000084 db3ac7b7 27dc6b2e a48c20d8 c0291455 85c12ee3 bb6a31d0 275bce01 75621606 04d00c4b 45e03ef8 06a035c9 3a95a356 2be1cc1b 5579a53d b269c5fb 8d24ae9f d6ea69fb d934e700 02c772a3 2cb296a1 8dc48a29 522c830d 3093c82a ed10377f 147400c4 8ff4da71 302eade3 b876a579 3133982f 71de2469 11061a49 f6d75213 0d000014 d573e173 47f2e5fb 35793071 aac559da 00000014 7003cbc1 097dbe9c 2600ba69 83bc8b35 2001-12-21 05:21:06: DEBUG: oakley.c:192:oakley_dh_compute(): compute DH's shared. 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): d134a9ca 135a5824 172566cd 774b339e dc06d87a 22e3c842 7f42c4fc d2d24ccc 3d3a7704 8f12de15 6fa720fa a277d2d7 5308bdd4 be66af82 80afc6e6 4b4aa03b c0532a8a 942ef53b b4930c15 3e91c9a4 c608d45f 245251cf 1c53fa98 41b42646 20b0d9aa 96e5541d 7a62b24a f8908c9f 597e1eb6 f7782566 ff343261 c3b302a32001-12-21 05:21:06: DEBUG: oakley.c:1924:oakley_skeyid(): psk found: 2001-12-21 05:21:06: DEBUG2: plog.c:204:plogdump(): 6d656b6d 69746173 6469676f 6174 2001-12-21 05:21:06: DEBUG: oakley.c:1938:oakley_skeyid(): nonce 1: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 00cfc3d8 ad4b5986 2001-12-21 05:21:06: DEBUG: oakley.c:1944:oakley_skeyid(): nonce 2: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): d573e173 47f2e5fb 35793071 aac559da 2001-12-21 05:21:06: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:21:06: DEBUG: oakley.c:1997:oakley_skeyid(): SKEYID computed: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 58ed2a80 7fd730d4 c8b94c55 3df4e0e4 90de5805 2001-12-21 05:21:06: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:21:06: DEBUG: oakley.c:2054:oakley_skeyid_dae(): SKEYID_d computed: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 1870f0ad 8134631f 9c3ba001 d053ab7e 50fb1b73 2001-12-21 05:21:06: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:21:06: DEBUG: oakley.c:2083:oakley_skeyid_dae(): SKEYID_a computed: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 93c081cb aa3e3903 1ebd5f29 0c632001 31f6f8bf 2001-12-21 05:21:06: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:21:06: DEBUG: oakley.c:2112:oakley_skeyid_dae(): SKEYID_e computed: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): ab30c8c3 30ea22d4 7c96ad93 b5459b11 5f2aee1e 2001-12-21 05:21:06: DEBUG: oakley.c:2207:oakley_compute_enckey(): len(SKEYID_e) < len(Ka) (20 < 24), generating long key (Ka = K1 | K2 | ...) 2001-12-21 05:21:06: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:21:06: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K1 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 00 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 4a702cc1 786c04a2 31c75356 83bd730e f4f097ea 2001-12-21 05:21:06: DEBUG: oakley.c:310:oakley_prf(): hmac-sha1 used. 2001-12-21 05:21:06: DEBUG: oakley.c:2232:oakley_compute_enckey(): compute intermediate cipher key K2 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 4a702cc1 786c04a2 31c75356 83bd730e f4f097ea 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): b4fe4a65 083ac252 12d384e7 472aa75d 579d9ae1 2001-12-21 05:21:06: DEBUG: oakley.c:2276:oakley_compute_enckey(): final cipher key computed: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 4a702cc1 786c04a2 31c75356 83bd730e f4f097ea b4fe4a65 2001-12-21 05:21:06: DEBUG: oakley.c:353:oakley_hash(): use sha1 to calculate phase 1. 2001-12-21 05:21:06: DEBUG: oakley.c:2379:oakley_newiv(): IV computed: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 55cd8d9b 1f5ca7ba 2001-12-21 05:21:06: DEBUG: isakmp.c:231:isakmp_handler(): === 2001-12-21 05:21:06: DEBUG: isakmp.c:232:isakmp_handler(): 68 bytes message received from 216.177.45.136[500] 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 35f876fb d758d3fb 162b149d 4b495389 05100201 00000000 00000044 14babd3e 4eed8b63 ab3c0314 a81b18fa 4ee356c2 f7ac3bfd 5e8d4a58 06e0689e ed5d0de8 5da51d88 2001-12-21 05:21:06: DEBUG: isakmp.c:2110:isakmp_printpacket(): begin. 2001-12-21 05:21:06: DEBUG: oakley.c:2492:oakley_do_decrypt(): begin decryption. 2001-12-21 05:21:06: DEBUG: oakley.c:2498:oakley_do_decrypt(): IV was saved for next processing: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): ed5d0de8 5da51d88 2001-12-21 05:21:06: DEBUG: oakley.c:2523:oakley_do_decrypt(): decrypt(3des) 2001-12-21 05:21:06: DEBUG: oakley.c:2526:oakley_do_decrypt(): with key: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 4a702cc1 786c04a2 31c75356 83bd730e f4f097ea b4fe4a65 2001-12-21 05:21:06: DEBUG: oakley.c:2535:oakley_do_decrypt(): decrypted payload by IV: 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): ed5d0de8 5da51d88 2001-12-21 05:21:06: DEBUG: oakley.c:2538:oakley_do_decrypt(): decrypted payload, but not trimed. 2001-12-21 05:21:06: DEBUG: plog.c:204:plogdump(): 08000