2025-04-30 09:47:34,733 Generated random file: ccsxuieshp of size: 5120 2025-04-30 09:47:34,733 Generated random file: vyuekhqxzk of size: 10240 2025-04-30 09:47:34,735 Generated random file: aslihcdmcw of size: 512000 2025-04-30 09:47:34,735 Requests: https://server4:443/ccsxuieshp https://server4:443/vyuekhqxzk https://server4:443/aslihcdmcw 2025-04-30 09:47:34,793 2025-04-30 09:47:34,793 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_cvqc5mof/ TESTCASE_SERVER=http3 TESTCASE_CLIENT=http3 WWW=/tmp/www_fdo7yjxd/ DOWNLOADS=/tmp/download_xdh5lsqo/ SERVER_LOGS=/tmp/logs_server_m0c5x09l CLIENT_LOGS=/tmp/logs_client_cjjffl6o SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=ghcr.io/alibaba/xquic/xquic-interop:latest SERVER=aiortc/aioquic-qns:latest REQUESTS="https://server4:443/ccsxuieshp https://server4:443/vyuekhqxzk https://server4:443/aslihcdmcw" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 09:47:47,828 Container sim Created 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-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 server | Endpoint's IPv6 address is fd00:cafe:cafe:100::100 server | Starting server 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 client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 1.061124519s sim | Using scenario: simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25 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 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/ccsxuieshp https://server4:443/vyuekhqxzk https://server4:443/aslihcdmcw -A h3 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/ccsxuieshp https://server4:443/vyuekhqxzk https://server4:443/aslihcdmcw client | server[server4] addr: 193.167.100.100:443. client | option set ALPN[h3] client | No.0 path created id = 0 client | open file[/downloads/ccsxuieshp] suc client | xqc_demo_cli_h3_request_send success size=25 client | open file[/downloads/vyuekhqxzk] suc client | xqc_demo_cli_h3_request_send success size=26 client | open file[/downloads/aslihcdmcw] suc client | xqc_demo_cli_h3_request_send success size=25 client | 0rtt_flag:0 client | :status = 200 client | server = aioquic/1.2.0 client | date = Wed, 30 Apr 2025 09:47:36 GMT client | content-type = text/plain; charset=utf-8 client | content-length = 5120 client | last-modified = Wed, 30 Apr 2025 09:47:34 GMT client | etag = "8c4b030d7428af63883097e207ea520a" client | :status = 200 client | server = aioquic/1.2.0 client | date = Wed, 30 Apr 2025 09:47:36 GMT client | content-type = text/plain; charset=utf-8 client | content-length = 10240 client | last-modified = Wed, 30 Apr 2025 09:47:34 GMT client | etag = "386ccbc86ebd686afaa3f3949be94142" client | :status = 200 client | server = aioquic/1.2.0 client | date = Wed, 30 Apr 2025 09:47:36 GMT client | content-type = text/plain; charset=utf-8 client | content-length = 512000 client | last-modified = Wed, 30 Apr 2025 09:47:34 GMT client | etag = "dc1c5981c6d58d88bbf249b6504565a2" client | xqc_h3_request_recv_body size 455, fin:1 client | >>>>>>>> request time cost:92438 us, speed:55 K/s client | >>>>>>>> send_body_size:0, recv_body_size:5120 client | stream_info:(1,0,0/0/0/a/0,27,5242,0,0,44)#0-1-6-27-5242-39738-2 client | xqc_h3_request_recv_body size 1017, fin:1 client | >>>>>>>> request time cost:140811 us, speed:72 K/s client | >>>>>>>> send_body_size:0, recv_body_size:10240 client | stream_info:(1,0,0/0/0/a/0,28,10286,0,0,44)#0-1-11-28-10286-37848-2 client | task[0], fin_cnt: 1, fin_flag: 0 client | send_body_size:0, recv_body_size:5120, send_header_size:59, recv_header_size:197, recv_fin:1, err:0, rate_limit:0, mp_state:0, early_data:0, avail_send_weight:1.000, avail_recv_weight:1.000, cwnd_blk:0 client | [H3-req] send_bytes:59, recv_bytes:5317, path_info:(1,0,0/0/0/a/0,27,5242,0,0,44)#0-1-6-27-5242-37848-2 client | task[0], fin_cnt: 2, fin_flag: 0 client | send_body_size:0, recv_body_size:10240, send_header_size:59, recv_header_size:198, recv_fin:1, err:0, rate_limit:0, mp_state:0, early_data:0, avail_send_weight:1.000, avail_recv_weight:1.000, cwnd_blk:0 client | [H3-req] send_bytes:59, recv_bytes:10438, path_info:(1,0,0/0/0/a/0,28,10286,0,0,44)#0-1-11-28-10286-37848-2 client | xqc_h3_request_recv_body size 369, fin:1 client | >>>>>>>> request time cost:569365 us, speed:899 K/s client | >>>>>>>> send_body_size:0, recv_body_size:512000 client | stream_info:(1,0,0/0/0/a/0,27,512083,0,0,44)#0-1-460-27-512083-37848-2 client | task[0], fin_cnt: 3, fin_flag: 1 client | send_body_size:0, recv_body_size:512000, send_header_size:59, recv_header_size:199, recv_fin:1, err:0, rate_limit:0, mp_state:0, early_data:0, avail_send_weight:1.000, avail_recv_weight:1.000, cwnd_blk:0 client | [H3-req] send_bytes:59, recv_bytes:512199, path_info:(1,0,0/0/0/a/0,27,512083,0,0,44)#0-1-460-27-512083-37090-2 client | send_count:13, lost_count:0, tlp_count:0, recv_count:485, srtt:37090 standby_bytes:0, total_bytes:544916 early_data_flag:0, conn_err:0, acked_max_mtu 1200, ack_info:#525-491#0-0#0-0#v0429, conn_info:0/0/0/a/0,1,1,1,0,0,0,0,0,0,0,141,488,485,104,0,527715,i96,4,395,404,80,524,570,0,4,28,37,4,525,600,0,4,1191,1200,80,523,570,0,4,18,100,142,568,4,70,4,143,594,4,17,40000,147,879,0-2,0-2,0-0,0-0,0-0,0-37,0-10479,0-545951,0-13,0-485,0-0,0-0,0-0,0-0,0-0,0-0,0-0,0-0 client | task finished, total task_req_cnt: 3, req_fin_cnt: 3, req_sent_cnt: 0, req_create_cnt: 3 client | all tasks are finished, will break loop and exit client | 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:47:47,929 Using the client's key log file. 2025-04-30 09:47:47,939 2025-04-30 09:47:47,940 Using the client's key log file. 2025-04-30 09:47:47,940 Using the client's key log file. 2025-04-30 09:47:47,948 2025-04-30 09:47:47,950 Using the client's key log file. 2025-04-30 09:47:48,535 Check of downloaded files succeeded.