2025-04-30 11:20:28,648 Generated random file: deftpblrdl of size: 1024
2025-04-30 11:20:28,649 Generated random file: hkpokirzvx of size: 1024
2025-04-30 11:20:28,649 Generated random file: bcbvaiwwem of size: 1024
2025-04-30 11:20:28,649 Generated random file: kxcaialzcz of size: 1024
2025-04-30 11:20:28,649 Generated random file: wcpfhtytnm of size: 1024
2025-04-30 11:20:28,649 Generated random file: hcquoxgrig of size: 1024
2025-04-30 11:20:28,649 Generated random file: agqobphvkc of size: 1024
2025-04-30 11:20:28,649 Generated random file: ayrnbkvxsj of size: 1024
2025-04-30 11:20:28,649 Generated random file: cwcsvzhqmw of size: 1024
2025-04-30 11:20:28,650 Generated random file: ilzkzodllv of size: 1024
2025-04-30 11:20:28,650 Generated random file: sclebaifxl of size: 1024
2025-04-30 11:20:28,650 Generated random file: inwejfxblv of size: 1024
2025-04-30 11:20:28,650 Generated random file: wtxzrdkpdt of size: 1024
2025-04-30 11:20:28,650 Generated random file: xsialdjcci of size: 1024
2025-04-30 11:20:28,650 Generated random file: xbbkbcjxcy of size: 1024
2025-04-30 11:20:28,650 Generated random file: zcmjphjdhb of size: 1024
2025-04-30 11:20:28,650 Generated random file: zuvhydsbzg of size: 1024
2025-04-30 11:20:28,651 Generated random file: cpepdonahx of size: 1024
2025-04-30 11:20:28,651 Generated random file: cilssamwhk of size: 1024
2025-04-30 11:20:28,651 Generated random file: cfsuyiijyo of size: 1024
2025-04-30 11:20:28,651 Generated random file: afdduqffoy of size: 1024
2025-04-30 11:20:28,651 Generated random file: aaqdxgglnh of size: 1024
2025-04-30 11:20:28,651 Generated random file: lxbqfiutbr of size: 1024
2025-04-30 11:20:28,651 Generated random file: vbxnopteqn of size: 1024
2025-04-30 11:20:28,651 Generated random file: kpuvpwsbjj of size: 1024
2025-04-30 11:20:28,652 Generated random file: sqdlfotnez of size: 1024
2025-04-30 11:20:28,652 Generated random file: pbwrvwzvdn of size: 1024
2025-04-30 11:20:28,652 Generated random file: psqqwhxssh of size: 1024
2025-04-30 11:20:28,652 Generated random file: tknpkueeuf of size: 1024
2025-04-30 11:20:28,652 Generated random file: juaxrantvx of size: 1024
2025-04-30 11:20:28,652 Generated random file: tquwpvprhy of size: 1024
2025-04-30 11:20:28,652 Generated random file: brznnwvnys of size: 1024
2025-04-30 11:20:28,652 Generated random file: xsobwldzux of size: 1024
2025-04-30 11:20:28,653 Generated random file: aucmuuhcoh of size: 1024
2025-04-30 11:20:28,653 Generated random file: hmxykyprfr of size: 1024
2025-04-30 11:20:28,653 Generated random file: gxjudaeeyu of size: 1024
2025-04-30 11:20:28,653 Generated random file: tklklwjdmr of size: 1024
2025-04-30 11:20:28,653 Generated random file: znxqcoekpb of size: 1024
2025-04-30 11:20:28,653 Generated random file: esorkqesnx of size: 1024
2025-04-30 11:20:28,653 Generated random file: bvowkdckor of size: 1024
2025-04-30 11:20:28,653 Generated random file: nfrkrhexbj of size: 1024
2025-04-30 11:20:28,654 Generated random file: whbkpeyxdy of size: 1024
2025-04-30 11:20:28,654 Generated random file: hgczmmekzr of size: 1024
2025-04-30 11:20:28,654 Generated random file: eybneovweu of size: 1024
2025-04-30 11:20:28,654 Generated random file: sfxyhnchpf of size: 1024
2025-04-30 11:20:28,654 Generated random file: excxvkudnz of size: 1024
2025-04-30 11:20:28,654 Generated random file: dyzosbqdhj of size: 1024
2025-04-30 11:20:28,654 Generated random file: bklyrhuvmi of size: 1024
2025-04-30 11:20:28,654 Generated random file: pbleaynoeo of size: 1024
2025-04-30 11:20:28,654 Generated random file: lxtkvaaegb of size: 1024
2025-04-30 11:20:28,655 Requests: https://server4:443/deftpblrdl https://server4:443/hkpokirzvx https://server4:443/bcbvaiwwem https://server4:443/kxcaialzcz https://server4:443/wcpfhtytnm https://server4:443/hcquoxgrig https://server4:443/agqobphvkc https://server4:443/ayrnbkvxsj https://server4:443/cwcsvzhqmw https://server4:443/ilzkzodllv https://server4:443/sclebaifxl https://server4:443/inwejfxblv https://server4:443/wtxzrdkpdt https://server4:443/xsialdjcci https://server4:443/xbbkbcjxcy https://server4:443/zcmjphjdhb https://server4:443/zuvhydsbzg https://server4:443/cpepdonahx https://server4:443/cilssamwhk https://server4:443/cfsuyiijyo https://server4:443/afdduqffoy https://server4:443/aaqdxgglnh https://server4:443/lxbqfiutbr https://server4:443/vbxnopteqn https://server4:443/kpuvpwsbjj https://server4:443/sqdlfotnez https://server4:443/pbwrvwzvdn https://server4:443/psqqwhxssh https://server4:443/tknpkueeuf https://server4:443/juaxrantvx https://server4:443/tquwpvprhy https://server4:443/brznnwvnys https://server4:443/xsobwldzux https://server4:443/aucmuuhcoh https://server4:443/hmxykyprfr https://server4:443/gxjudaeeyu https://server4:443/tklklwjdmr https://server4:443/znxqcoekpb https://server4:443/esorkqesnx https://server4:443/bvowkdckor https://server4:443/nfrkrhexbj https://server4:443/whbkpeyxdy https://server4:443/hgczmmekzr https://server4:443/eybneovweu https://server4:443/sfxyhnchpf https://server4:443/excxvkudnz https://server4:443/dyzosbqdhj https://server4:443/bklyrhuvmi https://server4:443/pbleaynoeo https://server4:443/lxtkvaaegb
2025-04-30 11:20:28,718 
2025-04-30 11:20:28,719 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_901y0pez/ TESTCASE_SERVER=multiconnect TESTCASE_CLIENT=multiconnect WWW=/tmp/www_lgvfdgyw/ DOWNLOADS=/tmp/download_y6uikbtt/ SERVER_LOGS=/tmp/logs_server_9iw0wrsz CLIENT_LOGS=/tmp/logs_client_s0tusr0o SCENARIO="drop-rate --delay=15ms --bandwidth=10Mbps --queue=25 --rate_to_server=30 --rate_to_client=30 --burst_to_server=3 --burst_to_client=3" CLIENT=ghcr.io/mozilla/neqo-qns:latest SERVER=litespeedtech/lsquic-qir:latest REQUESTS="https://server4:443/deftpblrdl https://server4:443/hkpokirzvx https://server4:443/bcbvaiwwem https://server4:443/kxcaialzcz https://server4:443/wcpfhtytnm https://server4:443/hcquoxgrig https://server4:443/agqobphvkc https://server4:443/ayrnbkvxsj https://server4:443/cwcsvzhqmw https://server4:443/ilzkzodllv https://server4:443/sclebaifxl https://server4:443/inwejfxblv https://server4:443/wtxzrdkpdt https://server4:443/xsialdjcci https://server4:443/xbbkbcjxcy https://server4:443/zcmjphjdhb https://server4:443/zuvhydsbzg https://server4:443/cpepdonahx https://server4:443/cilssamwhk https://server4:443/cfsuyiijyo https://server4:443/afdduqffoy https://server4:443/aaqdxgglnh https://server4:443/lxbqfiutbr https://server4:443/vbxnopteqn https://server4:443/kpuvpwsbjj https://server4:443/sqdlfotnez https://server4:443/pbwrvwzvdn https://server4:443/psqqwhxssh https://server4:443/tknpkueeuf https://server4:443/juaxrantvx https://server4:443/tquwpvprhy https://server4:443/brznnwvnys https://server4:443/xsobwldzux https://server4:443/aucmuuhcoh https://server4:443/hmxykyprfr https://server4:443/gxjudaeeyu https://server4:443/tklklwjdmr https://server4:443/znxqcoekpb https://server4:443/esorkqesnx https://server4:443/bvowkdckor https://server4:443/nfrkrhexbj https://server4:443/whbkpeyxdy https://server4:443/hgczmmekzr https://server4:443/eybneovweu https://server4:443/sfxyhnchpf https://server4:443/excxvkudnz https://server4:443/dyzosbqdhj https://server4:443/bklyrhuvmi https://server4:443/pbleaynoeo https://server4:443/lxtkvaaegb"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 11:23:31,102  Container sim  Recreate
 Container sim  Recreated
 Container client  Recreate
 Container server  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
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 multiconnect ']'
client  | + '[' -n /logs/qlog/ ']'
client  | + case "$ROLE" in
client  | + /wait-for-it.sh sim:57832 -s -t 30
client  | wait-for-it.sh: waiting 30 seconds for sim:57832
server  | Setting up routes...
server  | Actual changes:
server  | tx-checksumming: off
server  | 	tx-checksum-ip-generic: off
server  | 	tx-checksum-sctp: off
server  | tcp-segmentation-offload: off
server  | 	tx-tcp-segmentation: off [requested on]
server  | 	tx-tcp-ecn-segmentation: off [requested on]
server  | 	tx-tcp-mangleid-segmentation: off [requested on]
server  | 	tx-tcp6-segmentation: off [requested on]
server  | tx-udp-segmentation: off [requested on]
server  | Endpoint's IPv4 address is 193.167.100.100
server  | Endpoint's IPv6 address is fd00:cafe:cafe:100::100
server  | TEST_PARAMS:
server  | REQUESTS: ''
server  | paths:
server  | server:
server  | port:
server  | SERVER_PARAMS:
sim     | server:443 is available after 1.030817028s
sim     | Using scenario: drop-rate --delay=15ms --bandwidth=10Mbps --queue=25 --rate_to_server=30 --rate_to_client=30 --burst_to_server=3 --burst_to_client=3
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  | + OPTIONS=(--cc cubic --qns-test "$TESTCASE" --qlog-dir "$QLOGDIR" --output-dir /downloads)
client  | + '[' 'https://server4:443/deftpblrdl https://server4:443/hkpokirzvx https://server4:443/bcbvaiwwem https://server4:443/kxcaialzcz https://server4:443/wcpfhtytnm https://server4:443/hcquoxgrig https://server4:443/agqobphvkc https://server4:443/ayrnbkvxsj https://server4:443/cwcsvzhqmw https://server4:443/ilzkzodllv https://server4:443/sclebaifxl https://server4:443/inwejfxblv https://server4:443/wtxzrdkpdt https://server4:443/xsialdjcci https://server4:443/xbbkbcjxcy https://server4:443/zcmjphjdhb https://server4:443/zuvhydsbzg https://server4:443/cpepdonahx https://server4:443/cilssamwhk https://server4:443/cfsuyiijyo https://server4:443/afdduqffoy https://server4:443/aaqdxgglnh https://server4:443/lxbqfiutbr https://server4:443/vbxnopteqn https://server4:443/kpuvpwsbjj https://server4:443/sqdlfotnez https://server4:443/pbwrvwzvdn https://server4:443/psqqwhxssh https://server4:443/tknpkueeuf https://server4:443/juaxrantvx https://server4:443/tquwpvprhy https://server4:443/brznnwvnys https://server4:443/xsobwldzux https://server4:443/aucmuuhcoh https://server4:443/hmxykyprfr https://server4:443/gxjudaeeyu https://server4:443/tklklwjdmr https://server4:443/znxqcoekpb https://server4:443/esorkqesnx https://server4:443/bvowkdckor https://server4:443/nfrkrhexbj https://server4:443/whbkpeyxdy https://server4:443/hgczmmekzr https://server4:443/eybneovweu https://server4:443/sfxyhnchpf https://server4:443/excxvkudnz https://server4:443/dyzosbqdhj https://server4:443/bklyrhuvmi https://server4:443/pbleaynoeo https://server4:443/lxtkvaaegb' ']'
client  | + mapfile -d ' ' -t URLS
client  | + OPTIONS+=("${URLS[@]}")
client  | + RUST_LOG=debug
client  | + RUST_BACKTRACE=1
client  | + neqo-client --cc cubic --qns-test multiconnect --qlog-dir /logs/qlog/ --output-dir /downloads https://server4:443/deftpblrdl https://server4:443/hkpokirzvx https://server4:443/bcbvaiwwem https://server4:443/kxcaialzcz https://server4:443/wcpfhtytnm https://server4:443/hcquoxgrig https://server4:443/agqobphvkc https://server4:443/ayrnbkvxsj https://server4:443/cwcsvzhqmw https://server4:443/ilzkzodllv https://server4:443/sclebaifxl https://server4:443/inwejfxblv https://server4:443/wtxzrdkpdt https://server4:443/xsialdjcci https://server4:443/xbbkbcjxcy https://server4:443/zcmjphjdhb https://server4:443/zuvhydsbzg https://server4:443/cpepdonahx https://server4:443/cilssamwhk https://server4:443/cfsuyiijyo https://server4:443/afdduqffoy https://server4:443/aaqdxgglnh https://server4:443/lxbqfiutbr https://server4:443/vbxnopteqn https://server4:443/kpuvpwsbjj https://server4:443/sqdlfotnez https://server4:443/pbwrvwzvdn https://server4:443/psqqwhxssh https://server4:443/tknpkueeuf https://server4:443/juaxrantvx https://server4:443/tquwpvprhy https://server4:443/brznnwvnys https://server4:443/xsobwldzux https://server4:443/aucmuuhcoh https://server4:443/hmxykyprfr https://server4:443/gxjudaeeyu https://server4:443/tklklwjdmr https://server4:443/znxqcoekpb https://server4:443/esorkqesnx https://server4:443/bvowkdckor https://server4:443/nfrkrhexbj https://server4:443/whbkpeyxdy https://server4:443/hgczmmekzr https://server4:443/eybneovweu https://server4:443/sfxyhnchpf https://server4:443/excxvkudnz https://server4:443/dyzosbqdhj https://server4:443/bklyrhuvmi https://server4:443/pbleaynoeo 'https://server4:443/lxtkvaaegb
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:39402 -> 193.167.100.100:443
client  | 0.001 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Client dcid=44aef155d7ed64656e0eb971e70c
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:39402->193.167.100.100:443] Make permanent
client  | 0.001 DEBUG [unv-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443] set as primary path
client  | 0.001 DEBUG [pri-unv-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443] Path validated Instant { tv_sec: 416, tv_nsec: 41043265 }
client  | 0.001 DEBUG [Client 44aef155d7ed64656e0eb971e70c] client_start
client  | 0.002 DEBUG Writing transport parameters, msg=1
client  | 0.002 DEBUG [Agent 0x562639b6b2d0] state -> InProgress
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] State change from Init -> WaitInitial
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.002 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.002 DEBUG CRYPTO for in offset=0, len=1207
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=0 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, Ect0) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 0.002 DEBUG packet_sent this=0x562639b7ebe0, pn=0, ps=1252
client  | 0.002 DEBUG ECN probing: sent 1 probes
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.002 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.002 DEBUG CRYPTO for in offset=1207, len=332
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=1 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, Ect0) len 378
client  |   TX -> Crypto { offset: 1207, len: 332 }
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 378 to PLPMTU 1252
client  | 0.002 DEBUG packet_sent this=0x562639b7ebe0, pn=1, ps=1252
client  | 0.002 DEBUG ECN probing: sent 2 probes
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 0.002 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) 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 44aef155d7ed64656e0eb971e70c] delay duration 3.806776ms
client  | 0.002 DEBUG Setting timeout of 3.806776ms
client  | 0.002 DEBUG StateChange(WaitInitial)
client  | 0.002 WARN Cannot create stream ConnectionState
client  | 0.002 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 0.002 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) 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 44aef155d7ed64656e0eb971e70c] delay duration 3.784034ms
client  | 0.002 DEBUG Setting timeout of 3.784034ms
client  | 0.007 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.007 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) 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 44aef155d7ed64656e0eb971e70c] delay duration 294.827392ms
client  | 0.007 DEBUG Setting timeout of 294.827392ms
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 0/1 (0.0%)
sim     | Dropping 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 1/2 (50.0%)
sim     | Dropping 89 bytes 193.167.100.100:443 -> 193.167.0.100:39402, dropped 1/1 (100.0%)
client  | 0.302 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 0.302 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 0.302 INFO Lost crypto frame space=in offset=0 length=1207
client  | 0.302 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 0.302 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 0.302 INFO Lost crypto frame space=in offset=1207 length=332
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 0.303 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.303 DEBUG CRYPTO for in offset=0, len=1207
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=2 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, Ect0) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 0.303 DEBUG packet_sent this=0x562639b7ebe0, pn=2, ps=1252
client  | 0.303 DEBUG ECN probing: sent 3 probes
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.303 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.303 DEBUG CRYPTO for in offset=1207, len=332
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=3 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, Ect0) len 378
client  |   TX -> Crypto { offset: 1207, len: 332 }
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 378 to PLPMTU 1252
client  | 0.303 DEBUG packet_sent this=0x562639b7ebe0, pn=3, ps=1252
client  | 0.303 DEBUG ECN probing: sent 4 probes
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.303 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.303 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.303 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 599.921023ms
client  | 0.303 DEBUG Setting timeout of 599.921023ms
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 1/3 (33.3%)
sim     | Dropping 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 2/4 (50.0%)
client  | 0.904 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 0.904 INFO Lost crypto frame space=in offset=0 length=1207
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 0.904 DEBUG ECN validation failed, all 3 initial marked packets were lost
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 0.904 INFO Lost crypto frame space=in offset=1207 length=332
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 0.904 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.904 DEBUG CRYPTO for in offset=0, len=1207
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=4 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 0.904 DEBUG packet_sent this=0x562639b7ebe0, pn=4, ps=1252
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.904 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.904 DEBUG CRYPTO for in offset=1207, len=332
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=5 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 378
client  |   TX -> Crypto { offset: 1207, len: 332 }
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 378 to PLPMTU 1252
client  | 0.904 DEBUG packet_sent this=0x562639b7ebe0, pn=5, ps=1252
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.904 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 0.904 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 0.904 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 1.199921534s
client  | 0.904 DEBUG Setting timeout of 1.199921534s
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 2/5 (40.0%)
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 2/6 (33.3%)
client  | 2.105 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 2.105 INFO Lost crypto frame space=in offset=0 length=1207
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 2.105 INFO Lost crypto frame space=in offset=1207 length=332
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 2.105 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 2.105 DEBUG CRYPTO for in offset=0, len=1207
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=6 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 2.105 DEBUG packet_sent this=0x562639b7ebe0, pn=6, ps=1252
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 2.105 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 2.105 DEBUG CRYPTO for in offset=1207, len=332
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=7 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 378
client  |   TX -> Crypto { offset: 1207, len: 332 }
client  | 2.105 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 378 to PLPMTU 1252
client  | 2.105 DEBUG packet_sent this=0x562639b7ebe0, pn=7, ps=1252
client  | 2.106 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 2.106 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 2.106 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 2.106 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 2.399913348s
client  | 2.106 DEBUG Setting timeout of 2.399913348s
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 2/7 (28.6%)
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 2/8 (25.0%)
client  | 4.507 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 4.507 INFO Lost crypto frame space=in offset=0 length=1207
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 4.507 INFO Lost crypto frame space=in offset=1207 length=332
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 4.507 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 4.507 DEBUG CRYPTO for in offset=0, len=1207
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=8 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 4.507 DEBUG packet_sent this=0x562639b7ebe0, pn=8, ps=1252
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 4.507 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 4.507 DEBUG CRYPTO for in offset=1207, len=332
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=9 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 378
client  |   TX -> Crypto { offset: 1207, len: 332 }
client  | 4.507 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 378 to PLPMTU 1252
client  | 4.507 DEBUG packet_sent this=0x562639b7ebe0, pn=9, ps=1252
client  | 4.508 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
client  | 4.508 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 4.508 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
client  | 4.508 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 4.799900113s
client  | 4.508 DEBUG Setting timeout of 4.799900113s
sim     | Dropping 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 3/9 (33.3%)
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 3/10 (30.0%)
client  | 9.309 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 9.309 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 9.309 INFO Lost crypto frame space=in offset=0 length=1207
client  | 9.309 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 9.309 INFO Lost crypto frame space=in offset=1207 length=332
client  | 9.309 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 9.309 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 9.309 DEBUG CRYPTO for in offset=0, len=1207
client  | 9.309 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=10 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 9.309 DEBUG packet_sent this=0x562639b7ebe0, pn=10, ps=1252
client  | 9.309 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
client  | 9.309 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 9.309 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
client  | 9.309 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 9.599796911s
client  | 9.309 DEBUG Setting timeout of 9.599796911s
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 3/11 (27.3%)
client  | 18.910 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 18.910 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.910 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.910 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 18.910 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 18.910 DEBUG CRYPTO for in offset=0, len=1207
client  | 18.910 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=11 type=Initial pri-path:44aef155d7ed64656e0eb971e70c 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1207 }
client  | 18.910 DEBUG packet_sent this=0x562639b7ebe0, pn=11, ps=1252
client  | 18.910 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
client  | 18.910 DEBUG Building Initial dcid Some(CID [14]: 44aef155d7ed64656e0eb971e70c) scid Some(CID [0]: )
client  | 18.910 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
client  | 18.910 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 11.09095405s
client  | 18.910 DEBUG Setting timeout of 11.09095405s
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 3/12 (25.0%)
sim     | Forwarding 89 bytes 193.167.100.100:443 -> 193.167.0.100:39402, dropped 1/2 (50.0%)
client  | 18.943 INFO [Client 44aef155d7ed64656e0eb971e70c] received Retry
client  | 18.943 INFO [Client 44aef155d7ed64656e0eb971e70c] Valid Retry received, token=003d942eb341261f78af1c231217b39d82bad03efe8742057b0ac1d918f8a603b0d9fc599fba4e20369bf15cd33640a583e8fa3c1c150254e380 scid=d352be0729c510f6
client  | 18.943 INFO [pri-path:d352be0729c510f6 0.0.0.0:39402->193.167.100.100:443] discarding a packet without an RTT estimate; guessing RTT=18.941335363s
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 18.943 INFO Lost crypto frame space=in offset=1207 length=332
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 18.943 INFO Lost crypto frame space=in offset=1207 length=332
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: EcnEct0
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 18.943 INFO Lost crypto frame space=in offset=1207 length=332
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 18.943 INFO Lost crypto frame space=in offset=1207 length=332
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1207, length: 332 })
client  | 18.943 INFO Lost crypto frame space=in offset=1207 length=332
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1207 })
client  | 18.943 INFO Lost crypto frame space=in offset=0 length=1207
client  | 18.943 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Client dcid=d352be0729c510f6
client  | 18.943 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
client  | 18.943 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
client  | 18.943 INFO [CryptoStates] Continue packet numbers for initial after retry (write is 0..0)
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 18.943 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 18.943 DEBUG CRYPTO for in offset=0, len=1155
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=12 type=Initial pri-path:d352be0729c510f6 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1155 }
client  | 18.943 DEBUG packet_sent this=0x562639b7ebe0, pn=12, ps=1252
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 18.943 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 18.943 DEBUG CRYPTO for in offset=1155, len=384
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=13 type=Initial pri-path:d352be0729c510f6 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 482
client  |   TX -> Crypto { offset: 1155, len: 384 }
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 482 to PLPMTU 1252
client  | 18.943 DEBUG packet_sent this=0x562639b7ebe0, pn=13, ps=1252
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 18.943 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 18.943 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 914.460576ms
client  | 18.943 DEBUG Setting timeout of 914.460576ms
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 18.943 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 18.943 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
client  | 18.943 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 914.432254ms
client  | 18.943 DEBUG Setting timeout of 914.432254ms
sim     | Dropping 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 4/13 (30.8%)
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 4/14 (28.6%)
sim     | Dropping 40 bytes 193.167.100.100:443 -> 193.167.0.100:39402, dropped 2/3 (66.7%)
client  | 19.859 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 19.859 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 19.859 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 19.859 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 55.907869192s
client  | 19.859 DEBUG Setting timeout of 55.907869192s
client  | 75.768 DEBUG [LossRecovery] PTO timer fired for Initial
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 0, length: 1155 })
client  | 75.768 INFO Lost crypto frame space=in offset=0 length=1155
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] Lost: Crypto(CryptoRecoveryToken { space: Initial, offset: 1155, length: 384 })
client  | 75.768 INFO Lost crypto frame space=in offset=1155 length=384
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: Some(Initial), probe: EnumSet(Initial), paced: false }
client  | 75.768 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 75.768 DEBUG CRYPTO for in offset=0, len=1155
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=14 type=Initial pri-path:d352be0729c510f6 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 1252
client  |   TX -> Crypto { offset: 0, len: 1155 }
client  | 75.768 DEBUG packet_sent this=0x562639b7ebe0, pn=14, ps=1252
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 75.768 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 75.768 DEBUG CRYPTO for in offset=1155, len=384
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pn=15 type=Initial pri-path:d352be0729c510f6 0.0.0.0:39402->193.167.100.100:443 IpTos(Cs0, NotEct) len 482
client  |   TX -> Crypto { offset: 1155, len: 384 }
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] pad Initial from 482 to PLPMTU 1252
client  | 75.768 DEBUG packet_sent this=0x562639b7ebe0, pn=15, ps=1252
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] output_path send_profile SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 75.768 DEBUG Building Initial dcid Some(CID [8]: d352be0729c510f6) scid Some(CID [0]: )
client  | 75.768 DEBUG TX blocked, profile=SendProfile { limit: 1252, pto: None, probe: EnumSet(), paced: false }
client  | 75.768 DEBUG [Client 44aef155d7ed64656e0eb971e70c] delay duration 94.705021556s
client  | 75.768 DEBUG Setting timeout of 94.705021556s
sim     | Dropping 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 5/15 (33.3%)
sim     | Forwarding 1252 bytes 193.167.0.100:39402 -> 193.167.100.100:443, dropped 5/16 (31.2%)
client  | 170.475 INFO [Client 44aef155d7ed64656e0eb971e70c] idle timeout expired
client  | 170.475 DEBUG [Client 44aef155d7ed64656e0eb971e70c] State change from WaitInitial -> Closed(Transport(IdleTimeout))
client  | 170.475 DEBUG Output::None
client  | 170.475 WARN Unhandled event StateChange(Closed(Transport(IdleTimeout)))
client  | 170.475 DEBUG Timer fired while closed
client  | 170.475 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