2025-04-30 11:57:12,503 Generated random file: toezsjcznb of size: 5120
2025-04-30 11:57:12,504 Requests: https://server4:443/toezsjcznb
2025-04-30 11:57:12,884 
2025-04-30 11:57:12,885 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_v1ow4_aa/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_kkzs3w_u/ DOWNLOADS=/tmp/download_wb89h7n9/ SERVER_LOGS=/tmp/logs_server_0ivjwca6 CLIENT_LOGS=/tmp/logs_client_vy3_8cty SCENARIO="droplist --delay=15ms --bandwidth=10Mbps --queue=25 --drops_to_server=2,3,4,5,6,7" CLIENT=ghcr.io/mozilla/neqo-qns:latest SERVER=martenseemann/quic-go-interop:latest REQUESTS="https://server4:443/toezsjcznb"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 11:57:54,948  Container sim  Recreate
 Container sim  Recreated
 Container server  Recreate
 Container client  Recreate
 Container server  Recreated
 Container client  Recreated
Attaching to client, server, sim
sim     | waiting 10s for server:443
server  | Setting up routes...
client  | 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
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  | Endpoint's IPv4 address is 193.167.100.100
client  | Endpoint's IPv4 address is 193.167.0.100
server  | Endpoint's IPv6 address is fd00:cafe:cafe:100::100
client  | Endpoint's IPv6 address is fd00:cafe:cafe::100
client  | + export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/neqo/bin
client  | + PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/neqo/bin
client  | + '[' -n transfer ']'
client  | + '[' -n /logs/qlog/ ']'
client  | + case "$ROLE" in
client  | + /wait-for-it.sh sim:57832 -s -t 30
server  | Using commit: e4bb2dbd5557c9417b30cf9fcd9032fd6fea5366
server  | Running QUIC server.
client  | wait-for-it.sh: waiting 30 seconds for sim:57832
sim     | server:443 is available after 1.043017893s
sim     | Using scenario: droplist --delay=15ms --bandwidth=10Mbps --queue=25 --drops_to_server=2,3,4,5,6,7
sim     | tcpdump: tcpdump: listening on eth0listening on eth1, link-type EN10MB (Ethernet), link-type EN10MB (Ethernet), snapshot length 262144 bytes
sim     | , snapshot length 262144 bytes
client  | wait-for-it.sh: sim:57832 is available after 1 seconds
client  | + OPTIONS=(--cc cubic --qns-test "$TESTCASE" --qlog-dir "$QLOGDIR" --output-dir /downloads)
client  | + '[' https://server4:443/toezsjcznb ']'
client  | + mapfile -d ' ' -t URLS
client  | + OPTIONS+=("${URLS[@]}")
client  | + RUST_LOG=debug
client  | + RUST_BACKTRACE=1
client  | + neqo-client --cc cubic --qns-test transfer --qlog-dir /logs/qlog/ --output-dir /downloads 'https://server4:443/toezsjcznb
client  | '
client  | ++ tee -i -a /logs/client.log
client  | 0.000 DEBUG Logging initialized
client  | 0.001 DEBUG Default socket send buffer size is 212992
client  | 0.001 DEBUG Default socket receive buffer size is 1048576, not changing
client  | 0.001 INFO hq-interop Client connecting: 0.0.0.0:59883 -> 193.167.100.100:443
client  | 0.001 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Client dcid=aaf754ad0f01f43f
client  | 0.001 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
client  | 0.001 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
client  | 0.001 DEBUG Outbound interface eth0 for destination 193.167.100.100 has MTU 1500
client  | 0.001 DEBUG [unv-path 0.0.0.0:59883->193.167.100.100:443] Make permanent
client  | 0.001 DEBUG [unv-path:aaf754ad0f01f43f 0.0.0.0:59883->193.167.100.100:443] set as primary path
client  | 0.001 DEBUG [pri-unv-path:aaf754ad0f01f43f 0.0.0.0:59883->193.167.100.100:443] Path validated Instant { tv_sec: 397, tv_nsec: 849725743 }
client  | 0.001 DEBUG [Client aaf754ad0f01f43f] client_start
client  | 0.002 DEBUG Writing transport parameters, msg=1
client  | 0.002 DEBUG [Agent 0x5577eeed3270] state -> InProgress
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] State change from Init -> WaitInitial
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.002 DEBUG Building Initial dcid Some(CID [8]: aaf754ad0f01f43f) scid Some(CID [0]: )
client  | 0.002 DEBUG CRYPTO for in offset=0, len=1213
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] pn=0 type=Initial pri-path:aaf754ad0f01f43f 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 1252
client  |   TX -> Crypto { offset: 0, len: 1213 }
client  | 0.002 DEBUG packet_sent this=0x5577eeee6970, pn=0, ps=1252
client  | 0.002 DEBUG ECN probing: sent 1 probes
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.002 DEBUG Building Initial dcid Some(CID [8]: aaf754ad0f01f43f) scid Some(CID [0]: )
client  | 0.002 DEBUG CRYPTO for in offset=1213, len=326
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] pn=1 type=Initial pri-path:aaf754ad0f01f43f 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 366
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] pad Initial from 366 to PLPMTU 1252
client  | 0.002 DEBUG packet_sent this=0x5577eeee6970, pn=1, ps=1252
client  | 0.002 DEBUG ECN probing: sent 2 probes
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 0.002 DEBUG Building Initial dcid Some(CID [8]: aaf754ad0f01f43f) scid Some(CID [0]: )
client  | 0.002 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] delay duration 3.829562ms
client  | 0.002 DEBUG Setting timeout of 3.829562ms
client  | 0.002 DEBUG StateChange(WaitInitial)
client  | 0.002 WARN Cannot create stream ConnectionState
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 0.002 DEBUG Building Initial dcid Some(CID [8]: aaf754ad0f01f43f) scid Some(CID [0]: )
client  | 0.002 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 0.002 DEBUG [Client aaf754ad0f01f43f] delay duration 3.802321ms
client  | 0.002 DEBUG Setting timeout of 3.802321ms
client  | 0.007 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.007 DEBUG Building Initial dcid Some(CID [8]: aaf754ad0f01f43f) scid Some(CID [0]: )
client  | 0.007 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.007 DEBUG [Client aaf754ad0f01f43f] delay duration 294.81155ms
client  | 0.007 DEBUG Setting timeout of 294.81155ms
sim     | Dropping packet 2 (1252 bytes) from 193.167.0.100
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] pn=0 type=Initial pri-path:aaf754ad0f01f43f 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, NotEct) len 40
client  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] Rx ACK space=in, ranges=[0..=0]
client  | 0.039 DEBUG [LossRecovery] ACK for Initial - largest_acked=0
client  | 0.039 DEBUG on_packets_acked this=0x5577eeee6970, limited=1, bytes_in_flight=1252, cwnd=12520, state=SlowStart, new_acked=1252
client  | 0.039 DEBUG Acked crypto frame space=in offset=0 length=1213
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] Changing to use Server CID=a1432147
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] State change from WaitInitial -> WaitVersion
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.039 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.039 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] delay duration 76.064451ms
client  | 0.039 DEBUG Setting timeout of 76.064451ms
client  | 0.039 WARN Unhandled event StateChange(WaitVersion)
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.039 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.039 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.039 DEBUG [Client aaf754ad0f01f43f] delay duration 76.034454ms
client  | 0.039 DEBUG Setting timeout of 76.034454ms
client  | 0.116 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 0.116 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 0.116 INFO Lost crypto frame space=in offset=1213 length=326
client  | 0.116 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 0.116 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 0.116 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.116 DEBUG CRYPTO for in offset=1213, len=326
client  | 0.116 DEBUG [Client aaf754ad0f01f43f] pn=2 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 0.116 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 0.116 DEBUG packet_sent this=0x5577eeee6970, pn=2, ps=1252
client  | 0.116 DEBUG ECN probing: sent 3 probes
client  | 0.117 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.117 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.117 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.117 DEBUG [Client aaf754ad0f01f43f] delay duration 226.607673ms
client  | 0.117 DEBUG Setting timeout of 226.607673ms
sim     | Dropping packet 3 (1252 bytes) from 193.167.0.100
client  | 0.344 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 0.344 INFO Lost crypto frame space=in offset=1213 length=326
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 0.344 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.344 DEBUG CRYPTO for in offset=1213, len=326
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] pn=3 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 0.344 DEBUG packet_sent this=0x5577eeee6970, pn=3, ps=1252
client  | 0.344 DEBUG ECN probing: sent 4 probes
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.344 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.344 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.344 DEBUG [Client aaf754ad0f01f43f] delay duration 453.421752ms
client  | 0.344 DEBUG Setting timeout of 453.421752ms
sim     | Dropping packet 4 (1252 bytes) from 193.167.0.100
client  | 0.799 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 0.799 INFO Lost crypto frame space=in offset=1213 length=326
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 0.799 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.799 DEBUG CRYPTO for in offset=1213, len=326
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] pn=4 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 0.799 DEBUG packet_sent this=0x5577eeee6970, pn=4, ps=1252
client  | 0.799 DEBUG ECN probing: sent 5 probes
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.799 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 0.799 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.799 DEBUG [Client aaf754ad0f01f43f] delay duration 907.099004ms
client  | 0.799 DEBUG Setting timeout of 907.099004ms
sim     | Dropping packet 5 (1252 bytes) from 193.167.0.100
client  | 1.707 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 1.707 INFO Lost crypto frame space=in offset=1213 length=326
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 1.707 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 1.707 DEBUG CRYPTO for in offset=1213, len=326
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] pn=5 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 1.707 DEBUG packet_sent this=0x5577eeee6970, pn=5, ps=1252
client  | 1.707 DEBUG ECN probing: sent 6 probes
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 1.707 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 1.707 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 1.707 DEBUG [Client aaf754ad0f01f43f] delay duration 1.814393764s
client  | 1.707 DEBUG Setting timeout of 1.814393764s
sim     | Dropping packet 6 (1252 bytes) from 193.167.0.100
client  | 3.523 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 3.523 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 3.523 INFO Lost crypto frame space=in offset=1213 length=326
client  | 3.523 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 3.523 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 3.523 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 3.523 DEBUG CRYPTO for in offset=1213, len=326
client  | 3.523 DEBUG [Client aaf754ad0f01f43f] pn=6 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 3.523 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 3.523 DEBUG packet_sent this=0x5577eeee6970, pn=6, ps=1252
client  | 3.523 DEBUG ECN probing: sent 7 probes
client  | 3.524 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 3.524 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 3.524 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 3.524 DEBUG [Client aaf754ad0f01f43f] delay duration 3.629040871s
client  | 3.524 DEBUG Setting timeout of 3.629040871s
sim     | Dropping packet 7 (1252 bytes) from 193.167.0.100
client  | 7.154 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 7.154 INFO Lost crypto frame space=in offset=1213 length=326
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 7.154 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 7.154 DEBUG CRYPTO for in offset=1213, len=326
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] pn=7 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 7.154 DEBUG packet_sent this=0x5577eeee6970, pn=7, ps=1252
client  | 7.154 DEBUG ECN probing: sent 8 probes
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 7.154 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 7.154 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 7.154 DEBUG [Client aaf754ad0f01f43f] delay duration 7.258261129s
client  | 7.154 DEBUG Setting timeout of 7.258261129s
client  | 14.414 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 14.414 INFO Lost crypto frame space=in offset=1213 length=326
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 14.414 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 14.414 DEBUG CRYPTO for in offset=1213, len=326
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] pn=8 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 14.414 DEBUG packet_sent this=0x5577eeee6970, pn=8, ps=1252
client  | 14.414 DEBUG ECN probing: sent 9 probes
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 14.414 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 14.414 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 14.414 DEBUG [Client aaf754ad0f01f43f] delay duration 14.516738755s
client  | 14.414 DEBUG Setting timeout of 14.516738755s
client  | 28.932 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 28.932 DEBUG [Client aaf754ad0f01f43f] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1213, length: 326 })
client  | 28.932 INFO Lost crypto frame space=in offset=1213 length=326
client  | 28.932 DEBUG [Client aaf754ad0f01f43f] Lost: EcnEct0
client  | 28.932 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 28.932 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 28.932 DEBUG CRYPTO for in offset=1213, len=326
client  | 28.932 DEBUG [Client aaf754ad0f01f43f] pn=9 type=Initial pri-path:a1432147 0.0.0.0:59883->193.167.100.100:443 IpTos(Cs0, Ect0) len 362
client  |   TX -> Crypto { offset: 1213, len: 326 }
client  | 28.932 DEBUG [Client aaf754ad0f01f43f] pad Initial from 362 to PLPMTU 1252
client  | 28.932 DEBUG packet_sent this=0x5577eeee6970, pn=9, ps=1252
client  | 28.932 DEBUG ECN probing: sent 10 probes
client  | 28.932 DEBUG ECN probing concluded with 10 probes sent
client  | 28.933 DEBUG [Client aaf754ad0f01f43f] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 28.933 DEBUG Building Initial dcid Some(CID [4]: a1432147) scid Some(CID [0]: )
client  | 28.933 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 28.933 DEBUG [Client aaf754ad0f01f43f] delay duration 1.183771589s
client  | 28.933 DEBUG Setting timeout of 1.183771589s
client  | 30.118 INFO [Client aaf754ad0f01f43f] idle timeout expired
client  | 30.118 DEBUG [Client aaf754ad0f01f43f] State change from WaitVersion -> Closed(Transport(IdleTimeout))
client  | 30.118 DEBUG Output::None
client  | 30.118 WARN Unhandled event StateChange(Closed(Transport(IdleTimeout)))
client  | 30.118 DEBUG Timer fired while closed
client  | 30.118 DEBUG Output::None
client  | Error: TransportError(IdleTimeout)

client exited with code 1
Aborting on container exit...
 Container server  Stopping
 Container client  Stopping
 Container client  Stopped
 Container server  Stopped
 Container sim  Stopping
 Container sim  Stopped