2025-12-13 08:48:10,219 Generated random file: satisfied-purple-bag of size: 1024 2025-12-13 08:48:10,219 Requests: https://server4:443/satisfied-purple-bag 2025-12-13 08:48:10,280 2025-12-13 08:48:10,281 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_cgyfn0p0/ TESTCASE_SERVER=v2 TESTCASE_CLIENT=v2 WWW=/tmp/www_5voqbm8j/ DOWNLOADS=/tmp/download_ugloeix4/ SERVER_LOGS=/tmp/logs_server_omm9_ehb CLIENT_LOGS=/tmp/logs_client_9niduvl8 SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=peterdoornbosch/kwik_n_flupke-interop SERVER=ghcr.io/ngtcp2/ngtcp2-interop:latest REQUESTS="https://server4:443/satisfied-purple-bag" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-12-13 08:48:24,253 Container server Recreate Container client Recreate Container server Recreated Container client Recreated Attaching to client, server, sim sim | waiting 10s for server:443 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 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 client | Certificate was added to keystore sim | server:443 is available after 501.812167ms sim | Using scenario: simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25 sim | Capturing on 'eth1' sim | Capturing on 'eth0' sim | File: /logs/trace_node_right.pcap sim | File: /logs/trace_node_left.pcap client | wait-for-it.sh: waiting 30 seconds for sim:57832 client | wait-for-it.sh: sim:57832 is available after 1 seconds client | 48:12.384 Creating connection with server4:443 with v1 client | 48:12.468 Original destination connection id: da90f0d143500bde (scid: 7e751eee3f2842e9) client | >- CryptoStream[I|ClientHello] client | 48:12.626 -> Packet I|0|L|1200|2 Token=[] CryptoFrame[0,271] Padding(882) client | 48:12.675 Receiving packet with version v2, while connection version is v1 client | 48:12.668 <- (1) Packet I|1602373684|L|190|2 Token=[] AckFrame[0|?0] CryptoFrame[0,123] client | -< CryptoStream[I|ServerHello] client | 48:12.718 -> Packet I|1|L|1200|2 Token=[] AckFrame[1602373684|?0] Padding(1135) client | 48:12.668 <- (1) Packet H|1602373684|L|780|1 CryptoFrame[0,719] client | 48:12.725 - unsupported transport parameter 0x2ab2, size 0 (grease-quic-bit) client | 48:12.727 Version negotiation resulted in changing version from v1 to v2 client | >- CryptoStream[H|Finished] client | 48:12.756 -> Packet H|0|L|90|1 CryptoFrame[0,36] client | -< CryptoStream[H|EncryptedExtensions,Certificate,CertificateVerify,Finished] client | 48:12.762 -> Packet H|1|L|63|1 AckFrame[1602373684|?0] client | 48:12.668 <- (1) Packet A|1602373684|S0|7e751eee3f2842e9|230|2 NewConnectionIdFrame[1,<0|be204f7f0ba8c91cdb64ffaa0c09302f5387|1c7f5e534bf5178041717e5493af6e40] Padding(163) client | 48:12.772 -> Packet A|0|S0|2a684b93f76f6638bde6d339b5cc7d651288|67|1 StreamFrame[0(CIB),0,27,fin] client | 48:12.790 <- (2) Packet A|1602373685|S0|7e751eee3f2842e9|1406|2 PingFrame[] Padding(1376) client | 48:12.790 <- (3) Packet A|1602373686|S0|7e751eee3f2842e9|1200|4 HandshakeDoneFrame[] NewTokenFrame[36e12a694cfd5026c1067f629eb07d42a7ec394114d2958d0f0b875ae3c15877713328bb0356a9cd7f] CryptoFrame[0,237] Padding(886) client | 48:12.793 -> Packet A|1|S0|2a684b93f76f6638bde6d339b5cc7d651288|49|1 AckFrame[1602373685-1602373684|?9] client | -< CryptoStream[A|NewSessionTicket] client | 48:12.806 <- (4) Packet A|1602373687|S0|7e751eee3f2842e9|1200|2 StreamFrame[0(CIB),0,1024,fin] Padding(143) client | 48:12.808 -> Packet A|2|S0|2a684b93f76f6638bde6d339b5cc7d651288|49|1 AckFrame[1602373687-1602373684|?9] client | Get requested finished in 0.34 sec (0.00 MB/s). client | 48:12.815 Closing ClientConnection[da90f0d143500bde/7e751eee3f2842e9(V2) with server4/193.167.100.100:443] (reason: ImmediateClose) client | 48:12.816 <- (5) Packet A|1602373688|S0|7e751eee3f2842e9|40|2 AckFrame[0|?10] Padding(5) client | 48:12.817 -> Packet A|3|S0|2a684b93f76f6638bde6d339b5cc7d651288|44|2 ConnectionCloseFrame[0|0|] ConnectionCloseFrame[0|0|] client | 48:12.826 <- (6) Packet A|1602373689|S0|7e751eee3f2842e9|1444|2 PingFrame[] Padding(1417) client | 48:12.827 -> Packet A|4|S0|2a684b93f76f6638bde6d339b5cc7d651288|40|1 ConnectionCloseFrame[0|0|] client | 48:12.840 <- (7) Packet A|1602373690|S0|7e751eee3f2842e9|1406|2 MaxStreamsFrame[B,101] Padding(1377) client | Terminating Kwik 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-12-13 08:48:24,353 Using the client's key log file. 2025-12-13 08:48:24,366 2025-12-13 08:48:24,367 Using the client's key log file. 2025-12-13 08:48:24,367 Using the client's key log file. 2025-12-13 08:48:24,379 2025-12-13 08:48:24,379 Using the client's key log file. 2025-12-13 08:48:25,271 Check of downloaded files succeeded.