2025-04-30 08:43:52,285 Generated random file: vqldximplq of size: 5120
2025-04-30 08:43:52,285 Generated random file: kqrsgnjbsm of size: 10240
2025-04-30 08:43:52,285 Requests: https://server4:443/vqldximplq https://server4:443/kqrsgnjbsm
2025-04-30 08:43:52,346 
2025-04-30 08:43:52,346 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_gr22n31j/ TESTCASE_SERVER=resumption TESTCASE_CLIENT=resumption WWW=/tmp/www_kavlm0o3/ DOWNLOADS=/tmp/download_j48w4mwp/ SERVER_LOGS=/tmp/logs_server_ena4f9gc CLIENT_LOGS=/tmp/logs_client_d16klqr2 SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=ghcr.io/aws/s2n-quic/s2n-quic-qns:latest SERVER=ghcr.io/mozilla/neqo-qns:latest REQUESTS="https://server4:443/vqldximplq https://server4:443/kqrsgnjbsm"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 08:44:05,955  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
client  | x86_64
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  | wait-for-it.sh: waiting 30 seconds for sim:57832
server  | + export PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/neqo/bin
server  | + PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/neqo/bin
server  | + '[' -n resumption ']'
server  | + '[' -n /logs/qlog/ ']'
server  | + case "$ROLE" in
server  | + DB=/neqo/db
server  | + CERT=cert
server  | ++ mktemp
server  | + P12CERT=/tmp/tmp.wi3yzWvRig
server  | + mkdir -p /neqo/db
server  | + certutil -N -d sql:/neqo/db --empty-password
server  | + openssl pkcs12 -export -nodes -in /certs/cert.pem -inkey /certs/priv.key -name cert -passout pass: -out /tmp/tmp.wi3yzWvRig
server  | Warning: output encryption option -nodes ignored with -export
server  | + pk12util -d sql:/neqo/db -i /tmp/tmp.wi3yzWvRig -W ''
server  | pk12util: PKCS12 IMPORT SUCCESSFUL
server  | + certutil -L -d sql:/neqo/db -n cert
server  | Certificate:
server  |     Data:
server  |         Version: 3 (0x2)
server  |         Serial Number:
server  |             33:97:82:16:57:eb:eb:98:49:c6:80:1c:2b:70:54:c5:
server  |             9d:80:9f:80
server  |         Signature Algorithm: X9.62 ECDSA signature with SHA256
server  |         Issuer: "O=interop runner Root Certificate Authority"
server  |         Validity:
server  |             Not Before: Wed Apr 30 08:43:52 2025
server  |             Not After : Sat May 10 08:43:52 2025
server  |         Subject: "O=interop runner leaf"
server  |         Subject Public Key Info:
server  |             Public Key Algorithm: X9.62 elliptic curve public key
server  |                 Args:
server  |                     06:08:2a:86:48:ce:3d:03:01:07
server  |             EC Public Key:
server  |                 PublicValue:
server  |                     04:76:4d:92:d8:c8:c6:13:36:59:67:0f:88:0c:eb:9f:
server  |                     a3:6e:9e:a2:78:b0:c1:5e:10:37:70:0f:b6:61:40:2f:
server  |                     7e:ca:ca:9a:fc:e2:ed:54:fa:60:40:87:64:62:10:4e:
server  |                     ee:35:5b:1b:f8:e0:0e:60:a6:76:e3:aa:6e:27:b9:5d:
server  |                     c4
server  |                 Curve: ANSI X9.62 elliptic curve prime256v1 (aka secp256r1, NIST P-256)
server  |         Signed Extensions:
server  |             Name: Certificate Subject Alt Name
server  |             DNS name: "server"
server  |             DNS name: "server4"
server  |             DNS name: "server6"
server  |             DNS name: "server46"
server  | 
server  |             Name: Certificate Subject Key ID
server  |             Data:
server  |                 84:93:d2:97:3b:bc:84:8c:36:05:48:b5:72:98:18:cb:
server  |                 fc:bb:0c:09
server  | 
server  |             Name: Certificate Authority Key Identifier
server  |             Key ID:
server  |                 63:b2:e7:fc:1f:4d:38:c5:f1:6c:d8:9f:a9:ac:cf:50:
server  |                 0b:13:b6:e6
server  | 
server  |     Signature Algorithm: X9.62 ECDSA signature with SHA256
server  |     Signature:
server  |         30:44:02:20:7d:ac:85:ff:b1:4e:25:8a:2b:5b:aa:73:
server  |         7f:03:3d:43:7c:d7:97:52:8e:0f:5b:46:9f:af:06:1b:
server  |         db:8a:e5:ef:02:20:5f:29:9f:2f:f9:27:be:13:c8:f0:
server  |         03:7f:fb:af:3f:32:92:25:fa:63:eb:b1:2e:75:99:18:
server  |         bd:f1:d6:9c:46:71
server  |     Fingerprint (SHA-256):
server  |         E8:B3:0F:4F:81:C4:3C:13:6B:DA:DD:DB:77:EA:26:C5:91:91:5C:B3:D4:22:F4:24:CD:4E:82:26:A6:76:CD:B5
server  |     Fingerprint (SHA1):
server  |         61:58:34:D4:45:FD:CB:55:4B:82:3C:F7:BB:AC:2A:A8:CE:1B:18:73
server  | 
server  |     Mozilla-CA-Policy: false (attribute missing)
server  |     Certificate Trust Flags:
server  |         SSL Flags:
server  |             User
server  |         Email Flags:
server  |             User
server  |         Object Signing Flags:
server  |             User
server  | 
server  | + OPTIONS=(--cc cubic --qns-test "$TESTCASE" --qlog-dir "$QLOGDIR" -d "$DB" -k "$CERT")
server  | + '[' resumption = connectionmigration ']'
server  | + RUST_LOG=debug
server  | + RUST_BACKTRACE=1
server  | + neqo-server --cc cubic --qns-test resumption --qlog-dir /logs/qlog/ -d /neqo/db -k cert '[::]:443'
server  | ++ tee -i -a /logs/server.log
server  | 0.000 DEBUG Logging initialized
server  | 0.002 DEBUG Default socket send buffer size is 212992
server  | 0.002 DEBUG Default socket receive buffer size is 1048576, not changing
server  | 0.002 INFO Server waiting for connection on: [::]:443
server  | 0.761 DEBUG [Server] Unsupported version: 57414954
server  | 0.761 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:44246 IpTos(Cs0, NotEct) len 15
server  | 0.761 DEBUG [Server] Unsupported version: 57414954
server  | 0.761 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:44246 IpTos(Cs0, NotEct) len 15
server  | 0.761 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
server  | 0.761 DEBUG [Server] Unsupported version: 57414954
server  | 0.761 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:44246 IpTos(Cs0, NotEct) len 15
server  | 0.761 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
sim     | server:443 is available after 1.035437348s
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  | connecting to server4 at 193.167.100.100:443
server  | 1.025 DEBUG [Server] Handle initial
server  | 1.025 INFO AddressValidation: no token; accepting
server  | 1.025 INFO [Server] Accept connection CID [8]: 8e225fa50f7d0c5b
server  | 1.025 DEBUG Overwrite initial version Version1 ==> Version1
server  | 1.027 DEBUG Outbound interface eth0 for destination ::ffff:193.167.0.100 has MTU 1500
server  | 1.027 INFO [Server ...] Received valid Initial packet with scid CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d dcid CID [8]: 8e225fa50f7d0c5b
server  | 1.027 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Server dcid=8e225fa50f7d0c5b
server  | 1.027 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.027 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.027 DEBUG [Server 8e225fa50f7d0c5b] State change from Init -> WaitInitial
server  | 1.027 DEBUG [Server 8e225fa50f7d0c5b] pn=0 type=Initial unv-path [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1252
server  |   -> RX Crypto { offset: 0, len: 287 }
server  |   -> RX Padding { len: 910 }
server  | 1.027 DEBUG Read Ok(287) bytes
server  | 1.027 DEBUG 0-RTT: no token, no 0-RTT
server  | 1.028 DEBUG Read secret available for Handshake: SymKey [32]: cbc25691aeb76ef4ca82902ccc87b48dfcd760b870039cc0dd3239c3f806fec9
server  | 1.028 DEBUG Write secret available for Handshake: SymKey [32]: 3a66bdb859bf3ec5a82dd1c6c0bad36c97143a74cc4671e604f252fb6cba2ccd
server  | 1.028 DEBUG Writing transport parameters, msg=8
server  | 1.028 DEBUG Read secret available for ApplicationData: SymKey [32]: d49131d25c6c48aa5e0913f09c6d552a7c00298fb02ab926ecedb1e905b14468
server  | 1.028 DEBUG Write secret available for ApplicationData: SymKey [32]: d4cd561efa1d40b0799001e78bfa3b365a270220c15a6706fd7f183f4ffd3dd4
server  | 1.029 DEBUG [Agent 0x5636163491d0] state -> InProgress
server  | 1.029 DEBUG Making Write Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.029 DEBUG Making Read Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.029 DEBUG [Crypto] Handshake keys installed
server  | 1.029 DEBUG Making Write ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.029 DEBUG [Crypto] Application write key installed
server  | 1.029 DEBUG [Recvd-in] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 185612521 }
server  | 1.029 DEBUG [unv-path [::]:443->[::ffff:193.167.0.100]:34467] Make permanent
server  | 1.029 DEBUG [unv-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467] set as primary path
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] State change from WaitInitial -> Handshaking
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.029 DEBUG Building Initial dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.029 DEBUG CRYPTO for in offset=0, len=123
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] pn=0 type=Initial pri-unv-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 188
server  |   TX -> 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})) }
server  |   TX -> Crypto { offset: 0, len: 123 }
server  | 1.029 DEBUG Building Handshake dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.029 DEBUG CRYPTO for hs offset=0, len=723
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] pn=0 type=Handshake pri-unv-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 967
server  |   TX -> Crypto { offset: 0, len: 723 }
server  | 1.029 DEBUG packet_sent this=0x563616348b40, pn=0, ps=779
server  | 1.029 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] pad Initial from 967 to PLPMTU 1232
server  | 1.029 DEBUG packet_sent this=0x563616348b40, pn=0, ps=453
server  | 1.029 DEBUG ECN probing: sent 1 probes
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.029 DEBUG Building Initial dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.029 DEBUG Building Handshake dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.029 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.029 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] delay duration 296.284095ms
server  | 1.029 DEBUG Setting timeout of 296.284095ms
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.029 DEBUG Building Initial dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.029 DEBUG Building Handshake dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.029 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.029 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.029 DEBUG [Server 8e225fa50f7d0c5b] delay duration 296.243599ms
server  | 1.029 DEBUG Setting timeout of 296.243599ms
client  | GET /vqldximplq
server  | 1.064 DEBUG [Server 8e225fa50f7d0c5b] pn=1 type=Initial pri-unv-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 72
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 1904, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.064 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=in, ranges=[0..=0]
server  | 1.064 DEBUG [LossRecovery] ACK for Initial - largest_acked=0
server  | 1.064 DEBUG on_packets_acked this=0x563616348b40, limited=1, bytes_in_flight=779, cwnd=12320, state=SlowStart, new_acked=453
server  | 1.064 DEBUG Acked crypto frame space=in offset=0 length=123
server  | 1.064 DEBUG [pri-unv-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467] Path validated Instant { tv_sec: 297, tv_nsec: 224715921 }
server  | 1.064 DEBUG [Server 8e225fa50f7d0c5b] Drop packet number space in
server  | 1.064 DEBUG [LossRecovery] Reset loss recovery state for Initial
server  | 1.064 DEBUG [Server 8e225fa50f7d0c5b] pn=0 type=Handshake pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1180
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 1904, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX Crypto { offset: 0, len: 36 }
server  |   -> RX Padding { len: 1080 }
server  | 1.064 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=hs, ranges=[0..=0]
server  | 1.064 DEBUG [LossRecovery] ACK for Handshake - largest_acked=0
server  | 1.064 DEBUG on_packets_acked this=0x563616348b40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=779
server  | 1.064 DEBUG Acked crypto frame space=hs offset=0 length=723
server  | 1.064 DEBUG Read Ok(36) bytes
server  | 1.065 DEBUG [Agent 0x5636163491d0] state -> Complete(SecretAgentInfo { version: 772, cipher: 4865, group: 23, resumed: false, early_data: false, ech_accepted: false, alpn: Some("hq-interop"), signature_scheme: 1027 })
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] TLS connection complete
server  | 1.065 DEBUG [pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467] Path validated Instant { tv_sec: 297, tv_nsec: 224715921 }
server  | 1.065 DEBUG Making Read ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.065 DEBUG [Crypto] application read keys installed
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] State change from Handshaking -> Connected
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] State change from Connected -> Confirmed
server  | 1.065 DEBUG PMTUD started with probe size 1380
server  | 1.065 INFO [Server 8e225fa50f7d0c5b] Connection established
server  | 1.065 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 224715921 }
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.065 DEBUG Building Handshake dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d) scid Some(CID [10]: 5faac7f1c4336e0adc2b)
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] pn=1 type=Handshake pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 60
server  |   TX -> 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})) }
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] Drop packet number space hs
server  | 1.065 DEBUG [LossRecovery] Reset loss recovery state for Handshake
server  | 1.065 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] pn=0 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1332
server  |   TX -> HandshakeDone
server  |   TX -> NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [170, 245, 239, 167, 156, 35, 150, 22, 85, 161], stateless_reset_token: [210, 150, 90, 123, 56, 36, 146, 117, 104, 189, 90, 27, 197, 133, 17, 124] }
server  |   TX -> NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [78, 236, 123, 17, 58, 6, 192, 13, 77, 132], stateless_reset_token: [22, 206, 150, 163, 185, 201, 21, 150, 175, 83, 212, 215, 78, 71, 5, 211] }
server  |   TX -> Padding { len: 1177 }
server  | 1.065 DEBUG packet_sent this=0x563616348b40, pn=0, ps=1272
server  | 1.065 DEBUG ECN probing: sent 2 probes
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.065 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.065 DEBUG Sending PMTUD probe of size 1380, count 1
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] pn=1 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ping
server  |   TX -> Padding { len: 1297 }
server  | 1.065 DEBUG packet_sent this=0x563616348b40, pn=1, ps=1332
server  | 1.065 DEBUG ECN probing: sent 3 probes
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.065 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.065 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] delay duration 1.395335ms
server  | 1.065 DEBUG Setting timeout of 1.395335ms
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] pn=0 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 51
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 0, fin: false }
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 17, fin: true }
server  | 1.065 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 245531556 }
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.065 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.065 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.065 DEBUG [Server 8e225fa50f7d0c5b] delay duration 1.362383ms
server  | 1.065 DEBUG Setting timeout of 1.362383ms
server  | 1.066 DEBUG [Server 8e225fa50f7d0c5b] send session ticket 406300088e225fa50f7d0c5b0104800075300408ffffffffffffffff0504801000000604801000000704801000000801100901100b01140e01080f0a5faac7f1c4336e0adc2b110c00000001ca3a0aca000000016ab200c0000000ff02de1a0243e8200100686921
server  | 1.066 DEBUG Path = 'vqldximplq'
server  | 1.066 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.066 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.066 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.066 DEBUG [Server 8e225fa50f7d0c5b] delay duration 172.509µs
server  | 1.066 DEBUG Setting timeout of 172.509µs
server  | 1.068 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.068 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.068 DEBUG [Server 8e225fa50f7d0c5b] pn=2 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 0, len: >>1196, fin: false }
server  | 1.068 DEBUG packet_sent this=0x563616348b40, pn=2, ps=1232
server  | 1.068 DEBUG ECN probing: sent 4 probes
server  | 1.068 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.068 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.069 DEBUG [Server 8e225fa50f7d0c5b] pn=3 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 1196, len: >>1194, fin: false }
server  | 1.069 DEBUG packet_sent this=0x563616348b40, pn=3, ps=1232
server  | 1.069 DEBUG ECN probing: sent 5 probes
server  | 1.069 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.069 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.069 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.069 DEBUG [Server 8e225fa50f7d0c5b] delay duration 1.774567ms
server  | 1.069 DEBUG Setting timeout of 1.774567ms
server  | 1.069 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.069 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.069 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.069 DEBUG [Server 8e225fa50f7d0c5b] delay duration 1.751815ms
server  | 1.069 DEBUG Setting timeout of 1.751815ms
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.072 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] pn=4 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 2390, len: >>1194, fin: false }
server  | 1.072 DEBUG packet_sent this=0x563616348b40, pn=4, ps=1232
server  | 1.072 DEBUG ECN probing: sent 6 probes
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.072 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] pn=5 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 3584, len: >>1194, fin: false }
server  | 1.072 DEBUG packet_sent this=0x563616348b40, pn=5, ps=1232
server  | 1.072 DEBUG ECN probing: sent 7 probes
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.072 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.072 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] delay duration 1.849895ms
server  | 1.072 DEBUG Setting timeout of 1.849895ms
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.072 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.072 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.072 DEBUG [Server 8e225fa50f7d0c5b] delay duration 1.797768ms
server  | 1.072 DEBUG Setting timeout of 1.797768ms
server  | 1.075 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.075 DEBUG CRYPTO for ap offset=0, len=305
server  | 1.075 DEBUG [Server 8e225fa50f7d0c5b] pn=6 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 736
server  |   TX -> Stream { stream_id: 0, offset: 4778, len: 342, fin: true }
server  |   TX -> Crypto { offset: 0, len: 305 }
server  |   TX -> NewToken { token: [173, 154, 139, 141, 134, 1, 0, 207, 145, 190, 212, 128, 43, 35, 132, 225, 28, 120, 227, 239, 13, 101, 114, 247, 37, 240, 23, 126, 159, 1, 30, 232, 124, 167, 89, 90, 109, 89, 188, 138, 227, 81, 210] }
server  | 1.075 DEBUG packet_sent this=0x563616348b40, pn=6, ps=736
server  | 1.075 DEBUG ECN probing: sent 8 probes
server  | 1.075 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.075 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG [Server 8e225fa50f7d0c5b] delay duration 9.883953ms
server  | 1.075 DEBUG Setting timeout of 9.883953ms
server  | 1.075 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.075 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG [Server 8e225fa50f7d0c5b] delay duration 9.858165ms
server  | 1.075 DEBUG Setting timeout of 9.858165ms
server  | 1.086 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.086 DEBUG [Server 8e225fa50f7d0c5b] pn=7 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 43
server  |   TX -> Ack { largest_acknowledged: 0, ack_delay: 2655, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  | 1.086 DEBUG ECN probing: sent 9 probes
server  | 1.086 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.086 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG [Server 8e225fa50f7d0c5b] delay duration 111.384981ms
server  | 1.086 DEBUG Setting timeout of 111.384981ms
server  | 1.087 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.087 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.087 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.087 DEBUG [Server 8e225fa50f7d0c5b] delay duration 111.358601ms
server  | 1.087 DEBUG Setting timeout of 111.358601ms
client  | Request /vqldximplq completed successfully
server  | 1.099 DEBUG [Server 8e225fa50f7d0c5b] pn=1 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1472
server  |   -> RX Ping
server  |   -> RX Padding { len: 1443 }
server  | 1.099 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 259676958 }
server  | 1.099 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 259676958 }
server  | 1.099 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.099 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.099 DEBUG [Server 8e225fa50f7d0c5b] pn=8 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 42
server  |   TX -> Ack { largest_acknowledged: 1, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 2, Ce: 0})) }
server  | 1.099 DEBUG ECN probing: sent 10 probes
server  | 1.099 DEBUG ECN probing concluded with 10 probes sent
server  | 1.099 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.099 DEBUG Building Short dcid Some(CID [16]: 3b6f9e62cf1e42ef7cda55cdb3327e9d)
server  | 1.099 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.099 DEBUG [Server 8e225fa50f7d0c5b] delay duration 98.433813ms
server  | 1.099 DEBUG Setting timeout of 98.433813ms
server  | 1.099 DEBUG [Server 8e225fa50f7d0c5b] pn=2 type=Short pri-path:3b6f9e62cf1e42ef7cda55cdb3327e9d [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 147
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 107, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX NewConnectionId { sequence_number: 1, retire_prior: 1, connection_id: [84, 212, 40, 131, 62, 164, 196, 247, 60, 210, 112, 235, 115, 57, 18, 246], stateless_reset_token: [1, 43, 143, 209, 77, 184, 187, 190, 239, 2, 14, 134, 186, 252, 209, 69] }
server  |   -> RX NewConnectionId { sequence_number: 2, retire_prior: 1, connection_id: [52, 23, 44, 40, 34, 153, 241, 116, 151, 16, 209, 33, 146, 83, 121, 116], stateless_reset_token: [30, 49, 102, 247, 247, 119, 176, 214, 228, 80, 251, 209, 182, 109, 30, 251] }
server  |   -> RX NewConnectionId { sequence_number: 3, retire_prior: 1, connection_id: [224, 235, 151, 63, 87, 231, 206, 92, 147, 139, 174, 221, 246, 208, 195, 107], stateless_reset_token: [68, 179, 64, 216, 16, 198, 209, 202, 100, 231, 210, 38, 88, 122, 120, 2] }
server  |   -> RX RetireConnectionId { sequence_number: 0 }
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[0..=0]
server  | 1.100 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=0
server  | 1.100 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 6996/13592 ssthresh 18446744073709551615] slow start += 1272
server  | 1.100 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 6996/13592 ssthresh 18446744073709551615] on_packets_acked this=0x563616348b40, limited=0, bytes_in_flight=6996, cwnd=13592, state=SlowStart, new_acked=1272
server  | 1.100 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 279898983 }
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.100 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] pn=9 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 66
server  |   TX -> NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [159, 241, 77, 156, 115, 200, 206, 98, 213, 212], stateless_reset_token: [139, 215, 73, 166, 27, 211, 211, 83, 182, 236, 192, 1, 64, 98, 250, 84] }
server  |   TX -> RetireConnectionId { sequence_number: 0 }
server  | 1.100 DEBUG packet_sent this=0x563616348b40, pn=9, ps=66
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.100 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.100 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] delay duration 19.722299ms
server  | 1.100 DEBUG Setting timeout of 19.722299ms
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.100 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.100 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.100 DEBUG [Server 8e225fa50f7d0c5b] delay duration 19.692163ms
server  | 1.100 DEBUG Setting timeout of 19.692163ms
server  | 1.121 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.121 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.121 DEBUG [Server 8e225fa50f7d0c5b] pn=10 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 43
server  |   TX -> Ack { largest_acknowledged: 2, ack_delay: 2677, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  | 1.121 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.121 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.121 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.121 DEBUG [Server 8e225fa50f7d0c5b] delay duration 89.952362ms
server  | 1.121 DEBUG Setting timeout of 89.952362ms
server  | 1.121 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.121 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.121 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.121 DEBUG [Server 8e225fa50f7d0c5b] delay duration 89.926654ms
server  | 1.121 DEBUG Setting timeout of 89.926654ms
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] pn=3 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 7, ack_delay: 860, first_ack_range: 7, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 8, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[0..=7]
server  | 1.125 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=7
server  | 1.125 INFO ECN validation succeeded, path is capable
server  | 1.125 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 66/20588 ssthresh 18446744073709551615] slow start += 6996
server  | 1.125 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 66/20588 ssthresh 18446744073709551615] on_packets_acked this=0x563616348b40, limited=0, bytes_in_flight=66, cwnd=20588, state=SlowStart, new_acked=6996
server  | 1.125 DEBUG PMTUD probe of size 1380 succeeded
server  | 1.125 DEBUG PMTUD started with probe size 1420
server  | 1.125 DEBUG PLPMTU changed from 1232 to 1332, updating pacer
server  | 1.125 DEBUG Acked crypto frame space=ap offset=0 length=305
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.125 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.125 DEBUG Sending PMTUD probe of size 1420, count 1
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] pn=11 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1372
server  |   TX -> Ping
server  |   TX -> MaxStreams { stream_type: BiDi, maximum_streams: 17 }
server  |   TX -> Padding { len: 1335 }
server  | 1.125 DEBUG packet_sent this=0x563616348b40, pn=11, ps=1372
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.125 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.125 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] delay duration 99.712741ms
server  | 1.125 DEBUG Setting timeout of 99.712741ms
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.125 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.125 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.125 DEBUG [Server 8e225fa50f7d0c5b] delay duration 99.678407ms
server  | 1.125 DEBUG Setting timeout of 99.678407ms
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] pn=5 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 11, ack_delay: 34, first_ack_range: 10, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 10, Ce: 0})) }
server  |   -> RX Padding { len: 11 }
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[1..=11]
server  | 1.157 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=11
server  | 1.157 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 0/22026 ssthresh 18446744073709551615] slow start += 1438
server  | 1.157 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 0/22026 ssthresh 18446744073709551615] on_packets_acked this=0x563616348b40, limited=0, bytes_in_flight=0, cwnd=22026, state=SlowStart, new_acked=1438
server  | 1.157 DEBUG PMTUD probe of size 1420 succeeded
server  | 1.157 DEBUG PMTUD started with probe size 1470
server  | 1.157 DEBUG PLPMTU changed from 1332 to 1372, updating pacer
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.157 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.157 DEBUG Sending PMTUD probe of size 1470, count 1
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] pn=12 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1422
server  |   TX -> Ping
server  |   TX -> Padding { len: 1387 }
server  | 1.157 DEBUG packet_sent this=0x563616348b40, pn=12, ps=1422
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.157 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.157 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] delay duration 95.714701ms
server  | 1.157 DEBUG Setting timeout of 95.714701ms
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.157 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.157 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.157 DEBUG [Server 8e225fa50f7d0c5b] delay duration 95.686849ms
server  | 1.157 DEBUG Setting timeout of 95.686849ms
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] pn=6 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 12, ack_delay: 3353, first_ack_range: 11, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[1..=12]
server  | 1.217 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=12
server  | 1.217 DEBUG on_packets_acked this=0x563616348b40, limited=1, bytes_in_flight=0, cwnd=22026, state=SlowStart, new_acked=1422
server  | 1.217 DEBUG PMTUD probe of size 1470 succeeded
server  | 1.217 DEBUG PMTUD started with probe size 1500
server  | 1.217 DEBUG PLPMTU changed from 1372 to 1422, updating pacer
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.217 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.217 DEBUG Sending PMTUD probe of size 1500, count 1
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] pn=13 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1452
server  |   TX -> Ping
server  |   TX -> Padding { len: 1417 }
server  | 1.217 DEBUG packet_sent this=0x563616348b40, pn=13, ps=1452
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.217 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.217 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] delay duration 90.3804ms
server  | 1.217 DEBUG Setting timeout of 90.3804ms
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.217 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.217 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.217 DEBUG [Server 8e225fa50f7d0c5b] delay duration 90.350895ms
server  | 1.217 DEBUG Setting timeout of 90.350895ms
server  | 1.253 DEBUG [Server 8e225fa50f7d0c5b] pn=8 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 47
server  |   -> RX Ack { largest_acknowledged: 13, ack_delay: 451, first_ack_range: 12, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 12, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.253 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[1..=13]
server  | 1.253 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=13
server  | 1.253 DEBUG on_packets_acked this=0x563616348b40, limited=1, bytes_in_flight=0, cwnd=22026, state=SlowStart, new_acked=1452
server  | 1.253 DEBUG PMTUD probe of size 1500 succeeded
server  | 1.253 INFO PMTUD stopped, PLPMTU is now 1500, raise timer Some(Instant { tv_sec: 897, tv_nsec: 413673631 })
server  | 1.253 DEBUG PLPMTU changed from 1422 to 1452, updating pacer
server  | 1.253 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 413673631 }
server  | 1.253 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 413673631 }
server  | 1.253 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.253 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.253 DEBUG [Server 8e225fa50f7d0c5b] pn=14 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 46
server  |   TX -> Ack { largest_acknowledged: 8, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 1 }, AckRange { gap: 0, range: 3 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  | 1.253 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.253 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.253 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.253 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999774839s
server  | 1.253 DEBUG Setting timeout of 29.999774839s
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] pn=10 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 47
server  |   -> RX Ack { largest_acknowledged: 13, ack_delay: 451, first_ack_range: 12, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 12, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[1..=13]
server  | 1.254 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 413938306 }
server  | 1.254 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 413938306 }
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.254 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] pn=15 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 48
server  |   TX -> Ack { largest_acknowledged: 10, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }, AckRange { gap: 0, range: 1 }, AckRange { gap: 0, range: 3 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.254 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.254 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999862621s
server  | 1.254 DEBUG Setting timeout of 29.999862621s
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.254 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.254 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.254 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999828898s
server  | 1.254 DEBUG Setting timeout of 29.999828898s
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] pn=13 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 15, ack_delay: 14241, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 14, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[14..=15]
server  | 1.399 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=15
server  | 1.399 DEBUG on_packets_acked this=0x563616348b40, limited=1, bytes_in_flight=0, cwnd=22026, state=SlowStart, new_acked=0
server  | 1.399 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 559430515 }
server  | 1.399 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 559430515 }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] pn=16 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 42
server  |   TX -> Ack { largest_acknowledged: 13, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.399 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999800697s
server  | 1.399 DEBUG Setting timeout of 29.999800697s
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] pn=15 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 15, ack_delay: 14241, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 14, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[14..=15]
server  | 1.399 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 559665104 }
server  | 1.399 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 559665104 }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] pn=17 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 44
server  |   TX -> Ack { largest_acknowledged: 15, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 8, Ce: 0})) }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.399 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999901716s
server  | 1.399 DEBUG Setting timeout of 29.999901716s
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.399 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.399 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999872722s
server  | 1.399 DEBUG Setting timeout of 29.999872722s
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] pn=18 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 17, ack_delay: 12835, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 16, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[16..=17]
server  | 1.534 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=17
server  | 1.534 DEBUG on_packets_acked this=0x563616348b40, limited=1, bytes_in_flight=0, cwnd=22026, state=SlowStart, new_acked=0
server  | 1.534 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 693994192 }
server  | 1.534 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 693994192 }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] pn=18 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 42
server  |   TX -> Ack { largest_acknowledged: 18, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.534 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999811838s
server  | 1.534 DEBUG Setting timeout of 29.999811838s
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] pn=20 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 17, ack_delay: 12835, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 16, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] Rx ACK space=ap, ranges=[16..=17]
server  | 1.534 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 694210587 }
server  | 1.534 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 694210587 }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] pn=19 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 44
server  |   TX -> Ack { largest_acknowledged: 20, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 10, Ce: 0})) }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.534 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999894363s
server  | 1.534 DEBUG Setting timeout of 29.999894363s
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.534 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.534 DEBUG [Server 8e225fa50f7d0c5b] delay duration 29.999866841s
server  | 1.534 DEBUG Setting timeout of 29.999866841s
client  | connecting to server4 at 193.167.100.100:443
server  | 1.609 DEBUG [Server 8e225fa50f7d0c5b] pn=22 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX ConnectionClose { error_code: Transport(0), frame_type: 0, reason_phrase: "" }
server  |   -> RX Padding { len: 15 }
server  | 1.609 INFO [Server 8e225fa50f7d0c5b] ConnectionClose received. Error code: Transport(0) frame type 0 reason 
server  | 1.609 DEBUG [Server 8e225fa50f7d0c5b] State change from Confirmed -> Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 298, tv_nsec: 31468070 } }
server  | 1.609 DEBUG [Server 8e225fa50f7d0c5b] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.609 DEBUG Building Short dcid Some(CID [16]: 54d428833ea4c4f73cd270eb733912f6)
server  | 1.609 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 768998478 }
server  | 1.609 DEBUG [Server 8e225fa50f7d0c5b] pn=20 type=Short pri-path:54d428833ea4c4f73cd270eb733912f6 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 50
server  |   TX -> Ack { largest_acknowledged: 22, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }, AckRange { gap: 0, range: 0 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  |   TX -> ConnectionClose { error_code: Transport(0), frame_type: 28, reason_phrase: "" }
server  | 1.609 DEBUG Setting timeout of 262.277463ms
server  | 1.609 DEBUG Setting timeout of 262.258868ms
server  | 1.611 DEBUG [Server] Handle initial
server  | 1.611 INFO AddressValidation: no token; accepting
server  | 1.611 INFO [Server] Accept connection CID [8]: 87c951bae10ae5f7
server  | 1.611 DEBUG Overwrite initial version Version1 ==> Version1
server  | 1.612 DEBUG Outbound interface eth0 for destination ::ffff:193.167.0.100 has MTU 1500
server  | 1.612 INFO [Server ...] Received valid Initial packet with scid CID [16]: f71b7b852e694c5c9cee7626b8438209 dcid CID [8]: 87c951bae10ae5f7
server  | 1.612 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Server dcid=87c951bae10ae5f7
server  | 1.612 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.612 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.612 DEBUG [Server 87c951bae10ae5f7] State change from Init -> WaitInitial
server  | 1.612 DEBUG [Server 87c951bae10ae5f7] pn=0 type=Initial unv-path [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1252
server  |   -> RX Crypto { offset: 0, len: 600 }
server  |   -> RX Padding { len: 597 }
server  | 1.612 DEBUG Read Ok(600) bytes
server  | 1.612 INFO 0-RTT: transport parameters OK, passing to application checker
server  | 1.612 WARN AllowZeroRtt accepting 0-RTT
server  | 1.613 DEBUG Read secret available for Handshake: SymKey [32]: 17ef8bfcd2aa4c9e0c46144b6b0cba2a7a54a07788768ac9913db234ae363d5c
server  | 1.613 DEBUG Write secret available for Handshake: SymKey [32]: 910b7f5c4871f160a0b0793cb648c2bfd3d69bbce2fc33bd866ffa53d89828b0
server  | 1.613 DEBUG Writing transport parameters, msg=8
server  | 1.613 DEBUG Read secret available for ApplicationData: SymKey [32]: f004413fd38d04393f002bee40af0626a7ccd27037ccd346df68f34144595520
server  | 1.613 DEBUG Write secret available for ApplicationData: SymKey [32]: 50f7a4a58280d988495ff368b29769e00d9949a2f8b1d3536e90a6cbf4257093
server  | 1.613 DEBUG [Agent 0x563616392f70] state -> InProgress
server  | 1.613 DEBUG Making Write Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.613 DEBUG Making Read Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.613 DEBUG [Crypto] Handshake keys installed
server  | 1.613 DEBUG Making Write ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.613 DEBUG [Crypto] Application write key installed
server  | 1.613 DEBUG [Recvd-in] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 771041527 }
server  | 1.613 DEBUG [unv-path [::]:443->[::ffff:193.167.0.100]:34467] Make permanent
server  | 1.613 DEBUG [unv-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467] set as primary path
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] State change from WaitInitial -> Handshaking
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.613 DEBUG Building Initial dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.613 DEBUG CRYPTO for in offset=0, len=129
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] pn=0 type=Initial pri-unv-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 194
server  |   TX -> 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})) }
server  |   TX -> Crypto { offset: 0, len: 129 }
server  | 1.613 DEBUG Building Handshake dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.613 DEBUG CRYPTO for hs offset=0, len=176
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] pn=0 type=Handshake pri-unv-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 426
server  |   TX -> Crypto { offset: 0, len: 176 }
server  | 1.613 DEBUG packet_sent this=0x563616286590, pn=0, ps=232
server  | 1.613 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] pad Initial from 426 to PLPMTU 1232
server  | 1.613 DEBUG packet_sent this=0x563616286590, pn=0, ps=1000
server  | 1.613 DEBUG ECN probing: sent 1 probes
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.613 DEBUG Building Initial dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.613 DEBUG Building Handshake dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.613 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.613 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] delay duration 297.247624ms
server  | 1.613 DEBUG Setting timeout of 257.674167ms
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.613 DEBUG Building Initial dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.613 DEBUG Building Handshake dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.613 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.613 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.613 DEBUG [Server 87c951bae10ae5f7] delay duration 297.212779ms
server  | 1.613 DEBUG Setting timeout of 257.639322ms
client  | GET /kqrsgnjbsm
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] pn=1 type=Initial pri-unv-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 72
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 1268, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=in, ranges=[0..=0]
server  | 1.648 DEBUG [LossRecovery] ACK for Initial - largest_acked=0
server  | 1.648 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=232, cwnd=12320, state=SlowStart, new_acked=1000
server  | 1.648 DEBUG Acked crypto frame space=in offset=0 length=129
server  | 1.648 DEBUG [pri-unv-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467] Path validated Instant { tv_sec: 297, tv_nsec: 808201086 }
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] Drop packet number space in
server  | 1.648 DEBUG [LossRecovery] Reset loss recovery state for Initial
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] pn=0 type=Handshake pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1180
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 1268, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX Crypto { offset: 0, len: 36 }
server  |   -> RX Padding { len: 1080 }
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=hs, ranges=[0..=0]
server  | 1.648 DEBUG [LossRecovery] ACK for Handshake - largest_acked=0
server  | 1.648 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=232
server  | 1.648 DEBUG Acked crypto frame space=hs offset=0 length=176
server  | 1.648 DEBUG Read Ok(36) bytes
server  | 1.648 DEBUG [Agent 0x563616392f70] state -> Complete(SecretAgentInfo { version: 772, cipher: 4865, group: 23, resumed: true, early_data: false, ech_accepted: false, alpn: Some("hq-interop"), signature_scheme: 1027 })
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] TLS connection complete
server  | 1.648 DEBUG [pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467] Path validated Instant { tv_sec: 297, tv_nsec: 808201086 }
server  | 1.648 DEBUG Making Read ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.648 DEBUG [Crypto] application read keys installed
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] State change from Handshaking -> Connected
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] State change from Connected -> Confirmed
server  | 1.648 DEBUG PMTUD started with probe size 1380
server  | 1.648 INFO [Server 87c951bae10ae5f7] Connection established
server  | 1.648 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 808201086 }
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.648 DEBUG Building Handshake dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209) scid Some(CID [10]: 44b0c1e27ad839610309)
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] pn=1 type=Handshake pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 60
server  |   TX -> 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})) }
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] Drop packet number space hs
server  | 1.648 DEBUG [LossRecovery] Reset loss recovery state for Handshake
server  | 1.648 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] pn=0 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1332
server  |   TX -> HandshakeDone
server  |   TX -> NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [79, 47, 156, 104, 155, 232, 12, 157, 110, 25], stateless_reset_token: [50, 247, 147, 162, 128, 9, 208, 206, 238, 179, 155, 254, 206, 183, 127, 102] }
server  |   TX -> NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [45, 232, 92, 27, 253, 45, 149, 201, 177, 89], stateless_reset_token: [97, 212, 245, 171, 30, 30, 6, 1, 181, 106, 102, 3, 33, 168, 146, 159] }
server  |   TX -> Padding { len: 1177 }
server  | 1.648 DEBUG packet_sent this=0x563616286590, pn=0, ps=1272
server  | 1.648 DEBUG ECN probing: sent 2 probes
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.648 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.648 DEBUG Sending PMTUD probe of size 1380, count 1
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] pn=1 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ping
server  |   TX -> Padding { len: 1297 }
server  | 1.648 DEBUG packet_sent this=0x563616286590, pn=1, ps=1332
server  | 1.648 DEBUG ECN probing: sent 3 probes
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.648 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.648 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.648 DEBUG [Server 87c951bae10ae5f7] delay duration 1.354411ms
server  | 1.649 DEBUG Setting timeout of 1.354411ms
server  | 1.649 DEBUG [Server 87c951bae10ae5f7] pn=0 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 51
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 0, fin: false }
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 17, fin: true }
server  | 1.649 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 828950837 }
server  | 1.649 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.649 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.649 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.649 DEBUG [Server 87c951bae10ae5f7] delay duration 1.319847ms
server  | 1.649 DEBUG Setting timeout of 1.319847ms
server  | 1.649 DEBUG [Server 87c951bae10ae5f7] send session ticket 4063000887c951bae10ae5f70104800075300408ffffffffffffffff0504801000000604801000000704801000000801100901100b01140e01080f0a44b0c1e27ad839610309110c000000013a9a2afa000000016ab200c0000000ff02de1a0243e8200100686921
server  | 1.649 DEBUG Path = 'kqrsgnjbsm'
server  | 1.649 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.649 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.649 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.649 DEBUG [Server 87c951bae10ae5f7] delay duration 1.049932ms
server  | 1.649 DEBUG Setting timeout of 1.049932ms
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.651 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] pn=2 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 0, len: >>1196, fin: false }
server  | 1.651 DEBUG packet_sent this=0x563616286590, pn=2, ps=1232
server  | 1.651 DEBUG ECN probing: sent 4 probes
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.651 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] pn=3 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 1196, len: >>1194, fin: false }
server  | 1.651 DEBUG packet_sent this=0x563616286590, pn=3, ps=1232
server  | 1.651 DEBUG ECN probing: sent 5 probes
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.651 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.651 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] delay duration 1.798145ms
server  | 1.651 DEBUG Setting timeout of 1.798145ms
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.651 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.651 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.651 DEBUG [Server 87c951bae10ae5f7] delay duration 1.777266ms
server  | 1.651 DEBUG Setting timeout of 1.777266ms
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.654 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] pn=4 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 2390, len: >>1194, fin: false }
server  | 1.654 DEBUG packet_sent this=0x563616286590, pn=4, ps=1232
server  | 1.654 DEBUG ECN probing: sent 6 probes
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.654 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] pn=5 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 3584, len: >>1194, fin: false }
server  | 1.654 DEBUG packet_sent this=0x563616286590, pn=5, ps=1232
server  | 1.654 DEBUG ECN probing: sent 7 probes
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.654 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.654 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] delay duration 1.792645ms
server  | 1.654 DEBUG Setting timeout of 1.792645ms
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.654 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.654 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.654 DEBUG [Server 87c951bae10ae5f7] delay duration 1.776425ms
server  | 1.654 DEBUG Setting timeout of 1.776425ms
server  | 1.657 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.657 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.657 DEBUG [Server 87c951bae10ae5f7] pn=6 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 4778, len: >>1194, fin: false }
server  | 1.657 DEBUG packet_sent this=0x563616286590, pn=6, ps=1232
server  | 1.657 DEBUG ECN probing: sent 8 probes
server  | 1.657 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.657 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.657 DEBUG [Server 87c951bae10ae5f7] pn=7 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 5972, len: >>1194, fin: false }
server  | 1.657 DEBUG packet_sent this=0x563616286590, pn=7, ps=1232
server  | 1.657 DEBUG ECN probing: sent 9 probes
server  | 1.658 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.658 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.658 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.658 DEBUG [Server 87c951bae10ae5f7] delay duration 1.791052ms
server  | 1.658 DEBUG Setting timeout of 1.791052ms
server  | 1.658 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.658 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.658 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.658 DEBUG [Server 87c951bae10ae5f7] delay duration 1.7689ms
server  | 1.658 DEBUG Setting timeout of 1.7689ms
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.660 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] pn=8 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 7166, len: >>1194, fin: false }
server  | 1.660 DEBUG packet_sent this=0x563616286590, pn=8, ps=1232
server  | 1.660 DEBUG ECN probing: sent 10 probes
server  | 1.660 DEBUG ECN probing concluded with 10 probes sent
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1092, pto: None, probe: EnumSet(), paced: false }
server  | 1.660 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] pn=9 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 1092
server  |   TX -> Stream { stream_id: 0, offset: 8360, len: >>1054, fin: false }
server  | 1.660 DEBUG packet_sent this=0x563616286590, pn=9, ps=1092
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.660 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.660 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] delay duration 8.745385ms
server  | 1.660 DEBUG Setting timeout of 8.745385ms
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.660 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.660 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.660 DEBUG [Server 87c951bae10ae5f7] delay duration 8.724175ms
server  | 1.660 DEBUG Setting timeout of 8.724175ms
server  | 1.670 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.670 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.670 DEBUG [Server 87c951bae10ae5f7] pn=10 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 43
server  |   TX -> Ack { largest_acknowledged: 0, ack_delay: 2678, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  | 1.670 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.670 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.670 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.670 DEBUG [Server 87c951bae10ae5f7] delay duration 107.568978ms
server  | 1.670 DEBUG Setting timeout of 107.568978ms
server  | 1.670 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.670 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.670 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.670 DEBUG [Server 87c951bae10ae5f7] delay duration 107.547077ms
server  | 1.670 DEBUG Setting timeout of 107.547077ms
server  | 1.673 WARN [Server ...] Dropped received packet: State Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 298, tv_nsec: 31468070 } }; Total: 1
server  | 1.673 DEBUG Setting timeout of 197.79279ms
server  | 1.673 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.673 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.673 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.673 DEBUG [Server 87c951bae10ae5f7] delay duration 104.32776ms
server  | 1.673 DEBUG Setting timeout of 104.32776ms
server  | 1.682 DEBUG [Server 87c951bae10ae5f7] pn=1 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1472
server  |   -> RX Ping
server  |   -> RX Padding { len: 1443 }
server  | 1.682 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 842763256 }
server  | 1.682 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 842763256 }
server  | 1.682 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.682 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.682 DEBUG [Server 87c951bae10ae5f7] pn=11 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 42
server  |   TX -> Ack { largest_acknowledged: 1, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 2, Ce: 0})) }
server  | 1.682 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.682 DEBUG Building Short dcid Some(CID [16]: f71b7b852e694c5c9cee7626b8438209)
server  | 1.682 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.682 DEBUG [Server 87c951bae10ae5f7] delay duration 95.1098ms
server  | 1.682 DEBUG Setting timeout of 95.1098ms
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] pn=2 type=Short pri-path:f71b7b852e694c5c9cee7626b8438209 [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 147
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 87, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX NewConnectionId { sequence_number: 1, retire_prior: 1, connection_id: [207, 198, 144, 69, 136, 219, 34, 221, 249, 35, 175, 111, 79, 222, 101, 127], stateless_reset_token: [49, 116, 90, 224, 110, 249, 188, 152, 155, 12, 122, 153, 87, 238, 128, 8] }
server  |   -> RX NewConnectionId { sequence_number: 2, retire_prior: 1, connection_id: [89, 64, 143, 214, 132, 30, 149, 127, 51, 130, 211, 65, 40, 174, 229, 73], stateless_reset_token: [118, 40, 189, 207, 162, 188, 174, 7, 208, 106, 87, 45, 157, 234, 5, 30] }
server  |   -> RX NewConnectionId { sequence_number: 3, retire_prior: 1, connection_id: [130, 104, 123, 183, 211, 22, 235, 237, 2, 214, 202, 11, 16, 163, 225, 9], stateless_reset_token: [164, 92, 135, 241, 73, 198, 110, 19, 174, 32, 145, 224, 190, 140, 112, 111] }
server  |   -> RX RetireConnectionId { sequence_number: 0 }
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[0..=0]
server  | 1.683 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=0
server  | 1.683 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 11048/13592 ssthresh 18446744073709551615] slow start += 1272
server  | 1.683 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 11048/13592 ssthresh 18446744073709551615] on_packets_acked this=0x563616286590, limited=0, bytes_in_flight=11048, cwnd=13592, state=SlowStart, new_acked=1272
server  | 1.683 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 862945988 }
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.683 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.683 DEBUG CRYPTO for ap offset=0, len=305
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] pn=12 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 1207
server  |   TX -> NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [13, 73, 180, 94, 243, 250, 247, 39, 116, 59], stateless_reset_token: [223, 84, 48, 215, 101, 9, 93, 115, 245, 24, 49, 116, 110, 92, 249, 79] }
server  |   TX -> RetireConnectionId { sequence_number: 0 }
server  |   TX -> Stream { stream_id: 0, offset: 9414, len: 826, fin: true }
server  |   TX -> Crypto { offset: 0, len: 305 }
server  | 1.683 DEBUG packet_sent this=0x563616286590, pn=12, ps=1207
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.683 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] pn=13 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 79
server  |   TX -> NewToken { token: [173, 154, 139, 141, 134, 1, 0, 77, 62, 199, 31, 173, 178, 42, 61, 202, 7, 76, 111, 192, 246, 115, 28, 144, 192, 183, 8, 204, 193, 96, 152, 237, 96, 38, 126, 244, 241, 222, 125, 165, 84, 88, 251] }
server  | 1.683 DEBUG packet_sent this=0x563616286590, pn=13, ps=79
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.683 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.683 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] delay duration 19.560518ms
server  | 1.683 DEBUG Setting timeout of 19.560518ms
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.683 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.683 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.683 DEBUG [Server 87c951bae10ae5f7] delay duration 19.536574ms
server  | 1.683 DEBUG Setting timeout of 19.536574ms
client  | Request /kqrsgnjbsm completed successfully
server  | 1.704 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.704 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.704 DEBUG [Server 87c951bae10ae5f7] pn=14 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 43
server  |   TX -> Ack { largest_acknowledged: 2, ack_delay: 2695, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  | 1.704 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.704 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.704 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.704 DEBUG [Server 87c951bae10ae5f7] delay duration 84.740912ms
server  | 1.704 DEBUG Setting timeout of 84.740912ms
server  | 1.704 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.704 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.704 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.704 DEBUG [Server 87c951bae10ae5f7] delay duration 84.715424ms
server  | 1.704 DEBUG Setting timeout of 84.715424ms
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] pn=3 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 10, ack_delay: 963, first_ack_range: 10, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[0..=10]
server  | 1.709 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=10
server  | 1.709 INFO ECN validation succeeded, path is capable
server  | 1.709 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 1286/24640 ssthresh 18446744073709551615] slow start += 11048
server  | 1.709 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 1286/24640 ssthresh 18446744073709551615] on_packets_acked this=0x563616286590, limited=0, bytes_in_flight=1286, cwnd=24640, state=SlowStart, new_acked=11048
server  | 1.709 DEBUG PMTUD probe of size 1380 succeeded
server  | 1.709 DEBUG PMTUD started with probe size 1420
server  | 1.709 DEBUG PLPMTU changed from 1232 to 1332, updating pacer
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.709 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.709 DEBUG Sending PMTUD probe of size 1420, count 1
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] pn=15 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1372
server  |   TX -> Ping
server  |   TX -> Padding { len: 1337 }
server  | 1.709 DEBUG packet_sent this=0x563616286590, pn=15, ps=1372
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.709 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.709 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] delay duration 96.965189ms
server  | 1.709 DEBUG Setting timeout of 96.965189ms
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.709 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.709 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.709 DEBUG [Server 87c951bae10ae5f7] delay duration 96.932147ms
server  | 1.709 DEBUG Setting timeout of 96.932147ms
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] pn=5 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 15, ack_delay: 24, first_ack_range: 14, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 10, Ce: 0})) }
server  |   -> RX Padding { len: 11 }
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[1..=15]
server  | 1.741 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=15
server  | 1.741 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 0/27298 ssthresh 18446744073709551615] slow start += 2658
server  | 1.741 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 0/27298 ssthresh 18446744073709551615] on_packets_acked this=0x563616286590, limited=0, bytes_in_flight=0, cwnd=27298, state=SlowStart, new_acked=2658
server  | 1.741 DEBUG PMTUD probe of size 1420 succeeded
server  | 1.741 DEBUG PMTUD started with probe size 1470
server  | 1.741 DEBUG PLPMTU changed from 1332 to 1372, updating pacer
server  | 1.741 DEBUG Acked crypto frame space=ap offset=0 length=305
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.741 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.741 DEBUG Sending PMTUD probe of size 1470, count 1
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] pn=16 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1422
server  |   TX -> Ping
server  |   TX -> MaxStreams { stream_type: BiDi, maximum_streams: 17 }
server  |   TX -> Padding { len: 1385 }
server  | 1.741 DEBUG packet_sent this=0x563616286590, pn=16, ps=1422
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.741 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.741 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] delay duration 92.208442ms
server  | 1.741 DEBUG Setting timeout of 92.208442ms
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.741 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.741 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 1.741 DEBUG [Server 87c951bae10ae5f7] delay duration 92.172003ms
server  | 1.741 DEBUG Setting timeout of 92.172003ms
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] pn=6 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 16, ack_delay: 3226, first_ack_range: 15, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[1..=16]
server  | 1.800 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=16
server  | 1.800 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=0, cwnd=27298, state=SlowStart, new_acked=1422
server  | 1.800 DEBUG PMTUD probe of size 1470 succeeded
server  | 1.800 DEBUG PMTUD started with probe size 1500
server  | 1.800 DEBUG PLPMTU changed from 1372 to 1422, updating pacer
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.800 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.800 DEBUG Sending PMTUD probe of size 1500, count 1
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] pn=17 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 1452
server  |   TX -> Ping
server  |   TX -> Padding { len: 1417 }
server  | 1.800 DEBUG packet_sent this=0x563616286590, pn=17, ps=1452
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.800 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.800 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] delay duration 87.090172ms
server  | 1.800 DEBUG Setting timeout of 71.128839ms
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.800 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.800 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.800 DEBUG [Server 87c951bae10ae5f7] delay duration 87.056008ms
server  | 1.800 DEBUG Setting timeout of 71.094675ms
server  | 1.831 DEBUG [Server 87c951bae10ae5f7] pn=8 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 47
server  |   -> RX Ack { largest_acknowledged: 16, ack_delay: 7146, first_ack_range: 15, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.831 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[1..=16]
server  | 1.831 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 991740154 }
server  | 1.831 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 991740154 }
server  | 1.831 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.831 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.831 DEBUG [Server 87c951bae10ae5f7] pn=18 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 46
server  |   TX -> Ack { largest_acknowledged: 8, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 1 }, AckRange { gap: 0, range: 3 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  | 1.831 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.831 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.832 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] delay duration 55.505405ms
server  | 1.832 DEBUG Setting timeout of 39.544072ms
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] pn=10 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 47
server  |   -> RX Ack { largest_acknowledged: 16, ack_delay: 7146, first_ack_range: 15, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[1..=16]
server  | 1.832 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 297, tv_nsec: 991982809 }
server  | 1.832 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 297, tv_nsec: 991982809 }
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.832 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] pn=19 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 48
server  |   TX -> Ack { largest_acknowledged: 10, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }, AckRange { gap: 0, range: 1 }, AckRange { gap: 0, range: 3 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.832 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.832 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] delay duration 55.306662ms
server  | 1.832 DEBUG Setting timeout of 39.345329ms
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.832 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.832 DEBUG TX blocked, profile=SendProfile { limit: 1422, pto: None, probe: EnumSet(), paced: false }
server  | 1.832 DEBUG [Server 87c951bae10ae5f7] delay duration 55.274522ms
server  | 1.832 DEBUG Setting timeout of 39.313189ms
server  | 1.859 DEBUG [Server 87c951bae10ae5f7] pn=11 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, NotEct) len 47
server  |   -> RX Ack { largest_acknowledged: 17, ack_delay: 3341, first_ack_range: 16, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 12, Ce: 0})) }
server  |   -> RX Padding { len: 10 }
server  | 1.859 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[1..=17]
server  | 1.859 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=17
server  | 1.859 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=0, cwnd=27298, state=SlowStart, new_acked=1452
server  | 1.859 DEBUG PMTUD probe of size 1500 succeeded
server  | 1.859 INFO PMTUD stopped, PLPMTU is now 1500, raise timer Some(Instant { tv_sec: 898, tv_nsec: 19238053 })
server  | 1.859 DEBUG PLPMTU changed from 1422 to 1452, updating pacer
server  | 1.859 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.859 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.859 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.859 DEBUG [Server 87c951bae10ae5f7] delay duration 30s
server  | 1.859 DEBUG Setting timeout of 30s
server  | 1.859 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.859 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.859 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.859 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999867052s
server  | 1.859 DEBUG Setting timeout of 12.097069ms
server  | 1.872 DEBUG [Server 8e225fa50f7d0c5b] State change from Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 298, tv_nsec: 31468070 } } -> Closed(Transport(PeerError(0)))
server  | 1.872 INFO Closing timer expired
server  | 1.872 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.872 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.872 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.872 DEBUG [Server 87c951bae10ae5f7] delay duration 29.986750614s
server  | 1.872 DEBUG Setting timeout of 29.986750614s
server  | 1.872 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.872 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.872 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.872 DEBUG [Server 87c951bae10ae5f7] delay duration 29.986476051s
server  | 1.872 DEBUG Setting timeout of 29.986476051s
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] pn=14 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 19, ack_delay: 12596, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 14, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[17..=19]
server  | 1.965 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=19
server  | 1.965 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=0, cwnd=27298, state=SlowStart, new_acked=0
server  | 1.965 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 125107045 }
server  | 1.965 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 298, tv_nsec: 125107045 }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] pn=20 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 44
server  |   TX -> Ack { largest_acknowledged: 14, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 1, range: 1 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.965 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999794987s
server  | 1.965 DEBUG Setting timeout of 29.999794987s
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] pn=16 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 19, ack_delay: 12596, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 14, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[17..=19]
server  | 1.965 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 125348026 }
server  | 1.965 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 298, tv_nsec: 125348026 }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] pn=21 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 46
server  |   TX -> Ack { largest_acknowledged: 16, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }, AckRange { gap: 1, range: 1 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 8, Ce: 0})) }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.965 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999875758s
server  | 1.965 DEBUG Setting timeout of 29.999875758s
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 1.965 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 1.965 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999849519s
server  | 1.965 DEBUG Setting timeout of 29.999849519s
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] pn=19 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 21, ack_delay: 11346, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 16, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[20..=21]
server  | 2.087 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=21
server  | 2.087 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=0, cwnd=27298, state=SlowStart, new_acked=0
server  | 2.087 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 247669366 }
server  | 2.087 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 298, tv_nsec: 247669366 }
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.087 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] pn=22 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 42
server  |   TX -> Ack { largest_acknowledged: 19, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.087 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.087 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999828099s
server  | 2.087 DEBUG Setting timeout of 29.999828099s
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] pn=21 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 21, ack_delay: 11346, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 16, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[20..=21]
server  | 2.087 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 247869340 }
server  | 2.087 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 298, tv_nsec: 247869340 }
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.087 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.087 DEBUG [Server 87c951bae10ae5f7] pn=23 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 44
server  |   TX -> Ack { largest_acknowledged: 21, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 10, Ce: 0})) }
server  | 2.088 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.088 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.088 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.088 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999891086s
server  | 2.088 DEBUG Setting timeout of 29.999891086s
server  | 2.088 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.088 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.088 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.088 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999840131s
server  | 2.088 DEBUG Setting timeout of 29.999840131s
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] pn=24 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 23, ack_delay: 10215, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 18, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[22..=23]
server  | 2.201 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=23
server  | 2.201 DEBUG on_packets_acked this=0x563616286590, limited=1, bytes_in_flight=0, cwnd=27298, state=SlowStart, new_acked=0
server  | 2.201 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 361245399 }
server  | 2.201 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 298, tv_nsec: 361245399 }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] pn=24 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 42
server  |   TX -> Ack { largest_acknowledged: 24, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.201 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999830513s
server  | 2.201 DEBUG Setting timeout of 29.999830513s
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] pn=26 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX Ack { largest_acknowledged: 23, ack_delay: 10215, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 18, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 9 }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] Rx ACK space=ap, ranges=[22..=23]
server  | 2.201 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 361447477 }
server  | 2.201 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 298, tv_nsec: 361447477 }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] pn=25 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 44
server  |   TX -> Ack { largest_acknowledged: 26, ack_delay: 0, first_ack_range: 0, ack_ranges: [AckRange { gap: 0, range: 0 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 12, Ce: 0})) }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.201 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999902999s
server  | 2.201 DEBUG Setting timeout of 29.999902999s
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.201 DEBUG TX blocked, profile=SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.201 DEBUG [Server 87c951bae10ae5f7] delay duration 29.999879725s
server  | 2.201 DEBUG Setting timeout of 29.999879725s
server  | 2.217 DEBUG [Server 87c951bae10ae5f7] pn=27 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 47
server  |   -> RX ConnectionClose { error_code: Transport(0), frame_type: 0, reason_phrase: "" }
server  |   -> RX Padding { len: 15 }
server  | 2.217 INFO [Server 87c951bae10ae5f7] ConnectionClose received. Error code: Transport(0) frame type 0 reason 
server  | 2.217 DEBUG [Server 87c951bae10ae5f7] State change from Confirmed -> Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 298, tv_nsec: 625419375 } }
server  | 2.217 DEBUG [Server 87c951bae10ae5f7] output_path send_profile SendProfile { limit: 1452, pto: None, probe: EnumSet(), paced: false }
server  | 2.218 DEBUG Building Short dcid Some(CID [16]: cfc6904588db22ddf923af6f4fde657f)
server  | 2.218 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 298, tv_nsec: 377845194 }
server  | 2.218 DEBUG [Server 87c951bae10ae5f7] pn=26 type=Short pri-path:cfc6904588db22ddf923af6f4fde657f [::]:443->[::ffff:193.167.0.100]:34467 IpTos(Cs0, Ect0) len 48
server  |   TX -> Ack { largest_acknowledged: 27, ack_delay: 0, first_ack_range: 1, ack_ranges: [AckRange { gap: 0, range: 0 }], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 13, Ce: 0})) }
server  |   TX -> ConnectionClose { error_code: Transport(0), frame_type: 28, reason_phrase: "" }
server  | 2.218 DEBUG Setting timeout of 247.353639ms
server  | 2.218 DEBUG Setting timeout of 247.337368ms
server  | 2.266 WARN [Server ...] Dropped received packet: State Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 298, tv_nsec: 625419375 } }; Total: 1
server  | 2.266 DEBUG Setting timeout of 199.218223ms
server  | 2.266 DEBUG Setting timeout of 199.176696ms
server  | 2.466 DEBUG [Server 87c951bae10ae5f7] State change from Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 298, tv_nsec: 625419375 } } -> Closed(Transport(PeerError(0)))
server  | 2.466 INFO Closing timer expired

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 08:44:06,053 Using the client's key log file.
2025-04-30 08:44:06,063 
2025-04-30 08:44:06,064 Using the client's key log file.
2025-04-30 08:44:06,064 Using the client's key log file.
2025-04-30 08:44:06,072 
2025-04-30 08:44:06,073 Using the client's key log file.
2025-04-30 08:44:06,073 Using the client's key log file.
2025-04-30 08:44:06,956 Check of downloaded files succeeded.