2025-04-30 10:23:55,627 Generated random file: cxufcwuitc of size: 5120
2025-04-30 10:23:55,627 Generated random file: yqmkcutgol of size: 10240
2025-04-30 10:23:55,627 Requests: https://server4:443/cxufcwuitc https://server4:443/yqmkcutgol
2025-04-30 10:23:55,686 
2025-04-30 10:23:55,687 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_md1y6hmw/ TESTCASE_SERVER=resumption TESTCASE_CLIENT=resumption WWW=/tmp/www_92lam0uc/ DOWNLOADS=/tmp/download_bvpzppqv/ SERVER_LOGS=/tmp/logs_server__887j_wg CLIENT_LOGS=/tmp/logs_client_o9y32em5 SCENARIO="simple-p2p --delay=15ms --bandwidth=10Mbps --queue=25" CLIENT=ghcr.io/ngtcp2/ngtcp2-interop:latest SERVER=ghcr.io/mozilla/neqo-qns:latest REQUESTS="https://server4:443/cxufcwuitc https://server4:443/yqmkcutgol"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 10:24:07,882  Container sim  Created
 Container client  Recreate
 Container server  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  | wait-for-it.sh: waiting 30 seconds for sim:57832
server  | Setting up routes...
server  | Actual changes:
server  | tx-checksum-ip-generic: off
server  | tx-tcp-segmentation: off [not requested]
server  | tx-tcp-ecn-segmentation: off [not requested]
server  | tx-tcp-mangleid-segmentation: off [not requested]
server  | tx-tcp6-segmentation: off [not requested]
server  | tx-udp-segmentation: off [not requested]
server  | tx-checksum-sctp: off
server  | Endpoint's IPv4 address is 193.167.100.100
server  | Endpoint's IPv6 address is fd00:cafe:cafe:100::100
server  | + 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.Mi3dmurgs5
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.Mi3dmurgs5
server  | Warning: output encryption option -nodes ignored with -export
server  | + pk12util -d sql:/neqo/db -i /tmp/tmp.Mi3dmurgs5 -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  |             64:bf:93:51:9f:17:fd:7b:90:50:7a:1b:01:a0:d4:f9:
server  |             e4:97:06:06
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 10:23:55 2025
server  |             Not After : Sat May 10 10:23:55 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:2e:a3:94:3e:4d:0e:40:ad:4c:b2:4e:fd:bb:db:e3:
server  |                     ca:23:2f:a6:57:59:aa:5c:92:35:2a:25:02:ba:26:39:
server  |                     c1:73:e3:cf:d9:4b:b0:a6:8d:2e:98:d6:81:57:70:01:
server  |                     65:a8:d7:2b:9d:6f:10:b5:6d:de:bc:cd:b2:83:95:3e:
server  |                     e6
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  |                 e0:f7:29:b4:05:f0:d5:de:a9:31:de:6f:6a:88:9a:35:
server  |                 19:db:74:0f
server  | 
server  |             Name: Certificate Authority Key Identifier
server  |             Key ID:
server  |                 9e:24:86:6d:1b:0f:4d:55:2a:cd:a9:e1:60:e6:75:6e:
server  |                 ea:3b:a8:74
server  | 
server  |     Signature Algorithm: X9.62 ECDSA signature with SHA256
server  |     Signature:
server  |         30:44:02:20:08:5c:01:8c:d6:53:b6:46:f6:f1:28:4c:
server  |         b1:cf:46:5d:5d:e8:10:d9:2f:45:96:fc:fe:5d:e2:7e:
server  |         1d:8b:b5:4a:02:20:12:9a:84:59:5c:bb:99:59:ad:0e:
server  |         45:fc:da:eb:ce:2b:2c:b1:89:ae:70:3f:c0:9d:aa:42:
server  |         4d:02:4a:2d:0e:7f
server  |     Fingerprint (SHA-256):
server  |         A3:4C:FD:35:99:93:3A:0D:43:EF:05:27:7A:45:21:B7:34:86:6D:89:87:B5:82:53:76:3B:E7:B0:4D:7B:14:86
server  |     Fingerprint (SHA1):
server  |         43:7F:E6:5C:8C:4C:34:BB:52:5A:62:04:25:5D:BC:8D:D6:4B:E1:76
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.741 DEBUG [Server] Unsupported version: 57414954
server  | 0.741 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:35628 IpTos(Cs0, NotEct) len 15
sim     | server:443 is available after 1.010288848s
server  | 0.741 DEBUG [Server] Unsupported version: 57414954
server  | 0.741 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:35628 IpTos(Cs0, NotEct) len 15
server  | 0.741 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
server  | 0.741 DEBUG [Server] Unsupported version: 57414954
server  | 0.741 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:35628 IpTos(Cs0, NotEct) len 15
server  | 0.741 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
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
server  | 1.038 DEBUG [Server] Handle initial
server  | 1.038 INFO AddressValidation: no token; accepting
server  | 1.038 INFO [Server] Accept connection CID [18]: b7cab04acaee315d30ae5a97055240f6827a
server  | 1.038 DEBUG Overwrite initial version Version1 ==> Version1
server  | 1.039 DEBUG Outbound interface eth0 for destination ::ffff:193.167.0.100 has MTU 1500
server  | 1.039 INFO [Server ...] Received valid Initial packet with scid CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9 dcid CID [18]: b7cab04acaee315d30ae5a97055240f6827a
server  | 1.039 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Server dcid=b7cab04acaee315d30ae5a97055240f6827a
server  | 1.039 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.039 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.039 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] State change from Init -> WaitInitial
server  | 1.039 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236179 type=Initial unv-path [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1200
server  |   -> RX Crypto { offset: 0, len: 263 }
server  |   -> RX Padding { len: 866 }
server  | 1.039 DEBUG Read Ok(263) bytes
server  | 1.039 DEBUG 0-RTT: no token, no 0-RTT
server  | 1.040 DEBUG Read secret available for Handshake: SymKey [32]: 17cedb86be39d768132b37a9eabf9b2aec840670bebf3c5f27a67e07ff3243cd
server  | 1.040 DEBUG Write secret available for Handshake: SymKey [32]: 95f0b2c0cbfda93fae0ce6b11f60496efb03672b62a84cd1ec8b4d6bc133233d
server  | 1.040 DEBUG Writing transport parameters, msg=8
server  | 1.040 DEBUG Read secret available for ApplicationData: SymKey [32]: abfdc3b96c51eb3fd0d32f30cdb610e0560f995da347208e76e51dace0a5ae28
server  | 1.040 DEBUG Write secret available for ApplicationData: SymKey [32]: 5b43c4eb70b0a4d5270996e49dcfc60e1e9e9aee29f57c9bb784fc28fa1f8350
server  | 1.040 DEBUG [Agent 0x55ea60a551d0] state -> InProgress
server  | 1.040 DEBUG Making Write Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.040 DEBUG Making Read Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.040 DEBUG [Crypto] Handshake keys installed
server  | 1.040 DEBUG Making Write ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.040 DEBUG [Crypto] Application write key installed
server  | 1.040 DEBUG [Recvd-in] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 75669911 }
server  | 1.040 DEBUG [unv-path [::]:443->[::ffff:193.167.0.100]:46950] Make permanent
server  | 1.040 DEBUG [unv-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950] set as primary path
server  | 1.040 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] State change from WaitInitial -> Handshaking
server  | 1.040 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.040 DEBUG Building Initial dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.040 DEBUG CRYPTO for in offset=0, len=90
server  | 1.040 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=0 type=Initial pri-unv-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 159
server  |   TX -> Ack { largest_acknowledged: 456236179, 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: 90 }
server  | 1.040 DEBUG Building Handshake dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.040 DEBUG CRYPTO for hs offset=0, len=734
server  | 1.040 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=0 type=Handshake pri-unv-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 950
server  |   TX -> Crypto { offset: 0, len: 734 }
server  | 1.041 DEBUG packet_sent this=0x55ea60a54b40, pn=0, ps=791
server  | 1.041 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.041 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pad Initial from 950 to PLPMTU 1232
server  | 1.041 DEBUG packet_sent this=0x55ea60a54b40, pn=0, ps=441
server  | 1.041 DEBUG ECN probing: sent 1 probes
server  | 1.041 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.041 DEBUG Building Initial dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.041 DEBUG Building Handshake dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.041 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.041 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.041 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 296.95598ms
server  | 1.041 DEBUG Setting timeout of 296.95598ms
server  | 1.041 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.041 DEBUG Building Initial dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.041 DEBUG Building Handshake dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.041 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.041 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.041 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 296.917898ms
server  | 1.041 DEBUG Setting timeout of 296.917898ms
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236180 type=Initial pri-unv-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 64
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Rx ACK space=in, ranges=[0..=0]
server  | 1.075 DEBUG [LossRecovery] ACK for Initial - largest_acked=0
server  | 1.075 DEBUG on_packets_acked this=0x55ea60a54b40, limited=1, bytes_in_flight=791, cwnd=12320, state=SlowStart, new_acked=441
server  | 1.075 DEBUG Acked crypto frame space=in offset=0 length=90
server  | 1.075 DEBUG [pri-unv-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950] Path validated Instant { tv_sec: 261, tv_nsec: 113028559 }
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Drop packet number space in
server  | 1.075 DEBUG [LossRecovery] Reset loss recovery state for Initial
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236179 type=Handshake pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 105
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX Crypto { offset: 0, len: 36 }
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Rx ACK space=hs, ranges=[0..=0]
server  | 1.075 DEBUG [LossRecovery] ACK for Handshake - largest_acked=0
server  | 1.075 DEBUG on_packets_acked this=0x55ea60a54b40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=791
server  | 1.075 DEBUG Acked crypto frame space=hs offset=0 length=734
server  | 1.075 DEBUG Read Ok(36) bytes
server  | 1.075 DEBUG [Agent 0x55ea60a551d0] state -> Complete(SecretAgentInfo { version: 772, cipher: 4865, group: 29, resumed: false, early_data: false, ech_accepted: false, alpn: Some("hq-interop"), signature_scheme: 1027 })
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] TLS connection complete
server  | 1.075 DEBUG [pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950] Path validated Instant { tv_sec: 261, tv_nsec: 113028559 }
server  | 1.075 DEBUG Making Read ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.075 DEBUG [Crypto] application read keys installed
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] State change from Handshaking -> Connected
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] State change from Connected -> Confirmed
server  | 1.075 DEBUG PMTUD started with probe size 1380
server  | 1.075 INFO [Server b7cab04acaee315d30ae5a97055240f6827a] Connection established
server  | 1.075 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 113028559 }
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236179 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1031
server  |   -> RX NewConnectionId { sequence_number: 7, retire_prior: 0, connection_id: [159, 1, 68, 83, 172, 109, 131, 76, 220, 111, 65, 112, 179, 208, 130, 138, 168], stateless_reset_token: [115, 104, 158, 12, 32, 234, 145, 162, 222, 139, 210, 80, 95, 116, 7, 201] }
server  |   -> RX NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [236, 9, 106, 61, 80, 192, 206, 243, 220, 234, 65, 82, 121, 150, 51, 207, 240], stateless_reset_token: [76, 89, 52, 242, 88, 205, 93, 196, 133, 14, 209, 117, 34, 128, 239, 71] }
server  |   -> RX NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [107, 127, 215, 29, 5, 145, 6, 245, 75, 65, 178, 59, 219, 247, 7, 118, 115], stateless_reset_token: [184, 44, 50, 238, 244, 45, 103, 253, 126, 187, 75, 28, 4, 128, 10, 249] }
server  |   -> RX NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [22, 16, 220, 104, 131, 53, 219, 134, 227, 188, 32, 23, 178, 145, 252, 137, 89], stateless_reset_token: [217, 10, 116, 102, 44, 164, 64, 152, 71, 129, 26, 171, 166, 247, 226, 67] }
server  |   -> RX NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [190, 66, 13, 58, 125, 69, 249, 83, 73, 25, 249, 169, 98, 208, 161, 48, 179], stateless_reset_token: [47, 16, 15, 47, 48, 200, 138, 232, 218, 255, 146, 79, 170, 146, 131, 248] }
server  |   -> RX NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [134, 93, 183, 219, 147, 72, 3, 125, 167, 167, 138, 34, 215, 50, 0, 134, 77], stateless_reset_token: [125, 112, 238, 142, 249, 195, 70, 141, 147, 103, 8, 156, 80, 202, 118, 51] }
server  |   -> RX NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [242, 131, 230, 75, 89, 159, 15, 115, 233, 168, 170, 148, 126, 145, 137, 250, 10], stateless_reset_token: [70, 177, 122, 69, 42, 70, 1, 115, 141, 170, 212, 207, 61, 17, 42, 230] }
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 17, fin: true }
server  |   -> RX Padding { len: 721 }
server  | 1.075 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 113028559 }
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG Building Handshake dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9) scid Some(CID [10]: 8ef9be0cd2532d3bf68d)
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=1 type=Handshake pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 64
server  |   TX -> Ack { largest_acknowledged: 456236179, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Drop packet number space hs
server  | 1.075 DEBUG [LossRecovery] Reset loss recovery state for Handshake
server  | 1.075 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=0 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ack { largest_acknowledged: 456236179, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   TX -> HandshakeDone
server  |   TX -> NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [66, 121, 190, 224, 171, 213, 160, 76, 215, 10], stateless_reset_token: [159, 207, 89, 198, 123, 167, 45, 92, 50, 183, 235, 237, 58, 116, 156, 80] }
server  |   TX -> NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [86, 81, 9, 44, 129, 79, 32, 16, 189, 169], stateless_reset_token: [251, 184, 162, 125, 134, 132, 90, 76, 83, 253, 120, 128, 11, 53, 133, 74] }
server  |   TX -> NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [71, 8, 94, 120, 86, 85, 114, 150, 218, 142], stateless_reset_token: [111, 10, 49, 243, 232, 156, 131, 221, 135, 128, 103, 47, 59, 211, 45, 138] }
server  |   TX -> NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [181, 11, 219, 247, 199, 111, 7, 52, 230, 8], stateless_reset_token: [197, 153, 118, 220, 81, 186, 129, 86, 116, 29, 119, 63, 111, 248, 28, 34] }
server  |   TX -> NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [175, 171, 74, 253, 240, 76, 212, 72, 246, 87], stateless_reset_token: [250, 113, 239, 55, 36, 47, 58, 194, 138, 108, 206, 249, 53, 196, 84, 92] }
server  |   TX -> NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [241, 226, 13, 180, 149, 186, 227, 84, 30, 86], stateless_reset_token: [228, 79, 172, 90, 150, 52, 33, 118, 255, 31, 66, 231, 248, 48, 202, 237] }
server  |   TX -> Padding { len: 1041 }
server  | 1.075 DEBUG packet_sent this=0x55ea60a54b40, pn=0, ps=1268
server  | 1.075 DEBUG ECN probing: sent 2 probes
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.075 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.075 DEBUG Sending PMTUD probe of size 1380, count 1
server  | 1.075 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=1 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ping
server  |   TX -> Padding { len: 1296 }
server  | 1.075 DEBUG packet_sent this=0x55ea60a54b40, pn=1, ps=1332
server  | 1.075 DEBUG ECN probing: sent 3 probes
server  | 1.076 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.076 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.076 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.076 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.469528ms
server  | 1.076 DEBUG Setting timeout of 1.469528ms
server  | 1.076 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] send session ticket 406d0012b7cab04acaee315d30ae5a97055240f6827a0104800075300408ffffffffffffffff0504801000000604801000000704801000000801100901100b01140e01080f0a8ef9be0cd2532d3bf68d110c000000017a5a7a0a000000016ab200c0000000ff02de1a0243e8200100686921
server  | 1.076 DEBUG Path = 'cxufcwuitc'
server  | 1.076 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.076 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.076 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.076 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 506.351µs
server  | 1.077 DEBUG Setting timeout of 506.351µs
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236180 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1406
server  |   -> RX Ping
server  |   -> RX Padding { len: 1374 }
server  | 1.077 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 261, tv_nsec: 114632728 }
server  | 1.077 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 114632728 }
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.077 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=2 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 46
server  |   TX -> Ack { largest_acknowledged: 456236180, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 2, Ce: 0})) }
server  | 1.077 DEBUG ECN probing: sent 4 probes
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.077 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=3 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 0, len: >>1195, fin: false }
server  | 1.077 DEBUG packet_sent this=0x55ea60a54b40, pn=3, ps=1232
server  | 1.077 DEBUG ECN probing: sent 5 probes
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.077 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.077 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.80879ms
server  | 1.077 DEBUG Setting timeout of 1.80879ms
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.077 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.077 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.077 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.788442ms
server  | 1.077 DEBUG Setting timeout of 1.788442ms
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.080 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=4 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 1195, len: >>1193, fin: false }
server  | 1.080 DEBUG packet_sent this=0x55ea60a54b40, pn=4, ps=1232
server  | 1.080 DEBUG ECN probing: sent 6 probes
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.080 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=5 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 2388, len: >>1193, fin: false }
server  | 1.080 DEBUG packet_sent this=0x55ea60a54b40, pn=5, ps=1232
server  | 1.080 DEBUG ECN probing: sent 7 probes
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.080 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.080 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.73546ms
server  | 1.080 DEBUG Setting timeout of 1.73546ms
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.080 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.080 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.080 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.713088ms
server  | 1.080 DEBUG Setting timeout of 1.713088ms
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.083 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=6 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 3581, len: >>1193, fin: false }
server  | 1.083 DEBUG packet_sent this=0x55ea60a54b40, pn=6, ps=1232
server  | 1.083 DEBUG ECN probing: sent 8 probes
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.083 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.083 DEBUG CRYPTO for ap offset=0, len=321
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=7 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 757
server  |   TX -> Stream { stream_id: 0, offset: 4774, len: 346, fin: true }
server  |   TX -> Crypto { offset: 0, len: 321 }
server  |   TX -> NewToken { token: [173, 154, 139, 141, 134, 1, 0, 220, 27, 108, 242, 227, 0, 3, 171, 62, 170, 21, 116, 125, 245, 223, 113, 192, 240, 213, 134, 240, 2, 30, 97, 123, 152, 99, 162, 158, 73, 146, 149, 97, 95, 48, 208] }
server  | 1.083 DEBUG packet_sent this=0x55ea60a54b40, pn=7, ps=757
server  | 1.083 DEBUG ECN probing: sent 9 probes
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.083 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.083 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.505388ms
server  | 1.083 DEBUG Setting timeout of 1.505388ms
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.083 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.083 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.083 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 1.48489ms
server  | 1.083 DEBUG Setting timeout of 1.48489ms
server  | 1.086 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.086 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 115.222567ms
server  | 1.086 DEBUG Setting timeout of 115.222567ms
server  | 1.086 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.086 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.086 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 115.196478ms
server  | 1.086 DEBUG Setting timeout of 115.196478ms
server  | 1.109 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236181 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1444
server  |   -> RX Ping
server  |   -> RX Padding { len: 1415 }
server  | 1.109 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 261, tv_nsec: 147547980 }
server  | 1.109 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 147547980 }
server  | 1.109 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.109 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=8 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 46
server  |   TX -> Ack { largest_acknowledged: 456236181, ack_delay: 0, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  | 1.110 DEBUG ECN probing: sent 10 probes
server  | 1.110 DEBUG ECN probing concluded with 10 probes sent
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.110 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 91.947329ms
server  | 1.110 DEBUG Setting timeout of 91.947329ms
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236182 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 2, ack_delay: 6, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Rx ACK space=ap, ranges=[0..=2]
server  | 1.110 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=2
server  | 1.110 INFO ECN validation succeeded, path is capable
server  | 1.110 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 5685/14920 ssthresh 18446744073709551615] slow start += 2600
server  | 1.110 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 5685/14920 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60a54b40, limited=0, bytes_in_flight=5685, cwnd=14920, state=SlowStart, new_acked=2600
server  | 1.110 DEBUG PMTUD probe of size 1380 succeeded
server  | 1.110 DEBUG PMTUD started with probe size 1420
server  | 1.110 DEBUG PLPMTU changed from 1232 to 1332, updating pacer
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.110 DEBUG Sending PMTUD probe of size 1420, count 1
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=9 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 1372
server  |   TX -> Ping
server  |   TX -> Padding { len: 1336 }
server  | 1.110 DEBUG packet_sent this=0x55ea60a54b40, pn=9, ps=1372
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.110 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 107.758991ms
server  | 1.110 DEBUG Setting timeout of 107.758991ms
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.110 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.110 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 107.706223ms
server  | 1.110 DEBUG Setting timeout of 107.706223ms
server  | 1.111 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236183 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 4, ack_delay: 6, first_ack_range: 4, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 5, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.111 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Rx ACK space=ap, ranges=[0..=4]
server  | 1.111 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=4
server  | 1.111 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 4593/17384 ssthresh 18446744073709551615] slow start += 2464
server  | 1.111 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 4593/17384 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60a54b40, limited=0, bytes_in_flight=4593, cwnd=17384, state=SlowStart, new_acked=2464
server  | 1.111 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.111 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.111 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.111 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 99.470846ms
server  | 1.111 DEBUG Setting timeout of 99.470846ms
server  | 1.111 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.111 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.111 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.111 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 99.411966ms
server  | 1.111 DEBUG Setting timeout of 99.411966ms
server  | 1.115 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236184 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 6, ack_delay: 7, first_ack_range: 6, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.115 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] Rx ACK space=ap, ranges=[0..=6]
server  | 1.115 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=6
server  | 1.115 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 2129/19848 ssthresh 18446744073709551615] slow start += 2464
server  | 1.115 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 2129/19848 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60a54b40, limited=0, bytes_in_flight=2129, cwnd=19848, state=SlowStart, new_acked=2464
server  | 1.115 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.115 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.115 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.115 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 90.047482ms
server  | 1.115 DEBUG Setting timeout of 90.047482ms
server  | 1.115 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.115 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.115 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.115 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] delay duration 89.975868ms
server  | 1.115 DEBUG Setting timeout of 89.975868ms
server  | 1.116 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=456236185 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 39
server  |   -> RX ConnectionClose { error_code: Transport(0), frame_type: 0, reason_phrase: "" }
server  |   -> RX Padding { len: 7 }
server  | 1.116 INFO [Server b7cab04acaee315d30ae5a97055240f6827a] ConnectionClose received. Error code: Transport(0) frame type 0 reason 
server  | 1.116 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] State change from Confirmed -> Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 261, tv_nsec: 439282823 } }
server  | 1.116 DEBUG [pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950] Path validated Instant { tv_sec: 261, tv_nsec: 153821036 }
server  | 1.116 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.116 DEBUG Building Short dcid Some(CID [17]: ba659cc9c5f1c336541c82bf2e6af192d9)
server  | 1.116 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 261, tv_nsec: 153821036 }
server  | 1.116 DEBUG [Server b7cab04acaee315d30ae5a97055240f6827a] pn=10 type=Short pri-path:ba659cc9c5f1c336541c82bf2e6af192d9 [::]:443->[::ffff:193.167.0.100]:46950 IpTos(Cs0, Ect0) len 50
server  |   TX -> Ack { largest_acknowledged: 456236185, ack_delay: 0, first_ack_range: 6, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  |   TX -> ConnectionClose { error_code: Transport(0), frame_type: 28, reason_phrase: "" }
server  | 1.116 DEBUG Setting timeout of 285.295755ms
server  | 1.116 DEBUG Setting timeout of 285.260008ms
server  | 1.192 DEBUG [Server] Handle initial
server  | 1.192 INFO AddressValidation: no token; accepting
server  | 1.192 INFO [Server] Accept connection CID [18]: b31bf03a60034375fb04b6ccdb6a274a4bd3
server  | 1.192 DEBUG Overwrite initial version Version1 ==> Version1
server  | 1.193 DEBUG Outbound interface eth0 for destination ::ffff:193.167.0.100 has MTU 1500
server  | 1.193 INFO [Server ...] Received valid Initial packet with scid CID [17]: 883cacb4a465e02e177f9577c5fb205355 dcid CID [18]: b31bf03a60034375fb04b6ccdb6a274a4bd3
server  | 1.193 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Server dcid=b31bf03a60034375fb04b6ccdb6a274a4bd3
server  | 1.193 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.193 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.193 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] State change from Init -> WaitInitial
server  | 1.193 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572133 type=Initial unv-path [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1200
server  |   -> RX Crypto { offset: 0, len: 600 }
server  |   -> RX Padding { len: 529 }
server  | 1.193 DEBUG Read Ok(600) bytes
server  | 1.193 INFO 0-RTT: transport parameters OK, passing to application checker
server  | 1.193 WARN AllowZeroRtt accepting 0-RTT
server  | 1.194 DEBUG Read secret available for Handshake: SymKey [32]: bebede5bd4502a0d4fd040a15f0e9a585ebc402d6e63fc356d1e0b5a0a694659
server  | 1.194 DEBUG Write secret available for Handshake: SymKey [32]: c3b6da4b5b3b7f08b57e02b677f6aefd5229f44c43f7b40891ed287482648c16
server  | 1.194 DEBUG Writing transport parameters, msg=8
server  | 1.194 DEBUG Read secret available for ApplicationData: SymKey [32]: d171656b18440c7ee0feffbb69ba64f7eacd6461c0feb4f850bc9b14226d220c
server  | 1.194 DEBUG Write secret available for ApplicationData: SymKey [32]: 76bf32fa55554fb1d527307952f1a026eff66de9c3d6a3c9e984cb5a9cbb88c1
server  | 1.194 DEBUG [Agent 0x55ea60aac460] state -> InProgress
server  | 1.194 DEBUG Making Write Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.194 DEBUG Making Read Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.194 DEBUG [Crypto] Handshake keys installed
server  | 1.194 DEBUG Making Write ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.194 DEBUG [Crypto] Application write key installed
server  | 1.194 DEBUG [Recvd-in] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 229766826 }
server  | 1.194 DEBUG [unv-path [::]:443->[::ffff:193.167.0.100]:35522] Make permanent
server  | 1.194 DEBUG [unv-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522] set as primary path
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] State change from WaitInitial -> Handshaking
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.194 DEBUG Building Initial dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.194 DEBUG CRYPTO for in offset=0, len=96
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=0 type=Initial pri-unv-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 169
server  |   TX -> Ack { largest_acknowledged: 1844572133, 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: 96 }
server  | 1.194 DEBUG Building Handshake dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.194 DEBUG CRYPTO for hs offset=0, len=186
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=0 type=Handshake pri-unv-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 412
server  |   TX -> Crypto { offset: 0, len: 186 }
server  | 1.194 DEBUG packet_sent this=0x55ea60992840, pn=0, ps=243
server  | 1.194 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pad Initial from 412 to PLPMTU 1232
server  | 1.194 DEBUG packet_sent this=0x55ea60992840, pn=0, ps=989
server  | 1.194 DEBUG ECN probing: sent 1 probes
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.194 DEBUG Building Initial dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.194 DEBUG Building Handshake dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.194 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.194 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 297.5524ms
server  | 1.194 DEBUG Setting timeout of 207.068397ms
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.194 DEBUG Building Initial dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.194 DEBUG Building Handshake dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.194 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.194 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.194 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 297.514749ms
server  | 1.194 DEBUG Setting timeout of 207.030746ms
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572134 type=Initial pri-unv-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 64
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=in, ranges=[0..=0]
server  | 1.228 DEBUG [LossRecovery] ACK for Initial - largest_acked=0
server  | 1.228 DEBUG on_packets_acked this=0x55ea60992840, limited=1, bytes_in_flight=243, cwnd=12320, state=SlowStart, new_acked=989
server  | 1.228 DEBUG Acked crypto frame space=in offset=0 length=96
server  | 1.228 DEBUG [pri-unv-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522] Path validated Instant { tv_sec: 261, tv_nsec: 266064779 }
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Drop packet number space in
server  | 1.228 DEBUG [LossRecovery] Reset loss recovery state for Initial
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572133 type=Handshake pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 105
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   -> RX Crypto { offset: 0, len: 36 }
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=hs, ranges=[0..=0]
server  | 1.228 DEBUG [LossRecovery] ACK for Handshake - largest_acked=0
server  | 1.228 DEBUG on_packets_acked this=0x55ea60992840, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=243
server  | 1.228 DEBUG Acked crypto frame space=hs offset=0 length=186
server  | 1.228 DEBUG Read Ok(36) bytes
server  | 1.228 DEBUG [Agent 0x55ea60aac460] state -> Complete(SecretAgentInfo { version: 772, cipher: 4865, group: 29, resumed: true, early_data: false, ech_accepted: false, alpn: Some("hq-interop"), signature_scheme: 1027 })
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] TLS connection complete
server  | 1.228 DEBUG [pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522] Path validated Instant { tv_sec: 261, tv_nsec: 266064779 }
server  | 1.228 DEBUG Making Read ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.228 DEBUG [Crypto] application read keys installed
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] State change from Handshaking -> Connected
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] State change from Connected -> Confirmed
server  | 1.228 DEBUG PMTUD started with probe size 1380
server  | 1.228 INFO [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Connection established
server  | 1.228 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 266064779 }
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572133 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1031
server  |   -> RX NewConnectionId { sequence_number: 7, retire_prior: 0, connection_id: [70, 177, 61, 206, 36, 130, 105, 147, 254, 13, 26, 214, 80, 199, 171, 55, 213], stateless_reset_token: [128, 113, 173, 3, 36, 175, 139, 186, 156, 122, 112, 246, 162, 93, 185, 25] }
server  |   -> RX NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [24, 113, 110, 189, 34, 232, 64, 0, 204, 35, 33, 227, 64, 170, 54, 144, 132], stateless_reset_token: [165, 59, 133, 195, 218, 96, 105, 65, 113, 207, 98, 31, 44, 25, 129, 179] }
server  |   -> RX NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [160, 204, 13, 142, 99, 95, 26, 175, 73, 213, 1, 24, 147, 30, 160, 151, 223], stateless_reset_token: [109, 149, 107, 247, 222, 70, 182, 59, 245, 117, 98, 68, 61, 213, 94, 118] }
server  |   -> RX NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [207, 142, 24, 247, 13, 35, 26, 11, 213, 92, 89, 12, 141, 114, 46, 19, 131], stateless_reset_token: [130, 81, 26, 167, 233, 38, 23, 143, 183, 173, 22, 209, 230, 8, 193, 156] }
server  |   -> RX NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [158, 103, 232, 114, 247, 160, 234, 145, 206, 83, 198, 222, 23, 209, 249, 197, 231], stateless_reset_token: [129, 160, 170, 75, 215, 7, 142, 182, 183, 50, 64, 147, 94, 145, 138, 24] }
server  |   -> RX NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [171, 121, 25, 41, 159, 110, 105, 106, 191, 27, 128, 4, 211, 33, 103, 214, 34], stateless_reset_token: [113, 57, 11, 149, 4, 131, 241, 235, 197, 102, 2, 246, 188, 4, 226, 167] }
server  |   -> RX NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [116, 200, 130, 45, 91, 18, 104, 210, 98, 67, 242, 88, 187, 150, 42, 218, 125], stateless_reset_token: [167, 57, 48, 213, 235, 120, 122, 162, 245, 95, 226, 136, 89, 70, 113, 242] }
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 17, fin: true }
server  |   -> RX Padding { len: 721 }
server  | 1.228 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 266064779 }
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.228 DEBUG Building Handshake dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355) scid Some(CID [10]: 1a4656a6552eb20637f7)
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1 type=Handshake pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 68
server  |   TX -> Ack { largest_acknowledged: 1844572133, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Drop packet number space hs
server  | 1.228 DEBUG [LossRecovery] Reset loss recovery state for Handshake
server  | 1.228 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.228 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=0 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ack { largest_acknowledged: 1844572133, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 1, Ce: 0})) }
server  |   TX -> HandshakeDone
server  |   TX -> NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [230, 111, 60, 225, 60, 61, 230, 49, 15, 49], stateless_reset_token: [213, 113, 252, 120, 2, 130, 4, 59, 211, 168, 230, 119, 48, 209, 183, 237] }
server  |   TX -> NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [76, 215, 224, 147, 16, 101, 77, 89, 102, 30], stateless_reset_token: [209, 38, 129, 35, 155, 42, 64, 238, 137, 233, 158, 184, 213, 28, 134, 21] }
server  |   TX -> NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [193, 195, 206, 241, 45, 239, 101, 182, 208, 121], stateless_reset_token: [145, 223, 149, 23, 172, 78, 248, 170, 22, 226, 187, 131, 248, 114, 166, 168] }
server  |   TX -> NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [243, 123, 63, 177, 77, 4, 167, 103, 112, 191], stateless_reset_token: [198, 59, 217, 45, 243, 189, 4, 221, 174, 130, 192, 138, 143, 231, 228, 106] }
server  |   TX -> NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [130, 51, 82, 218, 224, 3, 50, 222, 143, 147], stateless_reset_token: [83, 234, 109, 46, 53, 191, 232, 193, 218, 183, 178, 182, 155, 171, 158, 10] }
server  |   TX -> NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [68, 225, 131, 205, 71, 43, 197, 111, 65, 182], stateless_reset_token: [79, 7, 210, 142, 138, 103, 209, 246, 170, 235, 28, 166, 148, 235, 39, 172] }
server  |   TX -> Padding { len: 1033 }
server  | 1.228 DEBUG packet_sent this=0x55ea60992840, pn=0, ps=1264
server  | 1.229 DEBUG ECN probing: sent 2 probes
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG Sending PMTUD probe of size 1380, count 1
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ping
server  |   TX -> Padding { len: 1296 }
server  | 1.229 DEBUG packet_sent this=0x55ea60992840, pn=1, ps=1332
server  | 1.229 DEBUG ECN probing: sent 3 probes
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.338772ms
server  | 1.229 DEBUG Setting timeout of 1.338772ms
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] send session ticket 406d0012b31bf03a60034375fb04b6ccdb6a274a4bd30104800075300408ffffffffffffffff0504801000000604801000000704801000000801100901100b01140e01080f0a1a4656a6552eb20637f7110c000000013a1aca0a000000016ab200c0000000ff02de1a0243e8200100686921
server  | 1.229 DEBUG Path = 'yqmkcutgol'
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.151401ms
server  | 1.229 DEBUG Setting timeout of 1.151401ms
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572134 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1406
server  |   -> RX Ping
server  |   -> RX Padding { len: 1374 }
server  | 1.229 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 261, tv_nsec: 267237388 }
server  | 1.229 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 267237388 }
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=2 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 50
server  |   TX -> Ack { largest_acknowledged: 1844572134, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 2, Ce: 0})) }
server  | 1.229 DEBUG ECN probing: sent 4 probes
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=3 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 0, len: >>1195, fin: false }
server  | 1.229 DEBUG packet_sent this=0x55ea60992840, pn=3, ps=1232
server  | 1.229 DEBUG ECN probing: sent 5 probes
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.730067ms
server  | 1.229 DEBUG Setting timeout of 1.730067ms
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.229 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.229 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.703708ms
server  | 1.229 DEBUG Setting timeout of 1.703708ms
server  | 1.231 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.231 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.231 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=4 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 1195, len: >>1193, fin: false }
server  | 1.231 DEBUG packet_sent this=0x55ea60992840, pn=4, ps=1232
server  | 1.231 DEBUG ECN probing: sent 6 probes
server  | 1.232 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.232 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.232 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.232 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.365669ms
server  | 1.232 DEBUG Setting timeout of 1.365669ms
server  | 1.232 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.232 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.232 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.232 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.34453ms
server  | 1.232 DEBUG Setting timeout of 1.34453ms
server  | 1.234 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.234 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.234 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=5 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 2388, len: >>1193, fin: false }
server  | 1.234 DEBUG packet_sent this=0x55ea60992840, pn=5, ps=1232
server  | 1.234 DEBUG ECN probing: sent 7 probes
server  | 1.234 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.234 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.234 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.234 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 961.539µs
server  | 1.234 DEBUG Setting timeout of 961.539µs
server  | 1.234 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.234 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.234 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.234 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 938.055µs
server  | 1.234 DEBUG Setting timeout of 938.055µs
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.236 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=6 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 3581, len: >>1193, fin: false }
server  | 1.236 DEBUG packet_sent this=0x55ea60992840, pn=6, ps=1232
server  | 1.236 DEBUG ECN probing: sent 8 probes
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.236 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=7 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 4774, len: >>1193, fin: false }
server  | 1.236 DEBUG packet_sent this=0x55ea60992840, pn=7, ps=1232
server  | 1.236 DEBUG ECN probing: sent 9 probes
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.236 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.236 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.749003ms
server  | 1.236 DEBUG Setting timeout of 1.749003ms
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.236 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.236 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.236 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 1.725619ms
server  | 1.236 DEBUG Setting timeout of 1.725619ms
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=8 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 5967, len: >>1193, fin: false }
server  | 1.239 DEBUG packet_sent this=0x55ea60992840, pn=8, ps=1232
server  | 1.239 DEBUG ECN probing: sent 10 probes
server  | 1.239 DEBUG ECN probing concluded with 10 probes sent
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=9 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, NotEct) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 7160, len: >>1193, fin: false }
server  | 1.239 DEBUG packet_sent this=0x55ea60992840, pn=9, ps=1232
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1100, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=10 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, NotEct) len 1100
server  |   TX -> Stream { stream_id: 0, offset: 8353, len: >>1061, fin: false }
server  | 1.239 DEBUG packet_sent this=0x55ea60992840, pn=10, ps=1100
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.239 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 115.670662ms
server  | 1.239 DEBUG Setting timeout of 115.670662ms
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.239 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.239 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 115.651446ms
server  | 1.239 DEBUG Setting timeout of 115.651446ms
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572135 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1444
server  |   -> RX Ping
server  |   -> RX Padding { len: 1415 }
server  | 1.263 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 261, tv_nsec: 300665488 }
server  | 1.263 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 261, tv_nsec: 300665488 }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=11 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, NotEct) len 50
server  |   TX -> Ack { largest_acknowledged: 1844572135, ack_delay: 0, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 92.271701ms
server  | 1.263 DEBUG Setting timeout of 92.271701ms
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572136 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 2, ack_delay: 5, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=ap, ranges=[0..=2]
server  | 1.263 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=2
server  | 1.263 INFO ECN validation succeeded, path is capable
server  | 1.263 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 9724/14916 ssthresh 18446744073709551615] slow start += 2596
server  | 1.263 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 9724/14916 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60992840, limited=0, bytes_in_flight=9724, cwnd=14916, state=SlowStart, new_acked=2596
server  | 1.263 DEBUG PMTUD probe of size 1380 succeeded
server  | 1.263 DEBUG PMTUD started with probe size 1420
server  | 1.263 DEBUG PLPMTU changed from 1232 to 1332, updating pacer
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG Sending PMTUD probe of size 1420, count 1
server  | 1.263 DEBUG CRYPTO for ap offset=0, len=321
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=12 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 1372
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 9414, len: 826, fin: true }
server  |   TX -> Crypto { offset: 0, len: 321 }
server  |   TX -> NewToken { token: [173, 154, 139, 141, 134, 1, 0, 147, 132, 251, 114, 149, 77, 165, 191, 101, 89, 146, 173, 41, 26, 36, 221, 137, 197, 177, 87, 180, 246, 132, 249, 64, 54, 4, 21, 248, 154, 60, 77, 83, 180, 81, 96] }
server  |   TX -> Padding { len: 134 }
server  | 1.263 DEBUG packet_sent this=0x55ea60992840, pn=12, ps=1372
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 104.093958ms
server  | 1.263 DEBUG Setting timeout of 104.093958ms
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 104.069933ms
server  | 1.263 DEBUG Setting timeout of 104.069933ms
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572137 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 4, ack_delay: 4, first_ack_range: 4, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 5, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=ap, ranges=[0..=4]
server  | 1.263 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=4
server  | 1.263 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 8632/17380 ssthresh 18446744073709551615] slow start += 2464
server  | 1.263 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 8632/17380 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60992840, limited=0, bytes_in_flight=8632, cwnd=17380, state=SlowStart, new_acked=2464
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 96.404553ms
server  | 1.263 DEBUG Setting timeout of 96.404553ms
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.263 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.263 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 96.337757ms
server  | 1.263 DEBUG Setting timeout of 96.337757ms
server  | 1.267 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572138 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 6, ack_delay: 7, first_ack_range: 6, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.267 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=ap, ranges=[0..=6]
server  | 1.267 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=6
server  | 1.267 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 6168/19844 ssthresh 18446744073709551615] slow start += 2464
server  | 1.267 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 6168/19844 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60992840, limited=0, bytes_in_flight=6168, cwnd=19844, state=SlowStart, new_acked=2464
server  | 1.267 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.267 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.267 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.267 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 86.656146ms
server  | 1.267 DEBUG Setting timeout of 86.656146ms
server  | 1.267 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.267 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.267 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.267 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 86.585734ms
server  | 1.267 DEBUG Setting timeout of 86.585734ms
server  | 1.271 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572139 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 8, ack_delay: 5, first_ack_range: 8, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.271 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=ap, ranges=[0..=8]
server  | 1.271 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=8
server  | 1.271 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 3704/22308 ssthresh 18446744073709551615] slow start += 2464
server  | 1.271 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 3704/22308 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60992840, limited=0, bytes_in_flight=3704, cwnd=22308, state=SlowStart, new_acked=2464
server  | 1.271 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.271 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.271 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.271 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 78.63116ms
server  | 1.271 DEBUG Setting timeout of 78.63116ms
server  | 1.271 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.271 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.271 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.271 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 78.575556ms
server  | 1.271 DEBUG Setting timeout of 78.575556ms
server  | 1.273 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572140 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 10, ack_delay: 4, first_ack_range: 10, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  |   -> RX Padding { len: 3 }
server  | 1.273 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] Rx ACK space=ap, ranges=[0..=10]
server  | 1.273 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=10
server  | 1.273 WARN ECN validation failed, no ECT(0) packets were newly acked
server  | 1.273 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 1372/24640 ssthresh 18446744073709551615] slow start += 2332
server  | 1.273 DEBUG [Cubic [last_max_cwnd: 0, k: 0, w_max: 0, ca_epoch_start: None] CongCtrl 1372/24640 ssthresh 18446744073709551615] on_packets_acked this=0x55ea60992840, limited=0, bytes_in_flight=1372, cwnd=24640, state=SlowStart, new_acked=2332
server  | 1.273 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.273 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.273 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.273 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 71.166396ms
server  | 1.273 DEBUG Setting timeout of 71.166396ms
server  | 1.273 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.273 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.273 DEBUG TX blocked, profile=SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.273 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] delay duration 71.106673ms
server  | 1.273 DEBUG Setting timeout of 71.106673ms
server  | 1.295 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=1844572141 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, Ect0) len 39
server  |   -> RX ConnectionClose { error_code: Transport(0), frame_type: 0, reason_phrase: "" }
server  |   -> RX Padding { len: 7 }
server  | 1.295 INFO [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] ConnectionClose received. Error code: Transport(0) frame type 0 reason 
server  | 1.295 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] State change from Confirmed -> Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 261, tv_nsec: 575921075 } }
server  | 1.295 DEBUG [pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522] Path validated Instant { tv_sec: 261, tv_nsec: 333143378 }
server  | 1.295 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 1.295 DEBUG Building Short dcid Some(CID [17]: 883cacb4a465e02e177f9577c5fb205355)
server  | 1.295 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 261, tv_nsec: 333143378 }
server  | 1.295 DEBUG [Server b31bf03a60034375fb04b6ccdb6a274a4bd3] pn=13 type=Short pri-path:883cacb4a465e02e177f9577c5fb205355 [::]:443->[::ffff:193.167.0.100]:35522 IpTos(Cs0, NotEct) len 54
server  |   TX -> Ack { largest_acknowledged: 1844572141, ack_delay: 0, first_ack_range: 8, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  |   TX -> ConnectionClose { error_code: Transport(0), frame_type: 28, reason_phrase: "" }
server  | 1.295 DEBUG Setting timeout of 105.973143ms
server  | 1.295 DEBUG Setting timeout of 105.963795ms

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

2025-04-30 10:24:07,982 Using the client's key log file.
2025-04-30 10:24:07,992 
2025-04-30 10:24:07,992 Using the client's key log file.
2025-04-30 10:24:07,992 Using the client's key log file.
2025-04-30 10:24:08,001 
2025-04-30 10:24:08,001 Using the client's key log file.
2025-04-30 10:24:08,001 Using the client's key log file.
2025-04-30 10:24:08,891 Check of downloaded files succeeded.