Test Infomation

Title	Connect two SA bundles with different spi, same IPsrc
CommandLine	./HTR_E_In_2SA_DspiSipsrc.seq -pkt ./HTR_E_2SA_DspiSip.def -log 56.html -ti Connect two SA bundles with different spi, same IPsrc
TestVersion	REL_1_1
ToolVersion	REL_1_1
Start	2000/07/31 18:48:03
Tn	/usr/local/v6eval//etc//tn.def
Nu	/usr/local/v6eval//etc//nut.def
Pkt	./HTR_E_2SA_DspiSip.def
System	kame-freebsd
TargetName	FreeBSD-3.4 Release + KAME-stable-20000704
HostName	target1.toba.tahi.org
Type	host

Test Sequence Execution Log

18:48:04	Start
	* Target initialization phase * Target: Clear all SAD and SPD entries
18:48:04	vRemote(ipsecClearAll.rmt) ``/usr/local/v6eval//bin/kame-freebsd/ipsecClearAll.rmt -t kame-freebsd -u root -p v6eval -d cuaa0c -o 1 '' connected target1# target1# /usr/local/v6/sbin/setkey -c spdflush; flush; ^D target1# target1# sendMessagesSync: never got /usr/local/v6/sbin/setkey -cspdflush;flush; echo $status 0 target1# ~ [EOT]
	Target: Set SAD entries: src="3ffe:501:ffff:ff05:200:ff:fe00:c1c1" dst="3ffe:501:ffff:ff03:200:ff:fe00:b0b0" spi=0x1000 mode=transport protocol=esp ealgo=des-cbc ealgokey=01234567
18:48:10	vRemote(ipsecSetSAD.rmt) ``/usr/local/v6eval//bin/kame-freebsd/ipsecSetSAD.rmt -t kame-freebsd -u root -p v6eval -d cuaa0c -o 1 src="3ffe:501:ffff:ff05:200:ff:fe00:c1c1" dst="3ffe:501:ffff:ff03:200:ff:fe00:b0b0" spi=0x1000 mode=transport protocol=esp ealgo=des-cbc ealgokey=01234567 '' connected target1# target1# /usr/local/v6/sbin/setkey -c add 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp 0x1000 -m transport -E des-cbc "01234567" ; dump; ^D 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp mode=transport spi=4096(0x00001000) reqid=0(0x00000000) E: des-cbc 30313233 34353637 replay=0 flags=0x00000040 state=mature seq=0 pid=484 created: Jul 31 18:47:22 2000 current: Jul 31 18:47:22 2000 diff: 0(s) hard: 0(s) soft: 0(s) last: hard: 0(s) soft: 0(s) current: 0(bytes) hard: 0(bytes) soft: 0(bytes) allocated: 0 hard: 0 soft: 0 refcnt=1 target1# target1# sendMessagesSync: never got /usr/local/v6/sbin/setkey -cadd 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp 0x1000 -m transport -E des-cbc "01234567";dump; echo $status 0 target1# ~ [EOT]
	Target: Set SAD entries: src="3ffe:501:ffff:ff05:200:ff:fe00:c1c1" dst="3ffe:501:ffff:ff03:200:ff:fe00:b0b0" spi=0x2000 mode=transport protocol=esp ealgo=des-cbc ealgokey=foo0foo1
18:48:20	vRemote(ipsecSetSAD.rmt) ``/usr/local/v6eval//bin/kame-freebsd/ipsecSetSAD.rmt -t kame-freebsd -u root -p v6eval -d cuaa0c -o 1 src="3ffe:501:ffff:ff05:200:ff:fe00:c1c1" dst="3ffe:501:ffff:ff03:200:ff:fe00:b0b0" spi=0x2000 mode=transport protocol=esp ealgo=des-cbc ealgokey=foo0foo1 '' connected target1# target1# /usr/local/v6/sbin/setkey -c add 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp 0x2000 -m transport -E des-cbc "foo0foo1" ; dump; ^D 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp mode=transport spi=8192(0x00002000) reqid=0(0x00000000) E: des-cbc 666f6f30 666f6f31 replay=0 flags=0x00000040 state=mature seq=1 pid=485 created: Jul 31 18:47:31 2000 current: Jul 31 18:47:31 2000 diff: 0(s) hard: 0(s) soft: 0(s) last: hard: 0(s) soft: 0(s) current: 0(bytes) hard: 0(bytes) soft: 0(bytes) allocated: 0 hard: 0 soft: 0 refcnt=1 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp mode=transport spi=4096(0x00001000) reqid=0(0x00000000) E: des-cbc 30313233 34353637 replay=0 flags=0x00000040 state=mature seq=0 pid=485 created: Jul 31 18:47:22 2000 current: Jul 31 18:47:31 2000 diff: 9(s) hard: 0(s) soft: 0(s) last: hard: 0(s) soft: 0(s) current: 0(bytes) hard: 0(bytes) soft: 0(bytes) allocated: 0 hard: 0 soft: 0 refcnt=1 target1# target1# sendMessagesSync: never got /usr/local/v6/sbin/setkey -cadd 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 esp 0x2000 -m transport -E des-cbc "foo0foo1";dump; echo $status 0 target1# ~ [EOT]
	Target: Set SPD entries: src="3ffe:501:ffff:ff05:200:ff:fe00:c1c1" dst="3ffe:501:ffff:ff03:200:ff:fe00:b0b0" upperspec=any direction=in protocol=esp mode=transport
18:48:29	vRemote(ipsecSetSPD.rmt) ``/usr/local/v6eval//bin/kame-freebsd/ipsecSetSPD.rmt -t kame-freebsd -u root -p v6eval -d cuaa0c -o 1 src="3ffe:501:ffff:ff05:200:ff:fe00:c1c1" dst="3ffe:501:ffff:ff03:200:ff:fe00:b0b0" upperspec=any direction=in protocol=esp mode=transport '' connected target1# target1# /usr/local/v6/sbin/setkey -c spdadd 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 any -P in ipsec esp/transport/3ffe:501:ffff:ff05:200:ff:fe00:c1c1-3ffe:501:ffff:ff03:200:ff:fe00:b0b0/require ; spddump; ^D 3ffe:501:ffff:ff05:200:ff:fe00:c1c1[any] 3ffe:501:ffff:ff03:200:ff:fe00:b0b0[any] any in ipsec esp/transport/3ffe:501:ffff:ff05:200:ff:fe00:c1c1-3ffe:501:ffff:ff03:200:ff:fe00:b0b0/require spid=61 seq=0 pid=486 refcnt=1 target1# target1# sendMessagesSync: never got /usr/local/v6/sbin/setkey -cspdadd 3ffe:501:ffff:ff05:200:ff:fe00:c1c1 3ffe:501:ffff:ff03:200:ff:fe00:b0b0 any -P in ipsec esp/transport/3ffe:501:ffff:ff05:200:ff:fe00:c1c1-3ffe:501:ffff:ff03:200:ff:fe00:b0b0/require;spddump; echo $status 0 target1# ~ [EOT]
	* Target testing phase *
18:48:39	Start Capturing Packets (Link0)
18:48:39	vSend(Link0,echo_request_from_host1_esp) send echo_request_from_host1_esp
18:48:40	vRecv(Link0,ns_to_router echo_reply_to_host1) timeout:6 cntLimit:0 seektime:0 recv echo_reply_to_host1
18:48:40	vRecv(Link0,ns_to_router) timeout:6 cntLimit:0 seektime:0 recv ns_to_router
18:48:45	vSend(Link0,na_from_router) send na_from_router
	NC about Router was PROBE state, but now it's REACHABLE.
18:48:45	vRecv(Link0,ns_to_router) timeout:6 cntLimit:0 seektime:0 vRecv() return status=1
18:48:51	vRecv(Link0,ns_to_router) timeout:6 cntLimit:0 seektime:0 vRecv() return status=1
	TN received echo reply from NUT to HOST1. (SPI=0x1000) Ping over 1st SA bundle is available.
18:48:57	vSend(Link0,echo_request_from_host1_esp_2) send echo_request_from_host1_esp_2
18:48:57	vRecv(Link0,ns_to_router echo_reply_to_host1_2) timeout:6 cntLimit:0 seektime:0 recv echo_reply_to_host1_2
18:48:57	vRecv(Link0,ns_to_router) timeout:6 cntLimit:0 seektime:0 vRecv() return status=1
	TN received echo reply from NUT to HOST1. (SPI=0x2000) Ping over 2nd SA bundle is available. Ping over coexisting two SA bundles are available. OK
18:49:03	End

Packet Reverse Log

send echo_request_from_host1_esp at 18:48:40

Frame_Ether                     (length:86)
| Hdr_Ether                       (length:14)
| | DestinationAddress               = 0:a0:24:95:a4:91
| | SourceAddress                    = 0:0:0:0:a0:a0
| | Type                             = 34525
| Packet_IPv6                     (length:72)
| | Hdr_IPv6                        (length:40)
| | | Version                          = 6
| | | TrafficClass                     = 0
| | | FlowLabel                        = 0
| | | PayloadLength                    = 32
| | | NextHeader                       = 50
| | | HopLimit                         = 64
| | | SourceAddress                    = 3ffe:501:ffff:ff05:200:ff:fe00:c1c1
| | | DestinationAddress               = 3ffe:501:ffff:ff03:200:ff:fe00:b0b0
| | Hdr_ESP                         (length:32)
| | | SPI                              = 4096
| | | SequenceNumber                   = 1
| | | algorithm                        = ealgo_descbc_012
| | | IVEC                             = 80000000 00000000
| | | Decrypted                       (length:16)
| | | | ESPPayload                      (length:14)
| | | | | ICMPv6_EchoRequest              (length:14)
| | | | | | Type                             = 128
| | | | | | Code                             = 0
| | | | | | Checksum                         = 43592 calc(43592)
| | | | | | Identifier                       = 0
| | | | | | SequenceNumber                   = 0
| | | | | | Payload                         (length:6)
| | | | | | | data                             = 44617461 2031
| | | | Padding                          = 
| | | | PadLength                        = 0
| | | | NextHeader                       = 58
| | | ICV                              =  calc()

Recv at 18:48:40

Frame_Ether                     (length:68)
| Hdr_Ether                       (length:14)
| | DestinationAddress               = 0:0:0:0:a0:a0
| | SourceAddress                    = 0:a0:24:95:a4:91
| | Type                             = 34525
| Packet_IPv6                     (length:54)
| | Hdr_IPv6                        (length:40)
| | | Version                          = 6
| | | TrafficClass                     = 0
| | | FlowLabel                        = 0
| | | PayloadLength                    = 14
| | | NextHeader                       = 58
| | | HopLimit                         = 64
| | | SourceAddress                    = 3ffe:501:ffff:ff03:200:ff:fe00:b0b0
| | | DestinationAddress               = 3ffe:501:ffff:ff05:200:ff:fe00:c1c1
| | ICMPv6_EchoReply                (length:14)
| | | Type                             = 129
| | | Code                             = 0
| | | Checksum                         = 43336 calc(43336)
| | | Identifier                       = 0
| | | SequenceNumber                   = 0
| | | Payload                         (length:6)
| | | | data                             = 44617461 2031
===ns_to_router=================================
ng compare _HDR_IPV6_ns_to_router.HopLimit received:64 = 255
ng compare _HDR_IPV6_ns_to_router.DestinationAddress received:3ffe:501:ffff:ff05:200:ff:fe00:c1c1 = oneof(v6("3ffe:501:ffff:ff03:200:ff:fe00:a0a0"),v6merge("FF02:0:0:0:0:1:FF00:0000",104,v6("3ffe:501:ffff:ff03:200:ff:fe00:a0a0")))
ng meta Packet_IPv6.ICMPv6_NS != Packet_IPv6.ICMPv6_EchoReply
===echo_reply_to_host1=================================

Recv at 18:48:45

Frame_Ether                     (length:86)
| Hdr_Ether                       (length:14)
| | DestinationAddress               = 0:0:0:0:a0:a0
| | SourceAddress                    = 0:a0:24:95:a4:91
| | Type                             = 34525
| Packet_IPv6                     (length:72)
| | Hdr_IPv6                        (length:40)
| | | Version                          = 6
| | | TrafficClass                     = 0
| | | FlowLabel                        = 0
| | | PayloadLength                    = 32
| | | NextHeader                       = 58
| | | HopLimit                         = 255
| | | SourceAddress                    = 3ffe:501:ffff:ff03:200:ff:fe00:b0b0
| | | DestinationAddress               = 3ffe:501:ffff:ff03:200:ff:fe00:a0a0
| | ICMPv6_NS                       (length:32)
| | | Type                             = 135
| | | Code                             = 0
| | | Checksum                         = 60641 calc(60641)
| | | Reserved                         = 0
| | | TargetAddress                    = 3ffe:501:ffff:ff03:200:ff:fe00:a0a0
| | | Opt_ICMPv6_SLL                  (length:8)
| | | | Type                             = 1
| | | | Length                           = 1
| | | | LinkLayerAddress                 = 0:a0:24:95:a4:91
===ns_to_router=================================

send na_from_router at 18:48:45

Frame_Ether                     (length:86)
| Hdr_Ether                       (length:14)
| | DestinationAddress               = 0:a0:24:95:a4:91
| | SourceAddress                    = 0:0:0:0:a0:a0
| | Type                             = 34525
| Packet_IPv6                     (length:72)
| | Hdr_IPv6                        (length:40)
| | | Version                          = 6
| | | TrafficClass                     = 0
| | | FlowLabel                        = 0
| | | PayloadLength                    = 32
| | | NextHeader                       = 58
| | | HopLimit                         = 255
| | | SourceAddress                    = 3ffe:501:ffff:ff03:200:ff:fe00:a0a0
| | | DestinationAddress               = 3ffe:501:ffff:ff03:200:ff:fe00:b0b0
| | ICMPv6_NA                       (length:32)
| | | Type                             = 136
| | | Code                             = 0
| | | Checksum                         = 13319 calc(13319)
| | | RFlag                            = 1
| | | SFlag                            = 1
| | | OFlag                            = 1
| | | Reserved                         = 0
| | | TargetAddress                    = 3ffe:501:ffff:ff03:200:ff:fe00:a0a0
| | | Opt_ICMPv6_TLL                  (length:8)
| | | | Type                             = 2
| | | | Length                           = 1
| | | | LinkLayerAddress                 = 0:0:0:0:a0:a0

send echo_request_from_host1_esp_2 at 18:48:57

Frame_Ether                     (length:86)
| Hdr_Ether                       (length:14)
| | DestinationAddress               = 0:a0:24:95:a4:91
| | SourceAddress                    = 0:0:0:0:a0:a0
| | Type                             = 34525
| Packet_IPv6                     (length:72)
| | Hdr_IPv6                        (length:40)
| | | Version                          = 6
| | | TrafficClass                     = 0
| | | FlowLabel                        = 0
| | | PayloadLength                    = 32
| | | NextHeader                       = 50
| | | HopLimit                         = 64
| | | SourceAddress                    = 3ffe:501:ffff:ff05:200:ff:fe00:c1c1
| | | DestinationAddress               = 3ffe:501:ffff:ff03:200:ff:fe00:b0b0
| | Hdr_ESP                         (length:32)
| | | SPI                              = 8192
| | | SequenceNumber                   = 1
| | | algorithm                        = ealgo_descbc_foo
| | | IVEC                             = 80000000 00000000
| | | Decrypted                       (length:16)
| | | | ESPPayload                      (length:14)
| | | | | ICMPv6_EchoRequest              (length:14)
| | | | | | Type                             = 128
| | | | | | Code                             = 0
| | | | | | Checksum                         = 43591 calc(43591)
| | | | | | Identifier                       = 0
| | | | | | SequenceNumber                   = 0
| | | | | | Payload                         (length:6)
| | | | | | | data                             = 44617461 2032
| | | | Padding                          = 
| | | | PadLength                        = 0
| | | | NextHeader                       = 58
| | | ICV                              =  calc()

Recv at 18:48:57

Frame_Ether                     (length:68)
| Hdr_Ether                       (length:14)
| | DestinationAddress               = 0:0:0:0:a0:a0
| | SourceAddress                    = 0:a0:24:95:a4:91
| | Type                             = 34525
| Packet_IPv6                     (length:54)
| | Hdr_IPv6                        (length:40)
| | | Version                          = 6
| | | TrafficClass                     = 0
| | | FlowLabel                        = 0
| | | PayloadLength                    = 14
| | | NextHeader                       = 58
| | | HopLimit                         = 64
| | | SourceAddress                    = 3ffe:501:ffff:ff03:200:ff:fe00:b0b0
| | | DestinationAddress               = 3ffe:501:ffff:ff05:200:ff:fe00:c1c1
| | ICMPv6_EchoReply                (length:14)
| | | Type                             = 129
| | | Code                             = 0
| | | Checksum                         = 43335 calc(43335)
| | | Identifier                       = 0
| | | SequenceNumber                   = 0
| | | Payload                         (length:6)
| | | | data                             = 44617461 2032
===ns_to_router=================================
ng compare _HDR_IPV6_ns_to_router.HopLimit received:64 = 255
ng compare _HDR_IPV6_ns_to_router.DestinationAddress received:3ffe:501:ffff:ff05:200:ff:fe00:c1c1 = oneof(v6("3ffe:501:ffff:ff03:200:ff:fe00:a0a0"),v6merge("FF02:0:0:0:0:1:FF00:0000",104,v6("3ffe:501:ffff:ff03:200:ff:fe00:a0a0")))
ng meta Packet_IPv6.ICMPv6_NS != Packet_IPv6.ICMPv6_EchoReply
===echo_reply_to_host1_2=================================