2025-04-30 10:31:48,071 Generated random file: owzolnabjp of size: 10485760 2025-04-30 10:31:48,071 Requests: https://server4:443/owzolnabjp 2025-04-30 10:31:48,139 2025-04-30 10:31:48,139 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_td3qmmw8/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_90jje250/ DOWNLOADS=/tmp/download__rjv88rc/ SERVER_LOGS=/tmp/logs_server_vqc8wdb5 CLIENT_LOGS=/tmp/logs_client_kb76exs5 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=privateoctopus/picoquic:latest REQUESTS="https://server4:443/owzolnabjp" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 10:32:09,396 Container sim Recreate Container sim Recreated Container server Recreate Container client Recreate Container client Recreated Container server Recreated Attaching to client, server, sim sim | waiting 10s for server:443 server | Setting up the simulation with setup.sh client | Setting up routes... server | 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 server | Actual changes: server | tx-checksum-ip-generic: off server | tx-tcp-segmentation: off [not requested] server | tx-tcp-ecn-segmentation: off [not requested] server | tx-tcp-mangleid-segmentation: off [not requested] server | tx-tcp6-segmentation: off [not requested] server | tx-udp-segmentation: off [not requested] server | tx-checksum-sctp: off client | Endpoint's IPv4 address is 193.167.0.100 server | Endpoint's IPv4 address is 193.167.100.100 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 server | Setup.sh completed server | Starting picoquic server for test: transfer server | owzolnabjp server | Starting picoquic server ... server | TEST_PARAMS: -8 -w ./www -L -l /logs/server_log.txt -q /logs/qlog -k /certs/priv.key -c /certs/cert.pem -p 443 -V -0 -d 180000 server | Starting Picoquic server (v1.1.26.1) on port 443, server name = ::, just_once = 0, do_retry = 0 server | No token file present. Will create one as . server | Accept enable multipath: 0. server | Waiting for packets. client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 1.035548741s 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)tcpdump: , snapshot length 262144 bytes sim | 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 10:31:49 listening on [::]:34222 client | 2025/04/30 10:31:49 connected to server4:443 sim | 1s: rebinding: 193.167.0.100:34222 -> 193.167.0.224:59022 sim | 1.00071s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00191s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00311s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00431s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00551s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00671s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00792s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.00912s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01032s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01152s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01272s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01392s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01513s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01633s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01753s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01873s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.01993s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02113s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02233s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02354s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02474s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02594s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02714s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02834s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 1.02848s: unknown binding for destination 193.167.0.100:34222, dropping packet sim | 6s: rebinding: 193.167.0.224:59022 -> 193.167.0.71:39968 sim | 6.00056s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00181s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00301s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00424s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00547s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00668s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00791s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00914s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01036s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01159s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01282s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01403s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01525s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01653s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01773s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01895s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02018s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02032s: unknown binding for destination 193.167.0.224:59022, dropping packet client | 2025/04/30 10:31:59 fetched https://server4:443/owzolnabjp client exited with code 0 Aborting on container exit... Container server Stopping Container client Stopping Container client Stopped Container server Stopped Container sim Stopping Container sim Stopped 2025-04-30 10:32:09,576 Using the client's key log file. 2025-04-30 10:32:09,623 2025-04-30 10:32:09,637 Using the client's key log file. 2025-04-30 10:32:09,637 Using the client's key log file. 2025-04-30 10:32:09,676 2025-04-30 10:32:09,690 Using the client's key log file. 2025-04-30 10:32:10,837 Check of downloaded files succeeded. 2025-04-30 10:32:10,838 Using the client's key log file. 2025-04-30 10:32:11,974 Check of downloaded files succeeded. 2025-04-30 10:32:40,557 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.71', 39968)), (('193.167.100.100', 443), ('193.167.0.100', 34222)), (('193.167.100.100', 443), ('193.167.0.224', 59022))} 2025-04-30 10:32:46,327 Using the client's key log file. 2025-04-30 10:33:14,259 Server saw these client addresses: {'193.167.0.224', '193.167.0.71', '193.167.0.100'} 2025-04-30 10:33:15,457 Check of downloaded files succeeded. 2025-04-30 10:33:15,457 Using the client's key log file. 2025-04-30 10:33:16,645 Check of downloaded files succeeded. 2025-04-30 10:33:46,264 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.71', 39968)), (('193.167.100.100', 443), ('193.167.0.100', 34222)), (('193.167.100.100', 443), ('193.167.0.224', 59022))}