2025-04-30 09:44:21,078 Generated random file: sfzwvgwiaq of size: 10485760 2025-04-30 09:44:21,078 Requests: https://server4:443/sfzwvgwiaq 2025-04-30 09:44:21,149 2025-04-30 09:44:21,150 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_lkz4os_1/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_s3exiavm/ DOWNLOADS=/tmp/download_kr4kbjrh/ SERVER_LOGS=/tmp/logs_server_7y90ekm9 CLIENT_LOGS=/tmp/logs_client_q3lf3_5w SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr" CLIENT=ghcr.io/facebook/proxygen/mvfst-interop:latest SERVER=ghcr.io/alibaba/xquic/xquic-interop:latest REQUESTS="https://server4:443/sfzwvgwiaq" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 09:44:42,603 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 client | + set -o nounset client | + VERSION=1 client | + HQ_CLI=/proxygen/_build/proxygen/bin/hq client | + PORT=443 client | + LOGLEVEL=2 client | + /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] 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 | 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 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 client | Endpoint's IPv6 address is fd00:cafe:cafe::100 client | + PROTOCOL=hq-interop client | + HTTPVERSION=0.9 client | + CONN_FLOW_CONTROL=107374182 client | + STREAM_FLOW_CONTROL=107374182 client | ++ echo https://server4:443/sfzwvgwiaq client | ++ tr ' ' '\n' client | ++ paste -sd, client | ++ awk -F / '{ print "/" $4 }' client | + INVOCATIONS=/sfzwvgwiaq client | + EARLYDATA=false client | + PSK_FILE= client | + '[' -n transfer ']' client | + case "${TESTCASE}" in client | + STREAM_FLOW_CONTROL=262144 client | + CONN_FLOW_CONTROL=2621440 client | + '[' client == client ']' client | + /wait-for-it.sh sim:57832 -s -t 10 server | ./demo_server -l d -L /logs/server.log -p 443 -D /www -k /logs/keys.log -i -M server | option log level :d server | option log directory :/logs/server.log server | option port :443 server | option read dir :/www server | option key output file: /logs/keys.log server | set interop mode server | option multipath enabled server | /logs/keys.log 4 server | create ipv4 socket fd: 9 server | create ipv6 socket fd: 10 client | wait-for-it.sh: waiting 10 seconds for sim:57832 sim | server:443 is available after 1.012878102s 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 | + echo 'Starting QUIC client...' client | Starting QUIC client... client | + '[' -n https://server4:443/sfzwvgwiaq ']' client | + REQS=("${REQUESTS}") client | + REQ=https://server4:443/sfzwvgwiaq client | ++ echo https://server4:443/sfzwvgwiaq client | ++ cut -d/ -f3 client | ++ cut -d: -f1 client | + SERVER=server4 client | + for INVOCATION in ${INVOCATIONS} client | + echo 'requesting files '\''/sfzwvgwiaq'\''' client | requesting files '/sfzwvgwiaq' client | + /proxygen/_build/proxygen/bin/hq --mode=client --host=server4 --port=443 --protocol=hq-interop --httpversion=0.9 --use_version=true --quic-version=1 --path=/sfzwvgwiaq --early_data=false --psk_file= --conn_flow_control=2621440 --stream_flow_control=262144 --outdir=/downloads --logdir=/logs --qlogger_path=/logs --v=2 client | + tee /logs/client.log client | I20250430 09:44:22.853180 43 HQClient.cpp:47] HQClient connecting to 193.167.100.100:443 client | I20250430 09:44:22.894950 43 CurlClient.cpp:187] Sending request for /sfzwvgwiaq server | xqc_hq_parse_req|247||hq recv CR LF| sim | 1s: rebinding: 193.167.0.100:40358 -> 193.167.0.224:59022 sim | 1.00088s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00188s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00288s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00388s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00487s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00587s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00687s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00786s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00886s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.00986s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01085s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01185s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01285s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01384s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01484s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01584s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01683s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01783s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01883s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.01983s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02083s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02182s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02282s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02382s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02482s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02581s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02681s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02685s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.0269s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.0279s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02889s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.02989s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03089s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03189s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03289s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03388s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03488s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03588s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03687s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03787s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03887s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.03986s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04086s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04284s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04384s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04388s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04393s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04493s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04593s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04693s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04792s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04892s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.04992s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.05091s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.05191s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.05291s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.0539s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.0549s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.0559s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.0569s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.05789s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.05889s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.05989s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06088s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06188s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06288s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06387s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06487s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06587s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06686s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06786s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06886s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.06985s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07085s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07185s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07284s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07384s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07484s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07583s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07683s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07783s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07882s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.07982s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.08082s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.08182s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.08281s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.08381s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 1.08481s: unknown binding for destination 193.167.0.100:40358, dropping packet sim | 6s: rebinding: 193.167.0.224:59022 -> 193.167.0.71:39968 sim | 6.00074s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00174s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00273s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00373s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00473s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00572s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00672s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00772s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00871s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.00972s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01071s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01171s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01271s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0137s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0147s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0157s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01669s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01769s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01869s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.01969s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02068s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02168s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02268s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02367s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02467s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02567s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02666s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02766s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02866s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.02965s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03065s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03165s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03264s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03364s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03464s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03563s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03663s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03668s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03672s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03772s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03872s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.03971s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04169s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04269s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04369s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04468s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04568s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04668s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04767s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04867s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.04967s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05066s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05166s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05266s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05365s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05465s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05565s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05665s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05764s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05864s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.05964s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06063s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06163s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06263s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06362s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06462s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06562s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06662s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06762s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06861s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.06961s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07061s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0716s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0726s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.0736s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07459s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07559s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07659s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07759s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07858s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.07958s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08058s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08157s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08257s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08357s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08456s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08556s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08656s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08755s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08855s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.08955s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.09054s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.09154s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.09254s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.09353s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.09453s: unknown binding for destination 193.167.0.224:59022, dropping packet sim | 6.09553s: unknown binding for destination 193.167.0.224:59022, dropping packet client | I20250430 09:44:32.096768 43 CurlClient.cpp:276] Got EOM for /sfzwvgwiaq. Txn Time= 9201 ms 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:44:42,980 Using the server's key log file. 2025-04-30 09:44:43,020 2025-04-30 09:44:43,034 Using the server's key log file. 2025-04-30 09:44:43,034 Using the server's key log file. 2025-04-30 09:44:43,076 2025-04-30 09:44:43,091 Using the server's key log file. 2025-04-30 09:44:44,315 Check of downloaded files succeeded. 2025-04-30 09:44:44,315 Using the server's key log file. 2025-04-30 09:44:45,534 Check of downloaded files succeeded. 2025-04-30 09:45:19,429 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.224', 59022)), (('193.167.100.100', 443), ('193.167.0.71', 39968)), (('193.167.100.100', 443), ('193.167.0.100', 40358))} 2025-04-30 09:45:23,706 Using the server's key log file. 2025-04-30 09:45:58,314 Server saw these client addresses: {'193.167.0.71', '193.167.0.100', '193.167.0.224'} 2025-04-30 09:45:59,590 Check of downloaded files succeeded. 2025-04-30 09:45:59,590 Using the server's key log file. 2025-04-30 09:46:00,873 Check of downloaded files succeeded. 2025-04-30 09:46:37,262 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.224', 59022)), (('193.167.100.100', 443), ('193.167.0.71', 39968)), (('193.167.100.100', 443), ('193.167.0.100', 40358))}