Test Information

TitleUsing new SA for outbound traffic **
CommandLine./SGW/SG_R_RFC2408_5_3_2_1.seq -pkt ./SGW/SG_R_RFC2408_5_3_2_1.def test_phase=2 test_type=BASIC -log 242.html -ti Using new SA for outbound traffic **
TestVersionundefined
ToolVersionREL_3_0_8
Start2006/03/13 16:24:59
Tn/usr/local/v6eval//etc//tn.def
Nu/usr/local/v6eval//etc//nut.def
Pkt./SGW/SG_R_RFC2408_5_3_2_1.def
Systemfreebsd-i386
TargetNameFreeBSD 5.4-RELEASE
HostNametarget1.tahi.org
Typerouter

Test Sequence Execution Log

16:25:00Start

*** Target IKE initialization phase ***
Target: Reset IKE SA entries: saddump
16:25:00 vRemote(ikeResetSA.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ikeResetSA.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 saddump ''
Connected

target1# 
target1# /usr/sbin/setkey -c <<EOD
dump;
flush;
EOD

? dump;
? flush;
? EOD
The result of line 1: No SAD entries.
target1# 
target1# sendMessagesSync: never got /usr/sbin/setkey -c <<EODdump;flush;EOD
echo $status
0
target1# kill -TERM `head -1 /var/run/racoon.pid`
head: /var/run/racoon.pid: No such file or directory

target1# 
target1# echo $status
1
target1# /bin/rm -f /var/run/racoon.pid

target1# 
target1# echo $status
0
~
[EOT]

Target: Clear SPD entries: spddump
16:25:06 vRemote(ipsecResetSPD.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ipsecResetSPD.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 spddump ''
Connected

target1# 
target1# /usr/sbin/setkey -c <<EOD
spddump;
spdflus? spddump;
h;
EOD

? spdflush;
EOD

? EOD
The result of line 1: No SPD entries.
target1# 
target1# sendMessagesSync: never got /usr/sbin/setkey -c <<EODspddump;spdflush;EOD
echo $status
0
~
[EOT]

Target: Set SPD entries: src=3ffe:501:ffff:100::/64 dst=3ffe:501:ffff:104::/64 tsrc=3ffe:501:ffff:102::1 tdst=3ffe:501:ffff:103::11 upperspec=any direction=out protocol=PROTO_IPSEC_ESP mode=Tunnel
16:25:12 vRemote(ipsecSetSPD.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ipsecSetSPD.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 src=3ffe:501:ffff:100::/64 dst=3ffe:501:ffff:104::/64 tsrc=3ffe:501:ffff:102::1 tdst=3ffe:501:ffff:103::11 upperspec=any direction=out protocol=PROTO_IPSEC_ESP mode=Tunnel ''
Connected

target1# 
target1# /usr/sbin/setkey -c <<EOD
spdadd 3ffe:501:ffff:100::/64 3ffe:501:ffff:104::/64
       any
       -P out ipsec
       esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require
;
spddump;
EOD

? spdadd 3ffe:501:ffff:100::/64 3ffe:501:ffff:104::/64
       any
       -P out ipsec
       esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require
;
spddump;
EOD

?        any
?        -P out ipsec
?        esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require
? ;
? spddump;
? EOD
3ffe:501:ffff:100::/64[any] 3ffe:501:ffff:104::/64[any] any
        out ipsec
        esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require
        created: Mar 13 16:31:51 2006  lastused: Mar 13 16:31:51 2006
        lifetime: 0(s) validtime: 0(s)
        spid=19264 seq=0 pid=3159
        refcnt=1
target1# 
target1# sendMessagesSync: never got /usr/sbin/setkey -c <<EODspdadd 3ffe:501:ffff:100::/64 3ffe:501:ffff:104::/64       any       -P out ipsec       esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require;spddump;EOD
echo $status
0
~
[EOT]

Target: Set SPD entries: dst=3ffe:501:ffff:100::/64 src=3ffe:501:ffff:104::/64 tdst=3ffe:501:ffff:102::1 tsrc=3ffe:501:ffff:103::11 upperspec=any direction=in protocol=PROTO_IPSEC_ESP mode=Tunnel
16:25:18 vRemote(ipsecSetSPD.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ipsecSetSPD.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 dst=3ffe:501:ffff:100::/64 src=3ffe:501:ffff:104::/64 tdst=3ffe:501:ffff:102::1 tsrc=3ffe:501:ffff:103::11 upperspec=any direction=in protocol=PROTO_IPSEC_ESP mode=Tunnel ''
Connected

target1# 
target1# /usr/sbin/setkey -c <<EOD
spdadd 3ffe:501:ffff:104::/64 3ffe:501:ffff:100::/64
       any
       -P in ipsec
       esp/tunnel/3ffe:501:ffff:103::11-3ffe:501:ffff:102::1/require
;
spddump;
EOD

? spdadd 3ffe:501:ffff:104::/64 3ffe:501:ffff:100::/64
       any
       -P in ipsec
       esp/tunnel/3ffe:501:ffff:103::11-3ffe:501:ffff:102::1/require
;
spddump;
EOD

?        any
?        -P in ipsec
?        esp/tunnel/3ffe:501:ffff:103::11-3ffe:501:ffff:102::1/require
? ;
? spddump;
? EOD
3ffe:501:ffff:104::/64[any] 3ffe:501:ffff:100::/64[any] any
        in ipsec
        esp/tunnel/3ffe:501:ffff:103::11-3ffe:501:ffff:102::1/require
        created: Mar 13 16:31:57 2006  lastused: Mar 13 16:31:57 2006
        lifetime: 0(s) validtime: 0(s)
        spid=19265 seq=1 pid=3160
        refcnt=1
3ffe:501:ffff:100::/64[any] 3ffe:501:ffff:104::/64[any] any
        out ipsec
        esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require
        created: Mar 13 16:31:51 2006  lastused: Mar 13 16:31:51 2006
        lifetime: 0(s) validtime: 0(s)
        spid=19264 seq=0 pid=3160
        refcnt=1
target1# 
target1# sendMessagesSync: never got /usr/sbin/setkey -c <<EODspdadd 3ffe:501:ffff:104::/64 3ffe:501:ffff:100::/64       any       -P in ipsec       esp/tunnel/3ffe:501:ffff:103::11-3ffe:501:ffff:102::1/require;spddump;EOD
echo $status
0
~
[EOT]

Target: Set IKE SA entries: dst=3ffe:501:ffff:103::11 dst_port=500 exchange_mode=main doi=ipsec_doi situation=identity_only isakmp_src_id_type=address isakmp_src_id=3ffe:501:ffff:102::1 dh_group=2 lifetime=28800 lifetime_unit=seconds encryption_algorithm=3des hash_algorithm=sha1 authentication_method=pre_shared_key key_id=3ffe:501:ffff:103::11 key_value=0x494b452d54455354 ph2_id_type=address ph2_src_id=3ffe:501:ffff:100::/64 ph2_dst_id=3ffe:501:ffff:104::/64 ph2_src_upper=any ph2_dst_upper=any ipsec_p_num=1 ipsec_p1_t_num=1 ph2_p1_t1_lt=60 ph2_p1_t1_lt_unit=seconds ph2_p1_t1_enc_alg=ESP_3DES ph2_p1_t1_auth_mtd=HMAC_SHA
16:25:25 vRemote(ikeSetSA.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ikeSetSA.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 dst=3ffe:501:ffff:103::11 dst_port=500 exchange_mode=main doi=ipsec_doi situation=identity_only isakmp_src_id_type=address isakmp_src_id=3ffe:501:ffff:102::1 dh_group=2 lifetime=28800 lifetime_unit=seconds encryption_algorithm=3des hash_algorithm=sha1 authentication_method=pre_shared_key key_id=3ffe:501:ffff:103::11 key_value=0x494b452d54455354 ph2_id_type=address ph2_src_id=3ffe:501:ffff:100::/64 ph2_dst_id=3ffe:501:ffff:104::/64 ph2_src_upper=any ph2_dst_upper=any ipsec_p_num=1 ipsec_p1_t_num=1 ph2_p1_t1_lt=60 ph2_p1_t1_lt_unit=seconds ph2_p1_t1_enc_alg=ESP_3DES ph2_p1_t1_auth_mtd=HMAC_SHA ''
Connected

target1# 
target1# ~[set] echocheck

target1# 
target1# ~[put] freebsd-i386.psk.txt /tmp/psk.txt
Dtarget1# 

target1# 
target1# /bin/chmod 600 /tmp/psk.txt
target1# echo $status
0
target1# ~[set] echocheck

target1# 
target1# ~[put] freebsd-i386.ike.conf /tmp/ike.conf
Dtarget1# 

target1# 
target1# test -f /var/run/racoon.pid &&kill -TERM `head -1 /var/run/racoon.pid`

target1# 
target1# echo $status
1
target1# /usr/local/sbin/racoon -f /tmp/ike.conf

target1# 
target1# echo $status
0
~
[EOT]
16:25:39 vRemote(ikeEnable.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ikeEnable.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 ''


*** Target initialization phase ***
16:25:40Start Capturing Packets (Link0)
16:25:40Start Capturing Packets (Link1)

*** Target pre-test seaquence ***
*** Phase-1 1st message send ***
16:25:40Clear Captured Packets (Link0)
16:25:40 vSend(Link0,isakmp_phase1_send_1st)
Send 1st message from HOST2(TN)

*** Phase-1 2nd message recieve ***
16:25:40 vRecv(Link0,isakmp_phase1_recv_2nd router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Receive Neighbor Solicitation from SGW1(NUT)
16:25:41 vSend(Link0,router_na)
Send Neighbor Advertisement(TN)
16:25:41 vRecv(Link0,isakmp_phase1_recv_2nd router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Recv 2nd message from HOST1(NUT)

OK payload_check
*** Phase-1 3rd message send ***
16:25:41Clear Captured Packets (Link0)
16:25:41 vSend(Link0,isakmp_phase1_send_3rd)
Send 3rd message from HOST2(TN)

*** Phase-1 4th message recieve ***
16:25:41 vRecv(Link0,isakmp_phase1_recv_4th router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Recv 4th message from HOST1(NUT)

OK payload_check
*** Phase-1 5th message send ***
16:25:42Clear Captured Packets (Link0)
16:25:42 vSend(Link0,isakmp_phase1_send_5th)
Send 5th message from HOST2(TN)

*** Phase-1 6th message recieve ***
16:25:43 vRecv(Link0,isakmp_phase1_recv_6th router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Recv 6th message from HOST1(NUT)

OK payload_check
*** Target testing phase start ***
*** Phase-2 1st message send ***
16:25:43Clear Captured Packets (Link0)
16:25:43Clear Captured Packets (Link1)
16:25:43 vSend(Link0,isakmp_phase2_send)
Send Phase-2 1st message (HDR*, HASH(1), SA, Ni) from HOST2(TN)

*** Phase-2 2nd message recv ***
16:25:43 vRecv(Link0,isakmp_phase2_recv_2nd router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Recv Phase-2 2nd message (HDR*, HASH(2), SA, Ni) from HOST1(NUT)

OK payload_check
*** Phase-2 3rd message send ***
16:25:44Clear Captured Packets (Link0)
16:25:44Clear Captured Packets (Link1)
16:25:44 vSend(Link0,isakmp_phase2_send_3rd)
Send Phase-2 3rd message HDR*, HASH(3) from HOST2(TN)
16:25:44 Wait 1 second

*** 1st IPsec SA is esatblished ***
*** Wait 42 sec to expire IPsec SA Lifetime ***
16:25:45 Wait 42 second

## 1st SA elapsed time: 42 ##
*** Re-Key phase start ***
*** Re-Key 1st message send ***
16:26:27Clear Captured Packets (Link0)
16:26:28Clear Captured Packets (Link1)
16:26:28 vSend(Link0,isakmp_phase2_send)
Send Phase-2 1st message (HDR*, HASH(1), SA, Ni) from HOST2(TN)

*** Re-Key 2nd message recv ***
16:26:28 vRecv(Link0,isakmp_phase2_recv_2nd router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Recv Phase-2 2nd message (HDR*, HASH(2), SA, Ni) from HOST1(NUT)

OK payload_check
*** Re-Key 3rd message send ***
16:26:28Clear Captured Packets (Link0)
16:26:28Clear Captured Packets (Link1)
16:26:29 vSend(Link0,isakmp_phase2_send_3rd)
Send Phase-2 3rd message HDR*, HASH(3) from HOST2(TN)
16:26:29 Wait 1 second

*** Re-Key IPsec SA is esatblished ***
*** Encrypted Echo Request message send using 2nd IPsec SA ***
16:26:30Clear Captured Packets (Link0)
16:26:30Clear Captured Packets (Link1)

## 1st SA elapsed time: 45 ##
## 2nd SA elapsed time: 0 ##
16:26:30 vSend(Link0,echo_request_send_esp_tunnel_net3sgw2_net2sgw1)
Send Encrypted Echo Request from HOST-2(TN)
16:26:31 vRecv(Link1,echo_request_recv_net4host2_net0host1 router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Receive Neighbor Solicitation from SGW1(NUT)
16:26:31 vSend(Link1,router_na_link1)
Send Neighbor Advertisement(TN)
16:26:31 vRecv(Link1,echo_request_recv_net4host2_net0host1 router_ns_multi router_ns_uni_link1 router_ns_uni_tll_sll_link1 router_ns_multi_llt_link1 router_ns_uni_sll router_ns_uni router_ns_multi_llt router_ns_uni_sll_link1 router_ns_multi_link1 router_ns_uni_tll_sll) timeout:5 cntLimit:0 seektime:0
Receive Echo Request from HOST-2(TN) via SGW1(NUT)

*** Echo Request message recv ***
Using new SA for outbound traffic is correct
*** Target test finish ***
16:26:32Stop Capturing Packets (Link0)
16:26:32Stop Capturing Packets (Link1)

Target: Reset IKE SA entries: saddump
16:26:32 vRemote(ikeResetSA.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ikeResetSA.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 saddump ''
Connected

target1# 
target1# /usr/sbin/setkey -c <<EOD
dump;
flush;
EOD
? dump;
? flush;

? EOD
3ffe:501:ffff:102::1 3ffe:501:ffff:103::11 
        esp mode=tunnel spi=4097(0x00001001) reqid=0(0x00000000)
        E: 3des-cbc  e31c4193 fb53e8f7 b0b91998 b36a20e5 9301d84b d7d84c14
        A: hmac-sha1  8ed6dfd4 c1abf0ed 127a8058 be1745a8 7125679e
        seq=0x00000000 replay=4 flags=0x00000000 state=mature 
        created: Mar 13 16:33:06 2006   current: Mar 13 16:33:10 2006
        diff: 4(s)      hard: 60(s)     soft: 48(s)
        last:                           hard: 0(s)      soft: 0(s)
        current: 0(bytes)       hard: 0(bytes)  soft: 0(bytes)
        allocated: 0    hard: 0 soft: 0
        sadb_seq=3 pid=3180 refcnt=1
3ffe:501:ffff:102::1 3ffe:501:ffff:103::11 
        esp mode=tunnel spi=4096(0x00001000) reqid=0(0x00000000)
        E: 3des-cbc  542a6b5e 7425741a d7e4a014 771f5ef1 f8d292ff 32affa72
        A: hmac-sha1  1bef26df 2e610ed5 96a05781 b2b64b90 207017ca
        seq=0x00000000 replay=4 flags=0x00000000 state=mature 
        created: Mar 13 16:32:21 2006   current: Mar 13 16:33:10 2006
        diff: 49(s)     hard: 60(s)     soft: 48(s)
        last:                           hard: 0(s)      soft: 0(s)
        current: 0(bytes)       hard: 0(bytes)  soft: 0(bytes)
        allocated: 0    hard: 0 soft: 0
        sadb_seq=2 pid=3180 refcnt=1
3ffe:501:ffff:103::11 3ffe:501:ffff:102::1 
        esp mode=tunnel spi=218885925(0x0d0bef25) reqid=0(0x00000000)
        E: 3des-cbc  da996d0b 5f24e42c 55cc1905 46117a8f f34aa45b 0f906ec7
        A: hmac-sha1  77d73ebe d4da2c7b 03f7130a de477043 87cfc1a3
        seq=0x00000001 replay=4 flags=0x00000000 state=mature 
        created: Mar 13 16:33:06 2006   current: Mar 13 16:33:11 2006
        diff: 5(s)      hard: 60(s)     soft: 48(s)
        last: Mar 13 16:33:08 2006      hard: 0(s)      soft: 0(s)
        current: 56(bytes)      hard: 0(bytes)  soft: 0(bytes)
        allocated: 1    hard: 0 soft: 0
        sadb_seq=1 pid=3180 refcnt=1
3ffe:501:ffff:103::11 3ffe:501:ffff:102::1 
        esp mode=tunnel spi=74299529(0x046db889) reqid=0(0x00000000)
        E: 3des-cbc  b8a43454 1cde7aaa 6a4cdc24 47a61050 1444dad9 3446e8fa
        A: hmac-sha1  106681ab ab6b503c 6abcff2c a818b6d4 228d75b8
        seq=0x00000000 replay=4 flags=0x00000000 state=mature 
        created: Mar 13 16:32:21 2006   current: Mar 13 16:33:11 2006
        diff: 50(s)     hard: 60(s)     soft: 48(s)
        last:                           hard: 0(s)      soft: 0(s)
        current: 0(bytes)       hard: 0(bytes)  soft: 0(bytes)
        allocated: 0    hard: 0 soft: 0
        sadb_seq=0 pid=3180 refcnt=1
target1# 
target1# sendMessagesSync: never got /usr/sbin/setkey -c <<EODdump;flush;EOD
echo $status
0
target1# kill -TERM `head -1 /var/run/racoon.pid`

target1# 
target1# echo $status
0
target1# /bin/rm -f /var/run/racoon.pid

target1# 
target1# echo $status
0
~
[EOT]

Target: Clear SPD entries: spddump
16:26:38 vRemote(ipsecResetSPD.rmt) ``/usr/local/v6eval//bin/freebsd-i386//ipsecResetSPD.rmt -t freebsd-i386 -u root -p v6eval -d cuad0 -o 1 spddump ''
Connected

target1# 
target1# /usr/sbin/setkey -c <<EOD
spddump;
spdflush;? spddump;

EOD

? spdflush;
EOD

? EOD
3ffe:501:ffff:104::/64[any] 3ffe:501:ffff:100::/64[any] any
        in ipsec
        esp/tunnel/3ffe:501:ffff:103::11-3ffe:501:ffff:102::1/require
        created: Mar 13 16:31:57 2006  lastused: Mar 13 16:33:08 2006
        lifetime: 0(s) validtime: 0(s)
        spid=19265 seq=1 pid=3183
        refcnt=1
3ffe:501:ffff:100::/64[any] 3ffe:501:ffff:104::/64[any] any
        out ipsec
        esp/tunnel/3ffe:501:ffff:102::1-3ffe:501:ffff:103::11/require
        created: Mar 13 16:31:51 2006  lastused: Mar 13 16:31:51 2006
        lifetime: 0(s) validtime: 0(s)
        spid=19264 seq=0 pid=3183
        refcnt=1
target1# 
target1# sendMessagesSync: never got /usr/sbin/setkey -c <<EODspddump;spdflush;EOD
echo $status
0
~
[EOT]

OK
16:26:44End

Packet Reverse Log