TcpSocketBase:TcpSocketBase(0x901a428) 0 [node 0] TcpSocketBase:Bind(0x901a428) 0 [node 0] TcpSocketBase:SetupCallback(0x901a428) 0 [node 0] TcpSocketBase:Connect(0x901a428, 03-06-0a:01:01:02:09:00) 0 [node 0] TcpSocketBase:SetupEndpoint(0x901a428) 0 [node 0] Route exists 0 [node 0] TcpSocketBase:DoConnect(0x901a428) 0 [node 0] TcpSocketBase:SendEmptyPacket(0x901a428, 2) 0 [node 0] Schedule retransmission timeout at time 0 to expire at time 3 0 [node 0] CLOSED -> SYN_SENT 0 [node 0] TcpSocketBase:ShutdownRecv(0x901a428) TcpSocketBase:TcpSocketBase(0x90017a0) 0 [node 1] TcpSocketBase:Bind(0x90017a0, 03-06-00:00:00:00:09:00) 0 [node 1] TcpSocketBase 0x90017a0 got an endpoint: 0x9031588 0 [node 1] TcpSocketBase:SetupCallback(0x90017a0) 0 [node 1] TcpSocketBase:Listen(0x90017a0) 0 [node 1] CLOSED -> LISTEN 0 [node 1] TcpSocketBase:ShutdownSend(0x90017a0) 0.005672 [node 1] Socket 0x90017a0 forward up 0.0.0.0:0 to 0.0.0.0:9 0.005672 [node 1] 0x90017a0 Leaving zerowindow persist state 0.005672 [node 1] TcpSocketBase:ProcessListen(0x90017a0, 49153 > 9 [ SYN ] Seq=0 Ack=0 Win=65535) 0.005672 [node 1] TcpSocketBase:TcpSocketBase(0x90019a8) 0.005672 [node 1] Invoked the copy constructor 0.005672 [node 1] Cloned a TcpSocketBase 0x90019a8 0.005672 [node 1] LISTEN -> SYN_RCVD 0.005672 [node 1] TcpSocketBase:SetupCallback(0x90019a8) 0.005672 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 18) 0.005672 [node 1] Schedule retransmission timeout at time 0.005672 to expire at time 3.00567 0.011344 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.011344 [node 0] 0x901a428 Leaving zerowindow persist state 0.011344 [node 0] TcpSocketBase:ProcessSynSent(0x901a428, 9 > 49153 [ SYN ACK ] Seq=0 Ack=1 Win=65535) 0.011344 [node 0] SYN_SENT -> ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendEmptyPacket(0x901a428, 16) 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x901a670) 0.011344 [node 0] txBufSize=512 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=0, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 536 rxwin 65535 segsize 536 nextTxSeq 1 highestRxAck 1 pd->Size 512 pd->SFS 512 0.011344 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 1, 536, 1) 0.011344 [node 0] 0x901a428 SendDataPacket Schedule ReTxTimeout at time 0.011344 to expire at time 1.01134 0.011344 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.011344 [node 0] SendPendingData sent 1 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x9025908) 0.011344 [node 0] txBufSize=1024 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 1024 pd->SFS 512 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x902a840) 0.011344 [node 0] txBufSize=1536 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 1536 pd->SFS 1024 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x902e8c8) 0.011344 [node 0] txBufSize=2048 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 2048 pd->SFS 1536 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x902e920) 0.011344 [node 0] txBufSize=2560 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 2560 pd->SFS 2048 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x902e978) 0.011344 [node 0] txBufSize=3072 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 3072 pd->SFS 2560 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x902e9d0) 0.011344 [node 0] txBufSize=3584 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 3584 pd->SFS 3072 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x902ea28) 0.011344 [node 0] txBufSize=4096 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 4096 pd->SFS 3584 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x9001da8) 0.011344 [node 0] txBufSize=4608 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 4608 pd->SFS 4096 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Send(0x901a428, 0x9001e00) 0.011344 [node 0] txBufSize=5000 state ESTABLISHED 0.011344 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.011344 [node 0] TcpSocketBase:AvailableWindow() 0.011344 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.011344 [node 0] UnAckCount=512, Win=536 0.011344 [node 0] TcpSocketBase 0x901a428 SendPendingData w 24 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 1 pd->Size 5000 pd->SFS 4488 0.011344 [node 0] SendPendingData sent 0 packets 0.011344 [node 0] TcpSocketBase:Close(0x901a428) 0.011344 [node 0] Socket 0x901a428 deferring close, state ESTABLISHED 0.011344 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.011344 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.017016 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.017016 [node 1] TcpSocketBase:ProcessSynRcvd(0x90019a8, 49153 > 9 [ ACK ] Seq=1 Ack=1 Win=65535) 0.017016 [node 1] SYN_RCVD -> ESTABLISHED 0.017016 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=1 Ack=1 Win=65535) 0.017016 [node 1] TcpSocketBase:GetTxAvailable(0x90019a8) 0.017016 [node 1] TcpSocketBase:GetTxAvailable(0x90019a8) 0.02588 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.02588 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=1 Ack=1 Win=65535) 0.02588 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=1 Ack=1 Win=65535) 0.02588 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=1 Ack=1 Win=65535) 0.02588 [node 1] seq 1 ack 1 pkt size 512 0.02588 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 16) 0.02588 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.02588 [node 1] TcpSocketBase:Recv(0x90019a8) 0.02588 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.02588 [node 1] TcpSocketBase:Recv(0x90019a8) 0.031552 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.031552 [node 0] TcpSocketBase:EstimateRtt(0x901a428, +20207998.0ns) 0.031552 [node 0] TcpSocketBase:ProcessEstablished(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=513 Win=65535) 0.031552 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=513 Win=65535) 0.031552 [node 0] New ack of 513 0.031552 [node 0] TcpSocketBase:NewAck(0x901a428, 513) 0.031552 [node 0] 0x901a428 Cancelled ReTxTimeout event which was set to expire at 1.01134 0.031552 [node 0] 0x901a428 Schedule ReTxTimeout at time 0.031552 to expire at time 0.231552 0.031552 [node 0] TCP 0x901a428 NewAck 513 numberAck 512 0.031552 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.031552 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.031552 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.031552 [node 0] TcpSocketBase:AvailableWindow() 0.031552 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.031552 [node 0] UnAckCount=0, Win=1072 0.031552 [node 0] TcpSocketBase 0x901a428 SendPendingData w 1072 rxwin 65535 segsize 536 nextTxSeq 513 highestRxAck 513 pd->Size 4488 pd->SFS 4488 0.031552 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 513, 536, 1) 0.031552 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.031552 [node 0] TcpSocketBase:AvailableWindow() 0.031552 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.031552 [node 0] UnAckCount=536, Win=1072 0.031552 [node 0] TcpSocketBase 0x901a428 SendPendingData w 536 rxwin 65535 segsize 536 nextTxSeq 1049 highestRxAck 513 pd->Size 4488 pd->SFS 3952 0.031552 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 1049, 536, 1) 0.031552 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.031552 [node 0] TcpSocketBase:AvailableWindow() 0.031552 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.031552 [node 0] UnAckCount=1072, Win=1072 0.031552 [node 0] TcpSocketBase 0x901a428 SendPendingData w 0 rxwin 65535 segsize 536 nextTxSeq 1585 highestRxAck 513 pd->Size 4488 pd->SFS 3416 0.031552 [node 0] SendPendingData sent 2 packets 0.0458 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.0458 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=513 Ack=1 Win=65535) 0.0458 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=513 Ack=1 Win=65535) 0.0458 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=513 Ack=1 Win=65535) 0.0458 [node 1] seq 513 ack 1 pkt size 536 0.0458 [node 1] 0x90019a8 scheduled delayed ACK at 0.2458 0.0458 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.0458 [node 1] TcpSocketBase:Recv(0x90019a8) 0.0458 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.0458 [node 1] TcpSocketBase:Recv(0x90019a8) 0.055048 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.055048 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=1049 Ack=1 Win=65535) 0.055048 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=1049 Ack=1 Win=65535) 0.055048 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=1049 Ack=1 Win=65535) 0.055048 [node 1] seq 1049 ack 1 pkt size 536 0.055048 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 16) 0.055048 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.055048 [node 1] TcpSocketBase:Recv(0x90019a8) 0.055048 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.055048 [node 1] TcpSocketBase:Recv(0x90019a8) 0.06072 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.06072 [node 0] TcpSocketBase:EstimateRtt(0x901a428, +29167997.0ns) 0.06072 [node 0] TcpSocketBase:ProcessEstablished(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=1585 Win=65535) 0.06072 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=1585 Win=65535) 0.06072 [node 0] New ack of 1585 0.06072 [node 0] TcpSocketBase:NewAck(0x901a428, 1585) 0.06072 [node 0] 0x901a428 Cancelled ReTxTimeout event which was set to expire at 0.231552 0.06072 [node 0] 0x901a428 Schedule ReTxTimeout at time 0.06072 to expire at time 0.26072 0.06072 [node 0] TCP 0x901a428 NewAck 1585 numberAck 1072 0.06072 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.06072 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.06072 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.06072 [node 0] TcpSocketBase:AvailableWindow() 0.06072 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.06072 [node 0] UnAckCount=0, Win=1608 0.06072 [node 0] TcpSocketBase 0x901a428 SendPendingData w 1608 rxwin 65535 segsize 536 nextTxSeq 1585 highestRxAck 1585 pd->Size 3416 pd->SFS 3416 0.06072 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 1585, 536, 1) 0.06072 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.06072 [node 0] TcpSocketBase:AvailableWindow() 0.06072 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.06072 [node 0] UnAckCount=536, Win=1608 0.06072 [node 0] TcpSocketBase 0x901a428 SendPendingData w 1072 rxwin 65535 segsize 536 nextTxSeq 2121 highestRxAck 1585 pd->Size 3416 pd->SFS 2880 0.06072 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 2121, 536, 1) 0.06072 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.06072 [node 0] TcpSocketBase:AvailableWindow() 0.06072 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.06072 [node 0] UnAckCount=1072, Win=1608 0.06072 [node 0] TcpSocketBase 0x901a428 SendPendingData w 536 rxwin 65535 segsize 536 nextTxSeq 2657 highestRxAck 1585 pd->Size 3416 pd->SFS 2344 0.06072 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 2657, 536, 1) 0.06072 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.06072 [node 0] TcpSocketBase:AvailableWindow() 0.06072 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.06072 [node 0] UnAckCount=1608, Win=1608 0.06072 [node 0] TcpSocketBase 0x901a428 SendPendingData w 0 rxwin 65535 segsize 536 nextTxSeq 3193 highestRxAck 1585 pd->Size 3416 pd->SFS 1808 0.06072 [node 0] SendPendingData sent 3 packets 0.074968 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.074968 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=1585 Ack=1 Win=65535) 0.074968 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=1585 Ack=1 Win=65535) 0.074968 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=1585 Ack=1 Win=65535) 0.074968 [node 1] seq 1585 ack 1 pkt size 536 0.074968 [node 1] 0x90019a8 scheduled delayed ACK at 0.274968 0.074968 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.074968 [node 1] TcpSocketBase:Recv(0x90019a8) 0.074968 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.074968 [node 1] TcpSocketBase:Recv(0x90019a8) 0.084216 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.084216 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=2121 Ack=1 Win=65535) 0.084216 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=2121 Ack=1 Win=65535) 0.084216 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=2121 Ack=1 Win=65535) 0.084216 [node 1] seq 2121 ack 1 pkt size 536 0.084216 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 16) 0.084216 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.084216 [node 1] TcpSocketBase:Recv(0x90019a8) 0.084216 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.084216 [node 1] TcpSocketBase:Recv(0x90019a8) 0.089888 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.089888 [node 0] TcpSocketBase:EstimateRtt(0x901a428, +29167997.0ns) 0.089888 [node 0] TcpSocketBase:ProcessEstablished(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=2657 Win=65535) 0.089888 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=2657 Win=65535) 0.089888 [node 0] New ack of 2657 0.089888 [node 0] TcpSocketBase:NewAck(0x901a428, 2657) 0.089888 [node 0] 0x901a428 Cancelled ReTxTimeout event which was set to expire at 0.26072 0.089888 [node 0] 0x901a428 Schedule ReTxTimeout at time 0.089888 to expire at time 0.289888 0.089888 [node 0] TCP 0x901a428 NewAck 2657 numberAck 1072 0.089888 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.089888 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.089888 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.089888 [node 0] TcpSocketBase:AvailableWindow() 0.089888 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.089888 [node 0] UnAckCount=536, Win=2144 0.089888 [node 0] TcpSocketBase 0x901a428 SendPendingData w 1608 rxwin 65535 segsize 536 nextTxSeq 3193 highestRxAck 2657 pd->Size 2344 pd->SFS 1808 0.089888 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 3193, 536, 1) 0.089888 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.089888 [node 0] TcpSocketBase:AvailableWindow() 0.089888 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.089888 [node 0] UnAckCount=1072, Win=2144 0.089888 [node 0] TcpSocketBase 0x901a428 SendPendingData w 1072 rxwin 65535 segsize 536 nextTxSeq 3729 highestRxAck 2657 pd->Size 2344 pd->SFS 1272 0.089888 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 3729, 536, 1) 0.089888 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.089888 [node 0] TcpSocketBase:AvailableWindow() 0.089888 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.089888 [node 0] UnAckCount=1608, Win=2144 0.089888 [node 0] TcpSocketBase 0x901a428 SendPendingData w 536 rxwin 65535 segsize 536 nextTxSeq 4265 highestRxAck 2657 pd->Size 2344 pd->SFS 736 0.089888 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 4265, 536, 1) 0.089888 [node 0] Send packet via TcpL4Protocol with flags 0x10 0.089888 [node 0] TcpSocketBase:AvailableWindow() 0.089888 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.089888 [node 0] UnAckCount=2144, Win=2144 0.089888 [node 0] TcpSocketBase 0x901a428 SendPendingData w 0 rxwin 65535 segsize 536 nextTxSeq 4801 highestRxAck 2657 pd->Size 2344 pd->SFS 200 0.089888 [node 0] SendPendingData sent 3 packets 0.093464 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.093464 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=2657 Ack=1 Win=65535) 0.093464 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=2657 Ack=1 Win=65535) 0.093464 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=2657 Ack=1 Win=65535) 0.093464 [node 1] seq 2657 ack 1 pkt size 536 0.093464 [node 1] 0x90019a8 scheduled delayed ACK at 0.293464 0.093464 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.093464 [node 1] TcpSocketBase:Recv(0x90019a8) 0.093464 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.093464 [node 1] TcpSocketBase:Recv(0x90019a8) 0.104136 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.104136 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=3193 Ack=1 Win=65535) 0.104136 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=3193 Ack=1 Win=65535) 0.104136 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=3193 Ack=1 Win=65535) 0.104136 [node 1] seq 3193 ack 1 pkt size 536 0.104136 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 16) 0.104136 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.104136 [node 1] TcpSocketBase:Recv(0x90019a8) 0.104136 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.104136 [node 1] TcpSocketBase:Recv(0x90019a8) 0.109808 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.109808 [node 0] TcpSocketBase:EstimateRtt(0x901a428, +49087995.0ns) 0.109808 [node 0] TcpSocketBase:ProcessEstablished(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=3729 Win=65535) 0.109808 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=3729 Win=65535) 0.109808 [node 0] New ack of 3729 0.109808 [node 0] TcpSocketBase:NewAck(0x901a428, 3729) 0.109808 [node 0] 0x901a428 Cancelled ReTxTimeout event which was set to expire at 0.289888 0.109808 [node 0] 0x901a428 Schedule ReTxTimeout at time 0.109808 to expire at time 0.309808 0.109808 [node 0] TCP 0x901a428 NewAck 3729 numberAck 1072 0.109808 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.109808 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.109808 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.109808 [node 0] TcpSocketBase:AvailableWindow() 0.109808 [node 0] TcpSocketBase:UnAckDataCount(0x901a428) 0.109808 [node 0] UnAckCount=1072, Win=2680 0.109808 [node 0] TcpSocketBase 0x901a428 SendPendingData w 1608 rxwin 65535 segsize 536 nextTxSeq 4801 highestRxAck 3729 pd->Size 1272 pd->SFS 200 0.109808 [node 0] TcpSocketBase:SendDataPacket(0x901a428, 4801, 536, 1) 0.109808 [node 0] ESTABLISHED -> FIN_WAIT_1 0.109808 [node 0] Send packet via TcpL4Protocol with flags 0x11 0.109808 [node 0] SendPendingData sent 1 packets 0.113384 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.113384 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=3729 Ack=1 Win=65535) 0.113384 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=3729 Ack=1 Win=65535) 0.113384 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=3729 Ack=1 Win=65535) 0.113384 [node 1] seq 3729 ack 1 pkt size 536 0.113384 [node 1] 0x90019a8 scheduled delayed ACK at 0.313384 0.113384 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.113384 [node 1] TcpSocketBase:Recv(0x90019a8) 0.113384 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.113384 [node 1] TcpSocketBase:Recv(0x90019a8) 0.122632 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.122632 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ ACK ] Seq=4265 Ack=1 Win=65535) 0.122632 [node 1] TcpSocketBase:ReceivedAck(0x90019a8, 49153 > 9 [ ACK ] Seq=4265 Ack=1 Win=65535) 0.122632 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ ACK ] Seq=4265 Ack=1 Win=65535) 0.122632 [node 1] seq 4265 ack 1 pkt size 536 0.122632 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 16) 0.122632 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.122632 [node 1] TcpSocketBase:Recv(0x90019a8) 0.122632 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.122632 [node 1] TcpSocketBase:Recv(0x90019a8) 0.126504 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.126504 [node 1] TcpSocketBase:ProcessEstablished(0x90019a8, 49153 > 9 [ FIN ACK ] Seq=4801 Ack=1 Win=65535) 0.126504 [node 1] TcpSocketBase:PeerClose(0x90019a8, 49153 > 9 [ FIN ACK ] Seq=4801 Ack=1 Win=65535) 0.126504 [node 1] Accepted FIN at seq 5001 0.126504 [node 1] TcpSocketBase:ReceivedData(0x90019a8, 49153 > 9 [ FIN ACK ] Seq=4801 Ack=1 Win=65535) 0.126504 [node 1] seq 4801 ack 1 pkt size 200 0.126504 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 16) 0.126504 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.126504 [node 1] TcpSocketBase:Recv(0x90019a8) 0.126504 [node 1] TcpSocketBase:RecvFrom(0x90019a8, 4294967295, 0) 0.126504 [node 1] TcpSocketBase:Recv(0x90019a8) 0.126504 [node 1] ESTABLISHED -> CLOSE_WAIT 0.126504 [node 1] TCP 0x90019a8 calling NotifyNormalClose 0.126504 [node 1] TcpSocketBase:Close(0x90019a8) 0.126504 [node 1] TcpSocketBase:DoClose(0x90019a8) 0.126504 [node 1] TcpSocketBase:SendEmptyPacket(0x90019a8, 17) 0.126504 [node 1] Schedule retransmission timeout at time 0.126504 to expire at time 1.1265 0.126504 [node 1] CLOSE_WAIT -> LAST_ACK 0.126504 [node 1] TcpSocketBase 0x90019a8 scheduling LATO1 0.128304 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.128304 [node 0] TcpSocketBase:EstimateRtt(0x901a428, +38415996.0ns) 0.128304 [node 0] TcpSocketBase:ProcessWait(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=4801 Win=65535) 0.128304 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=4801 Win=65535) 0.128304 [node 0] New ack of 4801 0.128304 [node 0] TcpSocketBase:NewAck(0x901a428, 4801) 0.128304 [node 0] 0x901a428 Cancelled ReTxTimeout event which was set to expire at 0.309808 0.128304 [node 0] 0x901a428 Schedule ReTxTimeout at time 0.128304 to expire at time 0.328304 0.128304 [node 0] TCP 0x901a428 NewAck 4801 numberAck 1072 0.128304 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.128304 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.128304 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.128304 [node 0] SendPendingData sent 0 packets 0.132176 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.132176 [node 0] TcpSocketBase:EstimateRtt(0x901a428, +22367998.0ns) 0.132176 [node 0] TcpSocketBase:ProcessWait(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=5002 Win=65535) 0.132176 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ ACK ] Seq=1 Ack=5002 Win=65535) 0.132176 [node 0] New ack of 5002 0.132176 [node 0] TcpSocketBase:NewAck(0x901a428, 5002) 0.132176 [node 0] 0x901a428 Cancelled ReTxTimeout event which was set to expire at 0.328304 0.132176 [node 0] 0x901a428 Schedule ReTxTimeout at time 0.132176 to expire at time 0.332176 0.132176 [node 0] TCP 0x901a428 NewAck 5002 numberAck 201 0.132176 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.132176 [node 0] TcpSocketBase:GetTxAvailable(0x901a428) 0.132176 [node 0] TcpSocketBase:SendPendingData(0x901a428, 1) 0.132176 [node 0] FIN_WAIT_1 -> FIN_WAIT_2 0.132848 [node 0] Socket 0x901a428 forward up 10.1.1.2:9 to 10.1.1.1:49153 0.132848 [node 0] TcpSocketBase:ProcessWait(0x901a428, 9 > 49153 [ FIN ACK ] Seq=1 Ack=5002 Win=65535) 0.132848 [node 0] TcpSocketBase:ReceivedAck(0x901a428, 9 > 49153 [ FIN ACK ] Seq=1 Ack=5002 Win=65535) 0.132848 [node 0] FIN_WAIT_2 -> TIME_WAIT 0.132848 [node 0] TcpSocketBase:SendEmptyPacket(0x901a428, 16) 0.13852 [node 1] Socket 0x90019a8 forward up 10.1.1.1:49153 to 10.1.1.2:9 0.13852 [node 1] TcpSocketBase:ProcessLastAck(0x90019a8, 49153 > 9 [ ACK ] Seq=5002 Ack=2 Win=65535) 0.13852 [node 1] TcpSocketBase:CloseAndNotify(0x90019a8) 0.13852 [node 1] LAST_ACK -> CLOSED 10 [node 0] TcpSocketBase:Close(0x901a428) 10 [node 0] TcpSocketBase:DoClose(0x901a428) 10 [node 1] TcpSocketBase:Close(0x90019a8) 10 [node 1] TcpSocketBase:DoClose(0x90019a8) 10 [node 1] TcpSocketBase:~TcpSocketBase(0x90019a8) 10 [node 1] TcpSocketBase:Close(0x90017a0) 10 [node 1] TcpSocketBase:DoClose(0x90017a0) 10 [node 1] TcpSocketBase:CloseAndNotify(0x90017a0) 10 [node 1] LISTEN -> CLOSED 240.133 [node 0] TcpSocketBase:CloseAndNotify(0x901a428) 240.133 [node 0] TIME_WAIT -> CLOSED 360 [node 0] TcpSocketBase:~TcpSocketBase(0x901a428) 360 [node 1] TcpSocketBase:~TcpSocketBase(0x90017a0) Total Bytes Received: 5000