2025-12-13 12:58:55,789 Generated random file: exhilarated-red-entei of size: 10485760 2025-12-13 12:58:55,789 Requests: https://server4:443/exhilarated-red-entei 2025-12-13 12:58:55,845 2025-12-13 12:58:55,845 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_72hnvo2w/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_69n8ar19/ DOWNLOADS=/tmp/download_rk95qc81/ SERVER_LOGS=/tmp/logs_server_w_t5otwp CLIENT_LOGS=/tmp/logs_client_034v1efy SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s" CLIENT=peterdoornbosch/kwik_n_flupke-interop SERVER=us-central1-docker.pkg.dev/golang-interop-testing/quic/go-x-net:latest REQUESTS="https://server4:443/exhilarated-red-entei" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-12-13 12:59:55,852 Container sim Recreate Container sim Recreated Container server Recreate Container client Recreate Container server Recreated Container client Recreated Attaching to client, server, sim sim | waiting 10s for server:443 server | 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 server | Endpoint's IPv4 address is 193.167.100.100 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 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 server | 2025/12/13 12:58:56 listening on [::]:443 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 client | Certificate was added to keystore client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 501.497631ms sim | Using scenario: rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s sim | Capturing on 'eth1' sim | Capturing on 'eth0' sim | File: /logs/trace_node_right.pcap sim | File: /logs/trace_node_left.pcap sim | 0s: first rebind in 1s, frequency 5s client | wait-for-it.sh: sim:57832 is available after 1 seconds client | Logging to /logs/kwik_client.log client | Writing keys to /logs/keys.log sim | Packets: 1 Packets: 1 Packets: 2 Packets: 5 Packets: 5 Packets: 12 Packets: 14 Packets: 11 Packets: 31 Packets: 32 Packets: 16 Packets: 37 Packets: 27 Packets: 239 Packets: 192 Packets: 505 Packets: 473 Packets: 800 Packets: 760 Packets: 1083 Packets: 1045 Packets: 1367 Packets: 1329 Packets: 1649 Packets: 1615 Packets: 1934 Packets: 1899 Packets: 2218 Packets: 2184 Packets: 2502 Packets: 2469 Packets: 2793 Packets: 2752 Packets: 3074 Packets: 3033 Packets: 3356 Packets: 3316 Packets: 3637 Packets: 3600 Packets: 3920 Packets: 3885 Packets: 4204 Packets: 4171 Packets: 4489 Packets: 4453 Packets: 4768 Packets: 4737 Packets: 5062 Packets: 5019 Packets: 5346 Packets: 5304 Packets: 5628 Packets: 5587 Packets: 5910 Packets: 5872 Packets: 6194 Packets: 6157 6s: rebinding: 193.167.0.100:50628 -> 193.167.0.100:57607 sim | 6.00033s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00131s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.0023s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00328s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00426s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00524s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00623s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00721s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00819s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.00917s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01015s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01114s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01212s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.0131s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01408s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01507s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01605s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01703s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01801s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.019s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.01998s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02096s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02194s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02293s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02391s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02489s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02587s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02686s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02784s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.02882s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.0298s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03079s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03177s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03275s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03373s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03471s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.0357s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03668s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03766s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.03864s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | 6.10451s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6475 Packets: 6441 6.28063s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6680 Packets: 6575 6.63115s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6683 Packets: 6577 Packets: 6684 Packets: 6579 Packets: 6686 7.33187s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6689 Packets: 6581 8.73298s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6692 Packets: 6583 11s: rebinding: 193.167.0.100:57607 -> 193.167.0.100:59022 sim | 11.5358s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6695 Packets: 6585 Packets: 6586 Packets: 6696 Packets: 6697 Packets: 6587 16s: rebinding: 193.167.0.100:59022 -> 193.167.0.100:18108 sim | 17.1419s: unknown binding for destination 193.167.0.100:50628, dropping packet sim | Packets: 6698 Packets: 6700 Packets: 6589 21s: rebinding: 193.167.0.100:18108 -> 193.167.0.100:39968 sim | 26s: rebinding: 193.167.0.100:39968 -> 193.167.0.100:745 sim | Packets: 6590 28.3548s: unknown binding for destination 193.167.0.100:50628, dropping packet client | [2025-12-13T12:59:26.640656401Z] WatchDog: system running for 29 seconds. sim | Packets: 6701 Packets: 6702 Packets: 6704 Packets: 6592 Packets: 6705 31s: rebinding: 193.167.0.100:745 -> 193.167.0.100:38910 sim | Packets: 6593 36s: rebinding: 193.167.0.100:38910 -> 193.167.0.100:64331 server | 2025/12/13 12:59:32 serveReq:write to reset stream sim | 41s: rebinding: 193.167.0.100:64331 -> 193.167.0.100:19495 sim | 46s: rebinding: 193.167.0.100:19495 -> 193.167.0.100:51391 sim | 51s: rebinding: 193.167.0.100:51391 -> 193.167.0.100:28302 sim | Packets: 6706 Packets: 6594 Packets: 6707 Packets: 6595 56s: rebinding: 193.167.0.100:28302 -> 193.167.0.100:55838 client | [2025-12-13T12:59:55.641075919Z] WatchDog: system running for 58 seconds. 2025-12-13 12:59:55,852 Test failed: took longer than 60s. 2025-12-13 12:59:55,909 time="2025-12-13T12:59:55Z" level=warning msg="The \"SERVER\" variable is not set. Defaulting to a blank string." time="2025-12-13T12:59:55Z" level=warning msg="The \"CLIENT\" variable is not set. Defaulting to a blank string." invalid spec: :/downloads:delegated: empty section between colons