2025-04-30 10:30:04,338 Generated random file: qokxwaequv of size: 10240 2025-04-30 10:30:04,338 Requests: https://server4:443/qokxwaequv 2025-04-30 10:30:04,398 2025-04-30 10:30:04,398 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_tt3rvak_/ TESTCASE_SERVER=retry TESTCASE_CLIENT=retry WWW=/tmp/www_nnb26hsv/ DOWNLOADS=/tmp/download_lbprvw87/ SERVER_LOGS=/tmp/logs_server_6af37yk7 CLIENT_LOGS=/tmp/logs_client_e6_u3xnj SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=peterdoornbosch/kwik_n_flupke-interop SERVER=martenseemann/quic-go-interop:latest REQUESTS="https://server4:443/qokxwaequv" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 10:30:18,457 Container sim Created Container server Recreate Container client Recreate Container client Recreated Container server 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 server | Using commit: e4bb2dbd5557c9417b30cf9fcd9032fd6fea5366 server | Running QUIC server. client | Certificate was added to keystore client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 1.049044875s 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 | 30:06.615 Creating connection with server4:443 with v1 client | 30:06.702 Original destination connection id: 15dfd66563b63555 (scid: 0b0ad9b0f6781b1a) client | >- CryptoStream[I|ClientHello] client | 30:06.858 -> Packet I|0|L|1200|2 Token=[] CryptoFrame[0,257] Padding(896) client | 30:06.896 <- (1) Packet I|-|R|133| Retry Token (98): 8631b35c104d4aabb0475db531e25ef11b439b5ff6b54177da1cf603229856fab97118c0e5210d45551063d61fea30f9d79072e22c0e702c9f1640ec3d8fe80cddaea7b063bc16f554f96ee7dca168efb6f638a556b8a682f4f609db15d40ffae45a client | 30:06.921 -> Packet I|1|L|1201|2 Token=8631b35c104d4aabb0475db531e25ef11b439b5ff6b54177da1cf603229856fab97118c0e5210d45551063d61fea30f9d79072e22c0e702c9f1640ec3d8fe80cddaea7b063bc16f554f96ee7dca168efb6f638a556b8a682f4f609db15d40ffae45a CryptoFrame[0,257] Padding(802) client | 30:06.955 <- (2) Packet I|0|L|478|3 Token=[] AckFrame[1|?0] Padding(306) CryptoFrame[0,123] client | -< CryptoStream[I|ServerHello] client | 30:06.986 -> Packet I|2|L|1202|2 Token=8631b35c104d4aabb0475db531e25ef11b439b5ff6b54177da1cf603229856fab97118c0e5210d45551063d61fea30f9d79072e22c0e702c9f1640ec3d8fe80cddaea7b063bc16f554f96ee7dca168efb6f638a556b8a682f4f609db15d40ffae45a AckFrame[0|?0] Padding(1059) client | 30:06.955 <- (2) Packet H|0|L|751|1 CryptoFrame[0,708] client | 30:07.002 - unknown transport parameter 0x058e, size 3 client | >- CryptoStream[H|Finished] client | 30:07.030 -> Packet H|0|L|76|1 CryptoFrame[0,36] client | -< CryptoStream[H|EncryptedExtensions,Certificate,CertificateVerify,Finished] client | 30:07.034 -> Packet H|1|L|42|1 AckFrame[0|?0] client | 30:06.955 <- (2) Packet A|0|S0|0b0ad9b0f6781b1a|51|1 NewConnectionIdFrame[1,<0|ab36686d|c229458dcbd4e7d7d5cc1bdfd8a4d001] client | 30:07.047 -> Packet A|0|S0|064fcf2c|43|1 StreamFrame[0(CIB),0,17,fin] client | 30:07.063 -> Packet A|1|S0|064fcf2c|28|1 AckFrame[0|?20] client | 30:07.062 <- (3) Packet A|1|S0|0b0ad9b0f6781b1a|259|3 NewTokenFrame[558ffad732e34a98044c35a4b8c7eeffe55eb079f0058941fe980bb0cfb21431bd95482c1fe0b35f7dfa6a54643ff1c993f351ecd467f8eeb9d93da7f7cc68ca5e26907e54ac7249e494e7e93030bcfbea17971620dc] CryptoFrame[0,138] HandshakeDoneFrame[] client | -< CryptoStream[A|NewSessionTicket] client | 30:07.078 <- (4) Packet A|2|S0|0b0ad9b0f6781b1a|32|1 AckFrame[0|?0] client | 30:07.079 <- (5) Packet A|3|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),0,1251] client | 30:07.081 <- (6) Packet A|4|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),1251,1249] client | 30:07.082 <- (7) Packet A|5|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),2500,1249] client | 30:07.081 -> Packet A|2|S0|064fcf2c|28|1 AckFrame[3-0|?13] client | 30:07.083 -> Packet A|3|S0|064fcf2c|28|1 AckFrame[5-0|?1] client | 30:07.083 <- (8) Packet A|6|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),3749,1249] client | 30:07.084 <- (9) Packet A|7|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),4998,1249] client | 30:07.085 -> Packet A|4|S0|064fcf2c|27|1 AckFrame[7-0|?0] client | 30:07.085 <- (10) Packet A|8|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),6247,1249] client | 30:07.086 <- (11) Packet A|9|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),7496,1249] client | 30:07.087 <- (12) Packet A|10|S0|0b0ad9b0f6781b1a|1280|1 StreamFrame[0(CIB),8745,1249] client | 30:07.089 -> Packet A|5|S0|064fcf2c|28|1 AckFrame[9-0|?2] client | 30:07.087 <- (13) Packet A|11|S0|0b0ad9b0f6781b1a|277|1 StreamFrame[0(CIB),9994,246] client | 30:07.090 -> Packet A|6|S0|064fcf2c|27|1 AckFrame[11-0|?0] client | 30:07.087 <- (14) Packet A|12|S0|0b0ad9b0f6781b1a|31|1 StreamFrame[0(CIB),10240,0,fin] client | Get requested finished in 0.39 sec (0.03 MB/s) : tech.kwik.h09.client.HttpResponseImpl@2ddc8ecb client | 30:07.097 Closing ClientConnection[15dfd66563b63555/0b0ad9b0f6781b1a(V1) with server4/193.167.100.100:443] (reason: ImmediateClose) client | 30:07.099 -> Packet A|7|S0|064fcf2c|32|2 ConnectionCloseFrame[0|0|] AckFrame[12-0|?8] 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-04-30 10:30:18,552 Using the server's key log file. 2025-04-30 10:30:18,561 2025-04-30 10:30:18,562 Using the server's key log file. 2025-04-30 10:30:18,562 Using the server's key log file. 2025-04-30 10:30:18,570 2025-04-30 10:30:18,570 Using the server's key log file. 2025-04-30 10:30:19,126 Check of downloaded files succeeded. 2025-04-30 10:30:19,687 Check of Retry succeeded. Token used: 8631b35c104d4aabb0475db531e25ef11b439b5ff6b54177da1cf603229856fab97118c0e5210d45551063d61fea30f9d79072e22c0e702c9f1640ec3d8fe80cddaea7b063bc16f554f96ee7dca168efb6f638a556b8a682f4f609db15d40ffae45a