2025-04-30 11:20:47,121 Generated random file: dbvnakykwp of size: 10485760 2025-04-30 11:20:47,121 Requests: https://server4:443/dbvnakykwp 2025-04-30 11:20:47,182 2025-04-30 11:20:47,183 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_uuwcc0r4/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_ye09rf2o/ DOWNLOADS=/tmp/download_gy32dnt_/ SERVER_LOGS=/tmp/logs_server_6fk8d7_o CLIENT_LOGS=/tmp/logs_client_j3xbpj1o SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr" CLIENT=ghcr.io/ngtcp2/ngtcp2-interop:latest SERVER=peterdoornbosch/kwik_n_flupke-interop REQUESTS="https://server4:443/dbvnakykwp" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-04-30 11:21:30,052 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 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 server | Importing keystore /server.p12 to /server.keystore... server | running kwik server version 0.10.2 server | Old Flupke plugin not found sim | server:443 is available after 1.02602374s sim | Using scenario: rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr 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 sim | 0s: first rebind in 1s, frequency 5s client | wait-for-it.sh: sim:57832 is available after 1 seconds sim | 1s: rebinding: 193.167.0.100:55766 -> 193.167.0.224:59022 sim | 1.00075s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00178s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.0028s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00383s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00485s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00588s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.0069s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00793s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00896s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.00998s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01101s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01203s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01306s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01408s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01511s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01614s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01716s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01819s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.01921s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02024s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02126s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02229s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02331s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02395s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02497s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.026s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02702s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02805s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.02907s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.0301s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.03113s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.03215s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.09601s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.24972s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.25074s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.55835s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 1.55937s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 2.17498s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 2.17599s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 3.4075s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 3.40852s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 5.87218s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 5.87319s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 6s: rebinding: 193.167.0.224:59022 -> 193.167.0.71:39968 sim | 10.8007s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 10.8018s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 11s: rebinding: 193.167.0.71:39968 -> 193.167.0.3:38910 sim | 16s: rebinding: 193.167.0.3:38910 -> 193.167.0.250:19495 sim | 20.6574s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 20.6585s: unknown binding for destination 193.167.0.100:55766, dropping packet sim | 21s: rebinding: 193.167.0.250:19495 -> 193.167.0.200:28302 sim | 26s: rebinding: 193.167.0.200:28302 -> 193.167.0.217:46157 sim | 31s: rebinding: 193.167.0.217:46157 -> 193.167.0.105:33243 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:21:30,160 Using the client's key log file. 2025-04-30 11:21:30,173 2025-04-30 11:21:30,174 Using the client's key log file. 2025-04-30 11:21:30,174 Using the client's key log file. 2025-04-30 11:21:30,186 2025-04-30 11:21:30,188 Using the client's key log file. 2025-04-30 11:21:30,793 File size of /tmp/download_gy32dnt_/dbvnakykwp doesn't match. Original: 10485760 bytes, downloaded: 451638 bytes. 2025-04-30 11:21:30,793 Using the client's key log file. 2025-04-30 11:21:31,397 File size of /tmp/download_gy32dnt_/dbvnakykwp doesn't match. Original: 10485760 bytes, downloaded: 451638 bytes. 2025-04-30 11:21:31,397 Using the client's key log file. 2025-04-30 11:21:33,224 Server saw these client addresses: {'193.167.0.100'} 2025-04-30 11:21:33,225 Server saw only a single client IP address in use; test broken?