2025-12-13 10:30:10,611 Generated random file: intense-pleased-elephant of size: 10485760 2025-12-13 10:30:10,611 Requests: https://server4:443/intense-pleased-elephant 2025-12-13 10:30:10,670 2025-12-13 10:30:10,671 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_vrvrsst4/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_kexpqzjy/ DOWNLOADS=/tmp/download_ifmgrvjs/ SERVER_LOGS=/tmp/logs_server_zekvd9u3 CLIENT_LOGS=/tmp/logs_client_0ksruiz5 SCENARIO="rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr" CLIENT=ghcr.io/microsoft/msquic/qns:main SERVER=cloudflare/quiche-qns:latest REQUESTS="https://server4:443/intense-pleased-elephant" docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 2025-12-13 10:30:58,511 Container sim Recreate Container sim Recreated 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-checksumming: off client | tx-checksum-ip-generic: off client | tx-checksum-sctp: off client | tcp-segmentation-offload: off client | tx-tcp-segmentation: off [requested on] client | tx-tcp-ecn-segmentation: off [requested on] client | tx-tcp-mangleid-segmentation: off [requested on] client | tx-tcp6-segmentation: off [requested on] client | tx-udp-segmentation: off [requested on] 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 | supported server | ## Starting quiche server... server | ## Server params: server | ## Test case: transfer client | wait-for-it.sh: waiting 30 seconds for sim:57832 sim | server:443 is available after 501.260359ms sim | Using scenario: rebind --delay=15ms --bandwidth=10Mbps --queue=25 --first-rebind=1s --rebind-freq=5s --rebind-addr sim | Capturing on 'eth0' sim | Capturing on 'eth1' sim | File: /logs/trace_node_right.pcap sim | File: /logs/trace_node_left.pcap sim | 0s: first rebind in 1s, frequency 5s client | wait-for-it.sh: sim:57832 is available after 1 seconds client | Connecting to server4 client | Client params (before files):-test:D -timeout:50000 -sslkeylogfile:/logs/keys.log client | Sending request: GET /intense-pleased-elephant client | intense-pleased-elephant: Wrote 1320 bytes.(0 ms/0 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(1 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(2 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(3 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(4 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(5 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(6 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(7 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(8 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 755 bytes.(9 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(31 ms/22 ms/21 ms) client | intense-pleased-elephant: Wrote 1326 bytes.(32 ms/1 ms/-21 ms) client | intense-pleased-elephant: Wrote 547 bytes.(33 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1320 bytes.(34 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(35 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(36 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(37 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(38 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(40 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(41 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(42 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(43 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(44 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(45 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(46 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(47 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(48 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(50 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(51 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(63 ms/12 ms/11 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(64 ms/1 ms/-11 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(65 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 753 bytes.(66 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(67 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(68 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 545 bytes.(69 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(70 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(71 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(72 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(73 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(74 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(75 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(76 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(77 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(78 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(80 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(81 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(82 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(83 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(84 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(85 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(86 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(87 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(88 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(90 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(91 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(92 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(93 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(94 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(95 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(96 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(97 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(98 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(99 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(101 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(102 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(103 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(104 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(105 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(106 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(107 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(108 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(109 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(111 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(112 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 753 bytes.(112 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(113 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(114 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(116 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(117 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 537 bytes.(117 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(118 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(119 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(120 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(122 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(123 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(124 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(125 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(126 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(127 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(128 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(129 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(130 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(132 ms/2 ms/1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(133 ms/1 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(134 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(135 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1316 bytes.(136 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(137 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(138 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 5288 bytes.(200 ms/62 ms/61 ms) client | intense-pleased-elephant: Wrote 3964 bytes.(202 ms/2 ms/-60 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(204 ms/2 ms/0 ms) client | intense-pleased-elephant: Wrote 514 bytes.(204 ms/0 ms/-2 ms) client | intense-pleased-elephant: Wrote 3450 bytes.(205 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 9252 bytes.(260 ms/55 ms/54 ms) client | intense-pleased-elephant: Wrote 10576 bytes.(263 ms/3 ms/-52 ms) client | intense-pleased-elephant: Wrote 9252 bytes.(265 ms/2 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(268 ms/3 ms/1 ms) client | intense-pleased-elephant: Wrote 5290 bytes.(269 ms/1 ms/-2 ms) client | intense-pleased-elephant: Wrote 312 bytes.(269 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 3654 bytes.(270 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 826 bytes.(270 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 9754 bytes.(271 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 58290 bytes.(272 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 2684 bytes.(275 ms/3 ms/2 ms) client | intense-pleased-elephant: Wrote 2648 bytes.(277 ms/2 ms/-1 ms) client | intense-pleased-elephant: Wrote 3972 bytes.(279 ms/2 ms/0 ms) client | intense-pleased-elephant: Wrote 10592 bytes.(281 ms/2 ms/0 ms) client | intense-pleased-elephant: Wrote 2648 bytes.(289 ms/8 ms/6 ms) client | intense-pleased-elephant: Wrote 2648 bytes.(292 ms/3 ms/-5 ms) client | intense-pleased-elephant: Wrote 2648 bytes.(294 ms/2 ms/-1 ms) client | intense-pleased-elephant: Wrote 2648 bytes.(297 ms/3 ms/1 ms) client | intense-pleased-elephant: Wrote 3966 bytes.(300 ms/3 ms/0 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(305 ms/5 ms/2 ms) client | intense-pleased-elephant: Wrote 3265 bytes.(305 ms/0 ms/-5 ms) client | intense-pleased-elephant: Wrote 7190 bytes.(308 ms/3 ms/3 ms) client | intense-pleased-elephant: Wrote 39616 bytes.(314 ms/6 ms/3 ms) client | intense-pleased-elephant: Wrote 674 bytes.(315 ms/1 ms/-5 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(316 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 904 bytes.(317 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(318 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 114 bytes.(318 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(319 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(320 ms/1 ms/0 ms) client | intense-pleased-elephant: Wrote 114 bytes.(320 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(322 ms/2 ms/2 ms) client | intense-pleased-elephant: Wrote 352 bytes.(322 ms/0 ms/-2 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(323 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 21 bytes.(323 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 1318 bytes.(324 ms/1 ms/1 ms) client | intense-pleased-elephant: Wrote 36 bytes.(324 ms/0 ms/-1 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(325 ms/1 ms/1 ms) sim | Packets: 1 Packets: 1 Packets: 5 Packets: 4 Packets: 10 Packets: 11 Packets: 32 Packets: 53 Packets: 259 1s: rebinding: 193.167.0.100:52761 -> 193.167.0.224:59022 sim | 1.0006s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00146s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00256s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00269s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00379s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00436s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00546s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00603s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00713s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00823s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.00934s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01044s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.011s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01211s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01267s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01378s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01488s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01598s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01655s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01766s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01875s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.01986s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02042s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02153s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02166s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02276s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02322s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02432s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02478s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02589s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02666s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02777s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02812s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02922s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.02952s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.03063s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.03078s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.0317s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.03281s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.03357s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.03468s: unknown binding for destination 193.167.0.100:52761, dropping packet sim | 1.03481s: unknown binding for destination 193.167.0.100:52761, dropping packet client | intense-pleased-elephant: Wrote 6096 bytes.(370 ms/45 ms/44 ms) client | intense-pleased-elephant: Wrote 3304 bytes.(370 ms/0 ms/-45 ms) client | intense-pleased-elephant: Wrote 1324 bytes.(444 ms/74 ms/74 ms) client | intense-pleased-elephant: Wrote 1017 bytes.(549 ms/105 ms/31 ms) sim | Packets: 317 Packets: 578 Packets: 634 Packets: 845 Packets: 916 Packets: 1140 Packets: 1233 Packets: 1419 Packets: 1257 Packets: 1420 Packets: 1261 Packets: 1421 Packets: 1422 6s: rebinding: 193.167.0.224:59022 -> 193.167.0.71:39968 sim | Packets: 1263 11s: rebinding: 193.167.0.71:39968 -> 193.167.0.3:38910 sim | Packets: 1423 Packets: 1424 Packets: 1264 Packets: 1265 16s: rebinding: 193.167.0.3:38910 -> 193.167.0.250:19495 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 | Packets: 1425 Packets: 1426 31s: rebinding: 193.167.0.217:46157 -> 193.167.0.105:33243 client | intense-pleased-elephant: Request closed incomplete. (30851 ms) client | client | TARGET VHDCRZSQUMBGA2E VERSION ALPN client | ============================================ client | server4 --------------- client | client | Total execution time: 30.930s client | sim | Packets: 1266 Packets: 1267 36s: rebinding: 193.167.0.105:33243 -> 193.167.0.60:32217 client | Client complete. client | Script complete. 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 10:30:58,609 Using the client's key log file. 2025-12-13 10:30:58,623 2025-12-13 10:30:58,624 Using the client's key log file. 2025-12-13 10:30:58,624 Using the client's key log file. 2025-12-13 10:30:58,636 2025-12-13 10:30:58,638 Using the client's key log file. 2025-12-13 10:30:59,120 Missing files: ['intense-pleased-elephant'] 2025-12-13 10:30:59,120 Using the client's key log file. 2025-12-13 10:30:59,601 Missing files: ['intense-pleased-elephant'] 2025-12-13 10:30:59,601 Using the client's key log file. 2025-12-13 10:31:02,496 Server saw these client addresses: {'193.167.0.224', '193.167.0.100'} 2025-12-13 10:31:02,982 Missing files: ['intense-pleased-elephant'] 2025-12-13 10:31:02,982 Using the client's key log file. 2025-12-13 10:31:03,470 Missing files: ['intense-pleased-elephant']