2025-04-30 09:48:19,873 Generated random file: vgeojqnrnn of size: 10485760 2025-04-30 09:48:19,874 Requests: https://server4:443/vgeojqnrnn 2025-04-30 09:48:19,944 2025-04-30 09:48:19,944 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_phr7o2kd/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_gr256_ey/ DOWNLOADS=/tmp/download_d3yg325h/ SERVER_LOGS=/tmp/logs_server_14g87_pc CLIENT_LOGS=/tmp/logs_client_1vax65gf SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr" CLIENT=us-central1-docker.pkg.dev/golang-interop-testing/quic/go-x-net:latest SERVER=ghcr.io/microsoft/msquic/qns:main REQUESTS="https://server4:443/vgeojqnrnn" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 09:48:43,235 Container sim Recreate Container sim Recreated Container client Recreate Container server Recreate Container server Recreated Container client Recreated Attaching to client, server, sim sim | waiting 10s for server:443 client | Setting up routes... client | Actual changes: client | tx-checksum-ip-generic: off client | tx-tcp-segmentation: off [not requested] client | tx-tcp-ecn-segmentation: off [not requested] client | tx-tcp-mangleid-segmentation: off [not requested] client | tx-tcp6-segmentation: off [not requested] client | tx-udp-segmentation: off [not requested] client | tx-checksum-sctp: off client | Endpoint's IPv4 address is 193.167.0.100 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 client | wait-for-it.sh: waiting 30 seconds for sim:57832 server | Setting up routes... server | Actual changes: server | tx-checksumming: off server | tx-checksum-ip-generic: off server | tx-checksum-sctp: off server | tcp-segmentation-offload: off server | tx-tcp-segmentation: off [requested on] server | tx-tcp-ecn-segmentation: off [requested on] server | tx-tcp-mangleid-segmentation: off [requested on] server | tx-tcp6-segmentation: off [requested on] server | tx-udp-segmentation: off [requested on] server | Endpoint's IPv4 address is 193.167.100.100 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 server | Waiting forever. server | sim | server:443 is available after 1.019570957s sim | Using scenario: rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr sim | tcpdump: listening on eth0, link-type EN10MB (Ethernet), snapshot length 262144 bytes sim | tcpdump: listening on eth1, link-type EN10MB (Ethernet), snapshot length 262144 bytes sim | 0s: first rebind in 1s, frequency 5s client | wait-for-it.sh: sim:57832 is available after 1 seconds client | 2025/04/30 09:48:21 listening on [::]:53774 client | 2025/04/30 09:48:21 connected to server4:443 server | [193.167.0.100:53774] GET '/vgeojqnrnn' sim | 1s: rebinding: 193.167.0.100:53774 -> 193.167.0.224:59022 sim | 1.0004s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.0016s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00281s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00401s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00521s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00633s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00753s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00873s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.00993s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01113s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01234s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01346s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01466s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01586s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01706s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01827s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.01947s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.02059s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.02179s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.02299s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.02419s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.0254s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.0266s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.0278s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.02792s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.02912s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.03032s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.03152s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.03273s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.03393s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.03513s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.0353s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.03545s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.0967s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.14215s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.19898s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.24388s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 1.30048s: unknown binding for destination 193.167.0.100:53774, dropping packet sim | 6s: rebinding: 193.167.0.224:59022 -> 193.167.0.71:39968 sim | 6.0002s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0012s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0022s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0032s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0042s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0052s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0062s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00626s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00726s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00826s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00926s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01026s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01126s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01226s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01326s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01333s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01433s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01533s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01633s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01733s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01833s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01933s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02033s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02038s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02155s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 11s: rebinding: 193.167.0.71:39968 -> 193.167.0.3:38910 sim | 11.0009s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0019s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0029s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0039s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0049s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0059s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0069s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0079s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0089s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.009s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.01s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.011s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.012s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.013s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.014s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.015s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.016s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0161s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0171s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0181s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0191s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0201s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0211s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0221s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0231s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0241s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0251s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0261s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0271s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0281s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0291s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0301s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0311s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0321s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0331s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0341s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0351s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0361s: unknown binding for destination 193.167.0.71:39968, dropping packet sim | 11.0372s: unknown binding for destination 193.167.0.71:39968, dropping packet client | 2025/04/30 09:48:32 fetched https://server4:443/vgeojqnrnn client exited with code 0 Aborting on container exit... Container client Stopping Container server Stopping Container client Stopped Container server Stopped Container sim Stopping Container sim Stopped 2025-04-30 09:48:43,408 Using the client's key log file. 2025-04-30 09:48:43,451 2025-04-30 09:48:43,466 Using the client's key log file. 2025-04-30 09:48:43,466 Using the client's key log file. 2025-04-30 09:48:43,508 2025-04-30 09:48:43,523 Using the client's key log file. 2025-04-30 09:48:44,860 Check of downloaded files succeeded. 2025-04-30 09:48:44,860 Using the client's key log file. 2025-04-30 09:48:46,138 Check of downloaded files succeeded. 2025-04-30 09:49:21,810 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.3', 38910)), (('193.167.100.100', 443), ('193.167.0.71', 39968)), (('193.167.100.100', 443), ('193.167.0.224', 59022)), (('193.167.100.100', 443), ('193.167.0.100', 53774))} 2025-04-30 09:49:27,293 Using the client's key log file. 2025-04-30 09:50:00,840 Server saw these client addresses: {'193.167.0.71', '193.167.0.3', '193.167.0.100', '193.167.0.224'} 2025-04-30 09:50:02,224 Check of downloaded files succeeded. 2025-04-30 09:50:02,224 Using the client's key log file. 2025-04-30 09:50:03,589 Check of downloaded files succeeded. 2025-04-30 09:50:39,371 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.3', 38910)), (('193.167.100.100', 443), ('193.167.0.71', 39968)), (('193.167.100.100', 443), ('193.167.0.224', 59022)), (('193.167.100.100', 443), ('193.167.0.100', 53774))}