2025-04-30 11:34:46,482 Generated random file: fmtyqxjjvb of size: 10485760 2025-04-30 11:34:46,482 Requests: https://server4:443/fmtyqxjjvb 2025-04-30 11:34:46,543 2025-04-30 11:34:46,543 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_zt9k44k3/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_d363md6a/ DOWNLOADS=/tmp/download_ij0on20s/ SERVER_LOGS=/tmp/logs_server_p4787_gz CLIENT_LOGS=/tmp/logs_client_ch2zvfr4 SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s" CLIENT=privateoctopus/picoquic:latest SERVER=litespeedtech/lsquic-qir:latest REQUESTS="https://server4:443/fmtyqxjjvb" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 11:35:07,908 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-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 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 server | TEST_PARAMS: server | REQUESTS: '' client | Endpoint's IPv4 address is 193.167.0.100 server | paths: server | server: server | port: server | SERVER_PARAMS: 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.059357094s 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)tcpdump: , snapshot length 262144 bytes sim | 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 | Starting picoquic client for test: transfer client | Starting picoquic client ... client | Parsing server name from first request: https://server4:443/fmtyqxjjvb client | Server set to: server4 client | Requests: https://server4:443/fmtyqxjjvb client | parsing as 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: <-:/fmtyqxjjvb;> client | Max stream id bidir remote before start = 0 (0) client | Starting client connection. Version = 1, I-CID: 2c235ad436ba6730 client | Max stream id bidir remote after start = -4 (0) client | Waiting for packets. client | Client port (AF=2): 61674. client | Negotiated ALPN: hq-interop client | Almost ready! client | client | Connection established. Version = 1, I-CID: 2c235ad436ba6730, verified: 1 client | Opening stream 0 to GET /fmtyqxjjvb sim | 1s: rebinding: 193.167.0.100:60144 -> 193.167.0.100:57607 sim | 1.00009s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00127s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00244s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00362s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00479s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00597s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00715s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.00832s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.0095s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01067s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01185s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01303s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.0142s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01538s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01655s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01773s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.01891s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02008s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02126s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02243s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02361s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02479s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02596s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02714s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02837s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.02954s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.03072s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.0319s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.03307s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.03425s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.03542s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.0366s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.03778s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.03895s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04013s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.0413s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04248s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04366s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04483s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04601s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04718s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04836s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.04954s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05071s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05189s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05306s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05424s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05542s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05659s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05777s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.05894s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.06012s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.0613s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.06247s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.06365s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.06482s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 1.066s: unknown binding for destination 193.167.0.100:60144, dropping packet sim | 6s: rebinding: 193.167.0.100:57607 -> 193.167.0.100:59022 sim | 6.00029s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00147s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00265s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00382s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.005s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00617s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00735s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.00853s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0097s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01088s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01205s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01323s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01441s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01558s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01676s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01793s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.01911s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02029s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02146s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02264s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02381s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02499s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02617s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02734s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02852s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.02969s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03087s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03205s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03322s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0344s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.03557s: 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.03793s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0391s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04028s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04145s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04268s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04386s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04503s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04621s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04739s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04856s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.04974s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05091s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05209s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05327s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05444s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05562s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05679s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05797s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.05915s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06032s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0615s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06267s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06385s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06503s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0662s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06738s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06855s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.06973s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07091s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07208s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07326s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07443s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07561s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07679s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07796s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.07914s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08031s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08149s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08267s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08384s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08502s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08619s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08737s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08855s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.08972s: unknown binding for destination 193.167.0.100:57607, dropping packet sim | 6.0909s: unknown binding for destination 193.167.0.100:57607, dropping packet client | Stream 0 ended after 10485760 bytes client | All done, Closing the connection. client | Received a request to close the connection. client | Address Discovery mode: 0 / 0 (0:0) client | Quic Bit was NOT greased by the client. client | Quic Bit was greased by the server. client | ECN was received (ect0: 0, ect1: 7520, ce: 0). client | ECN was not acknowledged. client | Received 10485760 bytes in 9.404303 seconds, 8.919968 Mbps. client | Sent 17 bytes in 9.404303 seconds, 0.000014 Mbps. client | max_data_local: 28311552 client | max_stream_data_local: 56623104 client | max_data_remote: 1572864 client | max_stream_data_remote: 1048576 client | ack_delay_remote: 1000 ... 4794 client | max_ack_gap_remote: 2 client | ack_delay_local: 25000 ... 25000 client | max_ack_gap_local: 2 client | max_mtu_sent: 1252 client | max_mtu_received: 1440 client | System call duration max: 24 client | System call duration smoothed: 1 client | System call duration deviation: 0 client | Received ticket from server4 (hq-interop): client | ticket time = 1746012888198, kx = 17, suite = 1301, 282 ticket, 32 secret. client | lifetime = 172800, age_add = 8537e438, 1 nonce, 256 ticket, 12 extensions. client | ticket extensions: 42(ED: ffffffff), client | 4 extra bytes at the end of the extensions client | Client exit with code = 0 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 11:35:08,106 Using the client's key log file. 2025-04-30 11:35:08,151 2025-04-30 11:35:08,164 Using the client's key log file. 2025-04-30 11:35:08,164 Using the client's key log file. 2025-04-30 11:35:08,196 2025-04-30 11:35:08,210 Using the client's key log file. 2025-04-30 11:35:09,260 Check of downloaded files succeeded. 2025-04-30 11:35:09,260 Using the client's key log file. 2025-04-30 11:35:10,314 Check of downloaded files succeeded. 2025-04-30 11:35:39,498 Server saw these paths used: {(('193.167.100.100', 443), ('193.167.0.100', 59022)), (('193.167.100.100', 443), ('193.167.0.100', 57607)), (('193.167.100.100', 443), ('193.167.0.100', 60144))}