2025-04-30 09:56:58,325 Generated random file: iofcclonsu of size: 10485760 2025-04-30 09:56:58,325 Requests: https://server4:443/iofcclonsu 2025-04-30 09:56:58,385 2025-04-30 09:56:58,385 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_ngod_jg9/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_xspaz_y9/ DOWNLOADS=/tmp/download_dgpiymhf/ SERVER_LOGS=/tmp/logs_server_5p9o7_nv CLIENT_LOGS=/tmp/logs_client_nv3r_jyg SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s" CLIENT=ghcr.io/alibaba/xquic/xquic-interop:latest SERVER=aiortc/aioquic-qns:latest REQUESTS="https://server4:443/iofcclonsu" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 09:57:21,237 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... 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-checksumming: off server | tx-checksum-ip-generic: off server | tx-checksum-sctp: off server | tcp-segmentation-offload: off server | tx-tcp-segmentation: off [requested on] server | tx-tcp-ecn-segmentation: off [requested on] server | tx-tcp-mangleid-segmentation: off [requested on] server | tx-tcp6-segmentation: off [requested on] server | tx-udp-segmentation: off [requested on] 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 server client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 1.040501844s sim | Using scenario: rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s 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 | ./demo_client -l d -L /logs/client.log -D /downloads -k /logs/keys.log -K 30 -o -U "https://server4:443/iofcclonsu" client | client | option log level :d client | option log directory :/logs/client.log client | option save body dir: /downloads client | key output file: /logs/keys.log client | client life circle time: 30 client | set interop mode client | option url only:https://server4:443/iofcclonsu client | server[server4] addr: 193.167.100.100:443. client | No.0 path created id = 0 client | open file[/downloads/iofcclonsu] suc sim | 1s: rebinding: 193.167.0.100:45440 -> 193.167.0.100:57607 sim | 1.00027s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.00125s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.00224s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.00268s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.00972s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01071s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01169s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01268s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01366s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01464s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01563s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01661s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.0176s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 1.01773s: unknown binding for destination 193.167.0.100:45440, dropping packet sim | 6s: rebinding: 193.167.0.100:57607 -> 193.167.0.100:59022 sim | 6.00677s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00775s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00874s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00972s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01071s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01169s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01267s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01366s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01464s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01554s: unknown binding for destination 193.167.0.100:57607, dropping packet client | >>>>>>>> request time cost:10331713 us, speed:1014 K/s client | >>>>>>>> user_stream[0x5651d90552f0], req: /iofcclonsu, send_body_size:11, recv_body_size:10485760 client | [HQ-req] send_bytes:17, recv_bytes:10485760, path_info:0-1-9160-17-10485760 client | task[0], fin_cnt: 1, fin_flag: 1 client | task finished, total task_req_cnt: 1, req_fin_cnt: 1, req_sent_cnt: 0, req_create_cnt: 1 client | all tasks are finished, will break loop and exit client | sim | 11s: rebinding: 193.167.0.100:59022 -> 193.167.0.100:18108 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:57:21,465 Using the client's key log file. 2025-04-30 09:57:21,496 2025-04-30 09:57:21,510 Using the client's key log file. 2025-04-30 09:57:21,510 Using the client's key log file. 2025-04-30 09:57:21,541 2025-04-30 09:57:21,555 Using the client's key log file. 2025-04-30 09:57:22,690 Check of downloaded files succeeded. 2025-04-30 09:57:22,690 Using the client's key log file. 2025-04-30 09:57:23,834 Check of downloaded files succeeded. 2025-04-30 09:57:56,342 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.100', 59022)), (('193.167.100.100', 443), ('193.167.0.100', 45440)), (('193.167.100.100', 443), ('193.167.0.100', 57607))}