2025-12-13 09:55:05,587 Generated random file: cruel-thick-speaker of size: 10485760 2025-12-13 09:55:05,587 Requests: https://server4:443/cruel-thick-speaker 2025-12-13 09:55:05,646 2025-12-13 09:55:05,647 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_356_zhlk/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_hl4i4zt0/ DOWNLOADS=/tmp/download_x2imvb1n/ SERVER_LOGS=/tmp/logs_server_jocz4847 CLIENT_LOGS=/tmp/logs_client_dz64pouc SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s" CLIENT=aiortc/aioquic-qns:latest SERVER=cloudflare/quiche-qns:latest REQUESTS="https://server4:443/cruel-thick-speaker" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-12-13 09:56:05,655 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 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 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 server | supported client | wait-for-it.sh: waiting 30 seconds for sim:57832 server | ## Starting quiche server... server | ## Server params: server | ## Test case: transfer sim | server:443 is available after 501.450326ms 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 | Starting client sim | Packets: 3 Packets: 2 Packets: 8 Packets: 7 Packets: 12 Packets: 28 1s: rebinding: 193.167.0.100:36987 -> 193.167.0.100:57607 sim | 1.00007s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.00117s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.00228s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.00338s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.00448s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.00559s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.00669s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.0078s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.0089s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01111s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01221s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01332s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01442s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01552s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01663s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01773s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01884s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.01994s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02104s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02215s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02325s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02436s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02546s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02656s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02767s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02877s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.02988s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.03098s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.03208s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.03319s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.03429s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.0354s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.0365s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.0376s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.03871s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.03981s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.04092s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.04202s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | 1.04312s: unknown binding for destination 193.167.0.100:36987, dropping packet sim | Packets: 158 Packets: 133 Packets: 400 Packets: 360 Packets: 666 Packets: 650 Packets: 965 Packets: 942 Packets: 1251 Packets: 1223 Packets: 1538 Packets: 1523 Packets: 1850 Packets: 1823 Packets: 2142 Packets: 2110 Packets: 2431 Packets: 2404 Packets: 2721 Packets: 2695 Packets: 3020 Packets: 2996 Packets: 3318 Packets: 3269 Packets: 3585 Packets: 3536 Packets: 3850 Packets: 3801 Packets: 4112 Packets: 4064 Packets: 4374 Packets: 4325 Packets: 4638 Packets: 4588 Packets: 4900 Packets: 4853 Packets: 5164 Packets: 5117 Packets: 5428 Packets: 5381 Packets: 5690 Packets: 5642 Packets: 5950 Packets: 5904 Packets: 6227 Packets: 6191 Packets: 6525 Packets: 6490 Packets: 6819 Packets: 6780 Packets: 7106 Packets: 7067 Packets: 7391 Packets: 7352 6s: rebinding: 193.167.0.100:57607 -> 193.167.0.100:59022 sim | 6.00102s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00213s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00323s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00378s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00489s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00557s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00667s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0069s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00801s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00911s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01021s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01108s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01218s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01329s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01372s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01482s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01522s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01633s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01743s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01854s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01964s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02074s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02185s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02295s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02406s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02516s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02626s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02737s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02847s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02958s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03068s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03178s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03289s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03399s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0351s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03519s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03564s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03675s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0369s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03786s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | Packets: 7670 Packets: 7636 Packets: 7971 Packets: 7873 Packets: 8197 Packets: 8151 Packets: 8488 Packets: 8437 Packets: 8773 Packets: 8716 Packets: 9049 Packets: 8999 Packets: 9332 Packets: 9294 Packets: 9642 Packets: 9610 Packets: 9958 Packets: 9920 Packets: 10266 Packets: 10222 Packets: 10568 Packets: 10498 Packets: 10844 Packets: 10784 Packets: 11130 Packets: 11077 Packets: 11422 Packets: 11362 Packets: 11703 Packets: 11646 Packets: 11989 Packets: 11926 Packets: 12267 Packets: 12202 Packets: 12544 Packets: 12483 Packets: 12824 Packets: 12755 Packets: 13093 Packets: 13024 Packets: 13376 Packets: 13324 Packets: 13677 Packets: 13623 Packets: 13974 Packets: 13762 Packets: 14071 11s: rebinding: 193.167.0.100:59022 -> 193.167.0.100:18108 sim | 12.1392s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 12.1396s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 12.2216s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 12.2216s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14073 12.3872s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 12.3876s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14077 12.7169s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 12.7174s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 13763 Packets: 14080 13.3749s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 13.3754s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 13764 Packets: 14082 Packets: 14083 14.6898s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 14.6903s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14085 16s: rebinding: 193.167.0.100:18108 -> 193.167.0.100:39968 sim | 17.3208s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 17.3213s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14087 18.2582s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 18.2587s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14089 21s: rebinding: 193.167.0.100:39968 -> 193.167.0.100:745 sim | 23.5199s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 23.5204s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14090 Packets: 14091 26s: rebinding: 193.167.0.100:745 -> 193.167.0.100:38910 sim | Packets: 14092 Packets: 13765 Packets: 13766 30.4994s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 30.4999s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14094 31s: rebinding: 193.167.0.100:38910 -> 193.167.0.100:64331 sim | Packets: 14095 36s: rebinding: 193.167.0.100:64331 -> 193.167.0.100:19495 sim | Packets: 14098 41s: rebinding: 193.167.0.100:19495 -> 193.167.0.100:51391 sim | 41.0166s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | 41.0171s: unknown binding for destination 193.167.0.100:59022, dropping packet sim | Packets: 14099 Packets: 14100 46s: rebinding: 193.167.0.100:51391 -> 193.167.0.100:28302 sim | 51s: rebinding: 193.167.0.100:28302 -> 193.167.0.100:55838 sim | 56s: rebinding: 193.167.0.100:55838 -> 193.167.0.100:46157 2025-12-13 09:56:05,656 Test failed: took longer than 60s. 2025-12-13 09:56:05,715 time="2025-12-13T09:56:05Z" level=warning msg="The \"SERVER\" variable is not set. Defaulting to a blank string." time="2025-12-13T09:56:05Z" level=warning msg="The \"CLIENT\" variable is not set. Defaulting to a blank string." invalid spec: :/www:ro: empty section between colons