2025-04-30 13:56:16,636 Generated random file: gdiqmbvvqu of size: 1024 2025-04-30 13:56:16,636 Generated random file: gulkhrkxxq of size: 1024 2025-04-30 13:56:16,636 Generated random file: lnetownjff of size: 1024 2025-04-30 13:56:16,636 Generated random file: wrrjoxssqc of size: 1024 2025-04-30 13:56:16,636 Generated random file: gxbbgqrhoz of size: 1024 2025-04-30 13:56:16,636 Generated random file: rotrbttmlz of size: 1024 2025-04-30 13:56:16,637 Generated random file: pytvfmlakp of size: 1024 2025-04-30 13:56:16,637 Generated random file: fonwvrzqim of size: 1024 2025-04-30 13:56:16,637 Generated random file: pscuasqqgy of size: 1024 2025-04-30 13:56:16,637 Generated random file: eweqsdzitm of size: 1024 2025-04-30 13:56:16,637 Generated random file: uirfzxfjif of size: 1024 2025-04-30 13:56:16,637 Generated random file: rosyivebhn of size: 1024 2025-04-30 13:56:16,637 Generated random file: wabtnnzhrh of size: 1024 2025-04-30 13:56:16,637 Generated random file: kstyvwloyu of size: 1024 2025-04-30 13:56:16,638 Generated random file: exodbgdcww of size: 1024 2025-04-30 13:56:16,638 Generated random file: ktrujtavik of size: 1024 2025-04-30 13:56:16,638 Generated random file: bxadzbwwbn of size: 1024 2025-04-30 13:56:16,638 Generated random file: mfjbbeopex of size: 1024 2025-04-30 13:56:16,638 Generated random file: niqnuebwav of size: 1024 2025-04-30 13:56:16,638 Generated random file: xxcolxgegp of size: 1024 2025-04-30 13:56:16,638 Generated random file: doebwmszhm of size: 1024 2025-04-30 13:56:16,638 Generated random file: bftendwhti of size: 1024 2025-04-30 13:56:16,638 Generated random file: nynwfohudh of size: 1024 2025-04-30 13:56:16,639 Generated random file: pczmbnshxy of size: 1024 2025-04-30 13:56:16,639 Generated random file: uuwtzkvegv of size: 1024 2025-04-30 13:56:16,639 Generated random file: rkzreegwed of size: 1024 2025-04-30 13:56:16,639 Generated random file: dfhxzoyxuc of size: 1024 2025-04-30 13:56:16,639 Generated random file: hlluxgjmwh of size: 1024 2025-04-30 13:56:16,639 Generated random file: euavtcxgbt of size: 1024 2025-04-30 13:56:16,639 Generated random file: aeofiowhnv of size: 1024 2025-04-30 13:56:16,639 Generated random file: xdnyagetgc of size: 1024 2025-04-30 13:56:16,640 Generated random file: tknzbfdtjf of size: 1024 2025-04-30 13:56:16,640 Generated random file: hnkydsuxum of size: 1024 2025-04-30 13:56:16,640 Generated random file: qqvdfigulg of size: 1024 2025-04-30 13:56:16,640 Generated random file: jjhnvfnmnk of size: 1024 2025-04-30 13:56:16,640 Generated random file: xtifmuhvfx of size: 1024 2025-04-30 13:56:16,640 Generated random file: rorsisobdv of size: 1024 2025-04-30 13:56:16,640 Generated random file: phhekqfgcm of size: 1024 2025-04-30 13:56:16,640 Generated random file: jxabxjkasl of size: 1024 2025-04-30 13:56:16,641 Generated random file: ikthjywien of size: 1024 2025-04-30 13:56:16,641 Generated random file: jobnnqqkaq of size: 1024 2025-04-30 13:56:16,641 Generated random file: vnihdwgyjh of size: 1024 2025-04-30 13:56:16,641 Generated random file: fexlvywypg of size: 1024 2025-04-30 13:56:16,641 Generated random file: uhscetynab of size: 1024 2025-04-30 13:56:16,641 Generated random file: axmxhqvnrf of size: 1024 2025-04-30 13:56:16,641 Generated random file: guvtncglzw of size: 1024 2025-04-30 13:56:16,641 Generated random file: eredxfoudl of size: 1024 2025-04-30 13:56:16,642 Generated random file: jtfoceiluf of size: 1024 2025-04-30 13:56:16,642 Generated random file: sykxxoqoon of size: 1024 2025-04-30 13:56:16,642 Generated random file: kyvnsufwgj of size: 1024 2025-04-30 13:56:16,642 Requests: https://server4:443/gdiqmbvvqu https://server4:443/gulkhrkxxq https://server4:443/lnetownjff https://server4:443/wrrjoxssqc https://server4:443/gxbbgqrhoz https://server4:443/rotrbttmlz https://server4:443/pytvfmlakp https://server4:443/fonwvrzqim https://server4:443/pscuasqqgy https://server4:443/eweqsdzitm https://server4:443/uirfzxfjif https://server4:443/rosyivebhn https://server4:443/wabtnnzhrh https://server4:443/kstyvwloyu https://server4:443/exodbgdcww https://server4:443/ktrujtavik https://server4:443/bxadzbwwbn https://server4:443/mfjbbeopex https://server4:443/niqnuebwav https://server4:443/xxcolxgegp https://server4:443/doebwmszhm https://server4:443/bftendwhti https://server4:443/nynwfohudh https://server4:443/pczmbnshxy https://server4:443/uuwtzkvegv https://server4:443/rkzreegwed https://server4:443/dfhxzoyxuc https://server4:443/hlluxgjmwh https://server4:443/euavtcxgbt https://server4:443/aeofiowhnv https://server4:443/xdnyagetgc https://server4:443/tknzbfdtjf https://server4:443/hnkydsuxum https://server4:443/qqvdfigulg https://server4:443/jjhnvfnmnk https://server4:443/xtifmuhvfx https://server4:443/rorsisobdv https://server4:443/phhekqfgcm https://server4:443/jxabxjkasl https://server4:443/ikthjywien https://server4:443/jobnnqqkaq https://server4:443/vnihdwgyjh https://server4:443/fexlvywypg https://server4:443/uhscetynab https://server4:443/axmxhqvnrf https://server4:443/guvtncglzw https://server4:443/eredxfoudl https://server4:443/jtfoceiluf https://server4:443/sykxxoqoon https://server4:443/kyvnsufwgj 2025-04-30 13:56:16,702 2025-04-30 13:56:16,702 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_apwhk_wx/ TESTCASE_SERVER=multiconnect TESTCASE_CLIENT=multiconnect WWW=/tmp/www_o4q0ds_s/ DOWNLOADS=/tmp/download_6zl0_1t3/ SERVER_LOGS=/tmp/logs_server_0m5_l_qy CLIENT_LOGS=/tmp/logs_client_hdldwsrf SCENARIO="drop-rate --delay=15ms --bandwidth=10Mbps --queue=25 --rate_to_server=30 --rate_to_client=30 --burst_to_server=3 --burst_to_client=3" CLIENT=privateoctopus/picoquic:latest SERVER=ghcr.io/alibaba/xquic/xquic-interop:latest REQUESTS="https://server4:443/gdiqmbvvqu https://server4:443/gulkhrkxxq https://server4:443/lnetownjff https://server4:443/wrrjoxssqc https://server4:443/gxbbgqrhoz https://server4:443/rotrbttmlz https://server4:443/pytvfmlakp https://server4:443/fonwvrzqim https://server4:443/pscuasqqgy https://server4:443/eweqsdzitm https://server4:443/uirfzxfjif https://server4:443/rosyivebhn https://server4:443/wabtnnzhrh https://server4:443/kstyvwloyu https://server4:443/exodbgdcww https://server4:443/ktrujtavik https://server4:443/bxadzbwwbn https://server4:443/mfjbbeopex https://server4:443/niqnuebwav https://server4:443/xxcolxgegp https://server4:443/doebwmszhm https://server4:443/bftendwhti https://server4:443/nynwfohudh https://server4:443/pczmbnshxy https://server4:443/uuwtzkvegv https://server4:443/rkzreegwed https://server4:443/dfhxzoyxuc https://server4:443/hlluxgjmwh https://server4:443/euavtcxgbt https://server4:443/aeofiowhnv https://server4:443/xdnyagetgc https://server4:443/tknzbfdtjf https://server4:443/hnkydsuxum https://server4:443/qqvdfigulg https://server4:443/jjhnvfnmnk https://server4:443/xtifmuhvfx https://server4:443/rorsisobdv https://server4:443/phhekqfgcm https://server4:443/jxabxjkasl https://server4:443/ikthjywien https://server4:443/jobnnqqkaq https://server4:443/vnihdwgyjh https://server4:443/fexlvywypg https://server4:443/uhscetynab https://server4:443/axmxhqvnrf https://server4:443/guvtncglzw https://server4:443/eredxfoudl https://server4:443/jtfoceiluf https://server4:443/sykxxoqoon https://server4:443/kyvnsufwgj" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 14:01:16,723 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 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 | ./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 | Setting up the simulation with setup.sh 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 | Setup.sh completed client | Waiting for the simulator to start client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 1.009194996s sim | Using scenario: drop-rate --delay=15ms --bandwidth=10Mbps --queue=25 --rate_to_server=30 --rate_to_client=30 --burst_to_server=3 --burst_to_client=3 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 client | wait-for-it.sh: sim:57832 is available after 1 seconds client | Starting picoquic client for test: multiconnect client | Starting picoquic client ... client | Parsing server name from first request: https://server4:443/gdiqmbvvqu client | Server set to: server4 client | Requests: https://server4:443/gdiqmbvvqu https://server4:443/gulkhrkxxq https://server4:443/lnetownjff https://server4:443/wrrjoxssqc https://server4:443/gxbbgqrhoz https://server4:443/rotrbttmlz https://server4:443/pytvfmlakp https://server4:443/fonwvrzqim https://server4:443/pscuasqqgy https://server4:443/eweqsdzitm https://server4:443/uirfzxfjif https://server4:443/rosyivebhn https://server4:443/wabtnnzhrh https://server4:443/kstyvwloyu https://server4:443/exodbgdcww https://server4:443/ktrujtavik https://server4:443/bxadzbwwbn https://server4:443/mfjbbeopex https://server4:443/niqnuebwav https://server4:443/xxcolxgegp https://server4:443/doebwmszhm https://server4:443/bftendwhti https://server4:443/nynwfohudh https://server4:443/pczmbnshxy https://server4:443/uuwtzkvegv https://server4:443/rkzreegwed https://server4:443/dfhxzoyxuc https://server4:443/hlluxgjmwh https://server4:443/euavtcxgbt https://server4:443/aeofiowhnv https://server4:443/xdnyagetgc https://server4:443/tknzbfdtjf https://server4:443/hnkydsuxum https://server4:443/qqvdfigulg https://server4:443/jjhnvfnmnk https://server4:443/xtifmuhvfx https://server4:443/rorsisobdv https://server4:443/phhekqfgcm https://server4:443/jxabxjkasl https://server4:443/ikthjywien https://server4:443/jobnnqqkaq https://server4:443/vnihdwgyjh https://server4:443/fexlvywypg https://server4:443/uhscetynab https://server4:443/axmxhqvnrf https://server4:443/guvtncglzw https://server4:443/eredxfoudl https://server4:443/jtfoceiluf https://server4:443/sykxxoqoon https://server4:443/kyvnsufwgj client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | parsing as client | /picoquic/picoquicdemo -8 -L -l /logs/test_log.txt -q /logs/qlog -o /downloads -0 -d 180000 -a hq-interop -v 00000001 server4 443 /gdiqmbvvqu client | Starting Picoquic (v1.1.26.1) connection to server = server4, port = 443 client | No token file present. Will create one as . client | Testing scenario: client | Max stream id bidir remote before start = 0 (0) client | Starting client connection. Version = 1, I-CID: 858240095cb5cdf client | Max stream id bidir remote after start = -4 (0) client | Waiting for packets. sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 0/1 (0.0%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 0/2 (0.0%) server | server_read_handler: packet process err, ret: -1 sim | Dropping 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 1/3 (33.3%) sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 1/4 (25.0%) server | server_read_handler: packet process err, ret: -1 sim | Dropping 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 2/5 (40.0%) sim | Dropping 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/6 (50.0%) sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/7 (42.9%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/8 (37.5%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/9 (33.3%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/10 (30.0%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/11 (27.3%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/12 (25.0%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/13 (23.1%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/14 (21.4%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/15 (20.0%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/16 (18.8%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/17 (17.6%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 3/18 (16.7%) server | server_read_handler: packet process err, ret: -1 sim | Dropping 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 4/19 (21.1%) sim | Forwarding 1252 bytes 193.167.0.100:51603 -> 193.167.100.100:443, dropped 4/20 (20.0%) server | server_read_handler: packet process err, ret: -1 client | Received a request to close the connection. client | Connection end with local error 0x433. client | Address Discovery mode: 0 / 0 (0:0) client | Quic Bit was NOT greased by the client. client | Quic Bit was NOT greased by the server. client | ECN was not received. client | ECN was not acknowledged. client | Client exit with code = -1 client | mv /logs/test_log.txt /logs/mc-gdiqmbvvqu.txt client | /picoquic/picoquicdemo -8 -L -l /logs/test_log.txt -q /logs/qlog -o /downloads -0 -d 180000 -a hq-interop -v 00000001 server4 443 /gulkhrkxxq client | Starting Picoquic (v1.1.26.1) connection to server = server4, port = 443 client | Testing scenario: client | Max stream id bidir remote before start = 0 (0) client | Starting client connection. Version = 1, I-CID: 52be26ff2b4d6e56 client | Max stream id bidir remote after start = -4 (0) client | Waiting for packets. sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/21 (19.0%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/22 (18.2%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/23 (17.4%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/24 (16.7%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/25 (16.0%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/26 (15.4%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/27 (14.8%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 4/28 (14.3%) server | server_read_handler: packet process err, ret: -1 sim | Dropping 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/29 (17.2%) sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/30 (16.7%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/31 (16.1%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/32 (15.6%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/33 (15.2%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/34 (14.7%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/35 (14.3%) server | server_read_handler: packet process err, ret: -1 sim | Forwarding 1252 bytes 193.167.0.100:56151 -> 193.167.100.100:443, dropped 5/36 (13.9%) server | server_read_handler: packet process err, ret: -1 2025-04-30 14:01:16,724 Test failed: took longer than 300s. 2025-04-30 14:01:16,775 time="2025-04-30T14:01:16Z" level=warning msg="The \"SERVER\" variable is not set. Defaulting to a blank string." time="2025-04-30T14:01:16Z" level=warning msg="The \"CLIENT\" variable is not set. Defaulting to a blank string." invalid spec: :/downloads:delegated: empty section between colons