2025-04-30 11:56:09,161 Generated random file: vnxkhdfuco of size: 10485760 2025-04-30 11:56:09,162 Requests: https://server4:443/vnxkhdfuco 2025-04-30 11:56:09,222 2025-04-30 11:56:09,222 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_lntkbwn8/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_woi58gz0/ DOWNLOADS=/tmp/download_b48k7cyf/ SERVER_LOGS=/tmp/logs_server_yr3pws07 CLIENT_LOGS=/tmp/logs_client_ahb61_7k SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr" CLIENT=privateoctopus/picoquic:latest SERVER=haproxytech/haproxy-qns:latest REQUESTS="https://server4:443/vnxkhdfuco" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 11:56:52,059 Container sim Recreate Container sim Recreated Container client Recreate Container server Recreate Container client Recreated Container server Recreated Attaching to client, server, sim sim | waiting 10s for server:443 client | Setting up the simulation with setup.sh server | Setting up routes... client | Setting up routes... 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 | 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 | Endpoint's IPv4 address is 193.167.100.100 client | Endpoint's IPv4 address is 193.167.0.100 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 server | starting lighttpd server client | Setup.sh completed client | Waiting for the simulator to start client | wait-for-it.sh: waiting 30 seconds for sim:57832 server | haproxy version HAProxy version 0f9b3daf98a80004f90e9540b0385d419f0e4e16 2025/04/25 - https://haproxy.org/ server | Status: development branch - not safe for use in production. server | Known bugs: https://github.com/haproxy/haproxy/issues?q=is:issue+is:open server | Running on: Linux 6.11.0-1012-azure #12~24.04.1-Ubuntu SMP Mon Mar 10 19:00:39 UTC 2025 x86_64 server | starting haproxy... sim | server:443 is available after 1.052149446s sim | Using scenario: rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr sim | tcpdump: listening on eth1, link-type EN10MB (Ethernet), snapshot length 262144 bytes sim | tcpdump: listening on eth0, 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 | Starting picoquic client for test: transfer client | Starting picoquic client ... client | Parsing server name from first request: https://server4:443/vnxkhdfuco client | Server set to: server4 client | Requests: https://server4:443/vnxkhdfuco client | parsing as client | Starting Picoquic (v1.1.26.1) connection to server = server4, port = 443 client | No token file present. Will create one as . client | Testing scenario: <-:/vnxkhdfuco;> client | Max stream id bidir remote before start = 0 (0) client | Starting client connection. Version = 1, I-CID: bfa834283c90bcb client | Max stream id bidir remote after start = -4 (0) client | Waiting for packets. client | Client port (AF=2): 55229. client | Negotiated ALPN: hq-interop client | Almost ready! client | client | Connection established. Version = 1, I-CID: bfa834283c90bcb, verified: 1 client | Opening stream 0 to GET /vnxkhdfuco sim | 1s: rebinding: 193.167.0.100:48599 -> 193.167.0.224:59022 sim | 1.00065s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00167s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00199s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00302s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00404s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00507s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.0061s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00659s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00761s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00864s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.00953s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01056s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.0112s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01222s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01325s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01427s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.0153s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01632s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01642s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01744s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.01847s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.0195s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02052s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02121s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02224s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02326s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02346s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02449s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02551s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02596s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02699s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02801s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.02904s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03006s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03035s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03138s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.0324s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03343s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03445s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03548s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03555s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03658s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.03739s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.11989s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.12092s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.26815s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.26918s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.52047s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.5215s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.98106s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 1.98209s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 2.8582s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 2.85922s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 4.56808s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 4.56911s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 6s: rebinding: 193.167.0.224:59022 -> 193.167.0.71:39968 sim | 7.94178s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 7.94281s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 11s: rebinding: 193.167.0.71:39968 -> 193.167.0.3:38910 sim | 14.6487s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 14.6497s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 16s: rebinding: 193.167.0.3:38910 -> 193.167.0.250:19495 sim | 21s: rebinding: 193.167.0.250:19495 -> 193.167.0.200:28302 sim | 26s: rebinding: 193.167.0.200:28302 -> 193.167.0.217:46157 sim | 28.018s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 28.019s: unknown binding for destination 193.167.0.100:48599, dropping packet sim | 31s: rebinding: 193.167.0.217:46157 -> 193.167.0.105:33243 client | Received a request to close the connection. client | Connection end with local error 0x433. client | Address Discovery mode: 0 / 0 (0:0) client | Quic Bit was NOT greased by the client. client | Quic Bit was NOT greased by the server. client | ECN was not received. client | ECN was not acknowledged. client | Received 889435 bytes in 30.896377 seconds, 0.230301 Mbps. client | Sent 17 bytes in 30.896377 seconds, 0.000004 Mbps. client | max_data_local: 3145728 client | max_stream_data_local: 2097152 client | max_data_remote: 1638000 client | max_stream_data_remote: 1474200 client | ack_delay_remote: 1000 ... 4118 client | max_ack_gap_remote: 2 client | ack_delay_local: 25000 ... 25000 client | max_ack_gap_local: 2 client | max_mtu_sent: 1252 client | max_mtu_received: 1252 client | System call duration max: 20 client | System call duration smoothed: 1 client | System call duration deviation: 0 client | Received ticket from server4 (hq-interop): client | ticket time = 1746014170905, kx = 17, suite = 1302, 269 ticket, 48 secret. client | lifetime = 7200, age_add = 53693d28, 8 nonce, 240 ticket, 8 extensions. client | ticket extensions: 42(ED: ffffffff), client | Client exit with code = -1 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 11:56:52,191 Using the client's key log file. 2025-04-30 11:56:52,207 2025-04-30 11:56:52,209 Using the client's key log file. 2025-04-30 11:56:52,209 Using the client's key log file. 2025-04-30 11:56:52,221 2025-04-30 11:56:52,223 Using the client's key log file. 2025-04-30 11:56:52,849 File size of /tmp/download_b48k7cyf/vnxkhdfuco doesn't match. Original: 10485760 bytes, downloaded: 889435 bytes. 2025-04-30 11:56:52,849 Using the client's key log file. 2025-04-30 11:56:53,476 File size of /tmp/download_b48k7cyf/vnxkhdfuco doesn't match. Original: 10485760 bytes, downloaded: 889435 bytes. 2025-04-30 11:56:53,476 Using the client's key log file. 2025-04-30 11:56:56,813 Server saw these client addresses: {'193.167.0.100'} 2025-04-30 11:56:56,813 Server saw only a single client IP address in use; test broken?