2025-04-30 10:29:59,072 Generated random file: ijffjdvfzb of size: 5120
2025-04-30 10:29:59,072 Requests: https://server4:443/ijffjdvfzb
2025-04-30 10:29:59,451 
2025-04-30 10:29:59,452 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_m2uf1z5b/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_f8kvjt6v/ DOWNLOADS=/tmp/download_3dc7gahe/ SERVER_LOGS=/tmp/logs_server_wunkrba3 CLIENT_LOGS=/tmp/logs_client_kk_21f3v SCENARIO="droplist --delay=15ms --bandwidth=10Mbps --queue=25 --drops_to_server=2,3,4,5,6,7" CLIENT=cloudflare/quiche-qns:latest SERVER=ghcr.io/mozilla/neqo-qns:latest REQUESTS="https://server4:443/ijffjdvfzb"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 10:30:12,875  Container sim  Recreate
 Container sim  Recreated
 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...
server  | 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
server  | Actual changes:
server  | tx-checksum-ip-generic: off
server  | tx-tcp-segmentation: off [not requested]
server  | tx-tcp-ecn-segmentation: off [not requested]
server  | tx-tcp-mangleid-segmentation: off [not requested]
server  | tx-tcp6-segmentation: off [not requested]
server  | tx-udp-segmentation: off [not requested]
server  | tx-checksum-sctp: off
client  | Endpoint's IPv4 address is 193.167.0.100
server  | Endpoint's IPv4 address is 193.167.100.100
client  | Endpoint's IPv6 address is fd00:cafe:cafe::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 transfer ']'
server  | + '[' -n /logs/qlog/ ']'
server  | + case "$ROLE" in
server  | + DB=/neqo/db
client  | supported
server  | + CERT=cert
server  | ++ mktemp
server  | + P12CERT=/tmp/tmp.Bae9Msm1R6
server  | + mkdir -p /neqo/db
server  | + certutil -N -d sql:/neqo/db --empty-password
client  | wait-for-it: waiting 30 seconds for sim:57832
server  | + openssl pkcs12 -export -nodes -in /certs/cert.pem -inkey /certs/priv.key -name cert -passout pass: -out /tmp/tmp.Bae9Msm1R6
server  | Warning: output encryption option -nodes ignored with -export
server  | + pk12util -d sql:/neqo/db -i /tmp/tmp.Bae9Msm1R6 -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  |             48:3b:84:75:0b:e1:67:15:c0:52:cd:79:5e:15:a5:80:
server  |             65:29:d2:39
server  |         Signature Algorithm: X9.62 ECDSA signature with SHA256
server  |         Issuer: "O=interop runner intermediate 8"
server  |         Validity:
server  |             Not Before: Wed Apr 30 10:29:59 2025
server  |             Not After : Sat May 10 10:29:59 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:6c:bc:c6:c7:5b:6e:76:33:d7:65:d3:a1:ad:4b:3c:
server  |                     d1:23:48:40:87:cb:d9:b4:2c:a1:36:bb:82:27:a8:08:
server  |                     ce:73:59:88:17:28:a6:ce:ea:25:e4:1e:cc:05:c1:2a:
server  |                     0b:79:f1:be:4d:e4:6c:00:6e:3e:cf:53:d6:0a:e9:c8:
server  |                     94
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  |             DNS name: "9OctUER5Qe1JmbLaTu5vlGVu0cAMjlAyd4H62TIOPgv6FL45J2yNqp
server  |                 RCrP2KMVQaXIq0nuHTKQaeRguZANEbpdyObt4n9f5D6pY1t4JgUzCTW7KH4jY
server  |                 7sBQhEwPs3JXM2wXEqNVAlYr7xFTrV6BOxEit5z9QgoP1Z2yRgoMCRXPKCU1v
server  |                 rDo4tQE5qG93O6yb1gSr6GSydmrOsCmJQDyIEj6H6DSdsRAzJcL0jCO2cU0AV
server  |                 vRjDVwlkrrjkH"
server  |             DNS name: "Z2Vz7SXIZZk5amV4sgZJIaYTVAU3eFCcYz0CgMDKwDdFrxGyHfqhEl
server  |                 KojqeO1GzmetjB7JqNc9ACOtz93R6s4FVawMUo9kFhY6j01AJPQyYZCvkO4FF
server  |                 gvTKfWax6nZTCQli7PuevX5SK8VnVHbYhuXUuGQIQnUqlJHeKkpKzcAlcDVbP
server  |                 noBWUNnpxdBEzs1Zw0Flz9CXf8BJ709rwt5eUuduyNFN56ok4CCojRc2a6X8K
server  |                 eGGtgimi4pqYr"
server  |             DNS name: "GhzZGccFM4wsSQbyFKARDLU9WYVgbHmJgMeUgG4lUquB8K8vyqR7fT
server  |                 bINplsgJBGSrlTyT4o2OlgotfyaDgX6tZpZRXBMsotaEpXuHuiu7mF6Iw7Hyt
server  |                 dyCkCVuHlTBrlle6zCRyMJNbeiPjAWFhXJJRGSLCNWXikewIp9fGciKmnLPWN
server  |                 gIQkzSl5do8AOsHUcxzGO6rPrEyJTjFNBdsBLRaWhZsGtXsjXZw5fk9iqZoN5
server  |                 hJv6jUZzw7w6d"
server  |             DNS name: "bUOnUGcFJSuTlWdY23F9sp7TMy3J82MnaLH5xiuU3ThysKhOpuri6a
server  |                 FrSgoX4Rw0cs7yBoN6SDDw0HhoODXr4eJviy5vRuT6xEhrSd5Vk2GcjSjHjT4
server  |                 VLRXn8t0uAfou1URjJiAKnTFYgOtrRQpZqomnTIu2pnPD0JXwQCvnvHUjPO8m
server  |                 bWEb2rvnYep4icJ0WY7kO275en7gfCEqZ4PztI74231g2K7LGMX7rmEwsSL5w
server  |                 h1HfW4STLxDlD"
server  |             DNS name: "LKwIONgK0sZHj09vEHYNz0M3fnEwVcqI3qunAS8OZHM9fkQy83hykW
server  |                 qEALMd6HOorhOJibojToFeIDrzu3OL2CczDZU70N7PDGHGyOMYBrlxVqJjTC9
server  |                 GFsgjixfhFaswqZOEJQEDe98QySE1OLbgUDlgWlXlWzNxhLLUD5sOnzPtsXnz
server  |                 QopEtqVO7Bv81r2KfQLua2E9e6VfQNAUhX0RUtkoSoJvsP9Yg9N7R6Pb3p9CL
server  |                 lQC0urh3wkUha"
server  |             DNS name: "t2WIEsFExKnl4H4b8d5qbhFYoG1jcwGjuWiXQOK1uPFxnb1TQ8XSXg
server  |                 vSioDA6NFUnhwyM1fxIRU3rGp3eQRuTas96jEZQn5TKG6FXhdZ5DXboUHXHQw
server  |                 6xonb7gGTK2bKDzInIX4SsmUzqU2AiziHMdrAI5G4mKMBnyBBwdJ7k03Y4wJI
server  |                 1HBeMfA3jttmsuPikFLTVI3XJ6389oHRvIXWJ6Ec48GsC4TCA3Du3XIEq7mub
server  |                 pyFnqhGJhE4Dy"
server  |             DNS name: "CQuYT15HdPc5gHhuUrGk6aXCdeS8avu7sh72bYA3hsbCuZbtC9a1Yr
server  |                 pvFSAlhFKIn11ucMh69Fz7fSQt1kndYnzZ2vcTq9RPyMV3RWWX1RBI9Dr2rLb
server  |                 4du6RmVsmUWQkmt4E2sv8ugBIvLa8iENNu9FNlwl7uXhuJ5UOyAl1ocfJY1xf
server  |                 VR0KlB0Gj1JoHZK5BLxWormmUZOQ77J05Sw0ybYkml9xLTXGCWN2pkiGMuumE
server  |                 DdaaFZeEkHfKK"
server  |             DNS name: "IpQVlIvKclFAVQUfjjzIuvCaOzR7CECshLb3W6v2xjMre0KtCO3oD9
server  |                 8TiEoKJS42GyoelxuGgQCzHsSvQRZDzhgiyDlf7Voph7HapVKekkA0BcpCzGy
server  |                 YE2RdYoyDlEqJar7qavHgVbj4JtQOCiopByCIlFHrbLdcR35MVAPfFaxG5MXh
server  |                 cLWZCt4pvyrrPQp3S5Ze27rOApXsnEm5jAnRF8P0WCnZYDazGuQWVMBwUnogu
server  |                 1jGWJmrDvRKpq"
server  |             DNS name: "441avMPyRg6teQ49i6pnWlK7fy45G0CQNvHG1XPtX3bfVwNWctyklG
server  |                 QDNA1E239lA80rRXP5NcsvFLcD7u6lEnxJSI9OxIGeMjRLDm1XbnCy16lRyoR
server  |                 bnjyHf7oXXawlUMvE0zgoCDpj6Dwp4DlXsZIeK6LkG8sVRc3L13VqIG4anScb
server  |                 IGL0LtdY24qbnh2ESl3IgU1DxAwmK39ze3CxvuQXwjGpxuVWNlgtmkjsLwzei
server  |                 0Z4W0BUVCqGg2"
server  |             DNS name: "VmUeGarslB0x3qUbSGMbMKTTgrN5pdw6R5SVWBiHsduPkyiw5Cn3KK
server  |                 Io6e4fIx9fl0tnDU1xlYzJXCfHr1yLkFhragqrK1tbq7OGAH3Am1D33wIm868
server  |                 CtCfgjJjMPG0215LdBkBduQfm9JdUG7xIDOcZIkzI7kLHcNR5xo6TFu0DoFcF
server  |                 I2sGhwr7SM5BaD3mFHT3PxhInIyEJQhDfNdIwVLA5GlsqfZB9ejOPmFPbzfYb
server  |                 pkIdXogDqm8Z5"
server  |             DNS name: "J9g5mfgYYyDE9Sw1JWPsxXCCd7g1z8nwB7Id0ODbyTkKFAvg8lyU4L
server  |                 ygGhKAs9KR288qt4VKGMDmbYGuC54kzEHTW3tCXnHu1dngQenDud1fpFVdeit
server  |                 sub9nbpNd5RSjkeEZDrBuedImPe1AvNnps0egsqiKKHHdf6D1zQm4wdHEJ2a3
server  |                 CpEpIzNxVOft5P9ijBpSufj5MrgwgFPMqmeI0C54lzodZa5L8zSZrQVuzym14
server  |                 L8HqqXOjEPogr"
server  |             DNS name: "CQF1qm4Ebsj6aJUxJX9mPDpykAYn2gJmV0PyaNCUrtt0ujriTYM9Ha
server  |                 QAIncDXPizTK0tZwJkmxTA8DwhndDrRFHWX1Tfs56l794EJENRAIRdaP8DZEV
server  |                 LTZcjXOm5ZbQPxEyDnHWsbNly7XGwATKXvlHvbgt9clFdo1npOYfogIZsMnDM
server  |                 w0yx028OwedcESbn3aGOpQXKi86TEKF4VHMlGSN0BQmSRaeeZL9j2bEpyKJuU
server  |                 oeCBe9wWI48z9"
server  |             DNS name: "zIF055q0f3FTue8cjdosAFhCWnFy0kt3hFlEbm2ahZqJ8kwvretjcY
server  |                 tZJMpVj3hzgNvwy8rPLb9SOeK6gYbB1RDUbjPn3042n96AaMSK71WvQ4spOcZ
server  |                 UrERZLFFBZxvvbtcZpAHX2i9yyBGn3lT4xyurGcYAUblo05OzSRto3tw50fUT
server  |                 ojrDolfVe7tSTOnuh5eB3EKRvGkqFQDAQfJsYveO7Ow0sfrzlNzay8VM7foJI
server  |                 62SWrdXWu9zQB"
server  |             DNS name: "o4cT2sQDnzaXZtovuz80IFIo2pSbApNNdS5Z5T6c4LvRA9U8OSD6Rw
server  |                 WwVUPuLDWvFAWs8jQeFP5ZjpfRAJxd1wFdfVLokYDO7ebSITdj6sbhoLQMmSD
server  |                 Wfzt6cQDLIKenuxR6DbMj5L4MNtnzSNq7pRz1CoPWJSOrKeIsjf5DageAnbBO
server  |                 ZOoqpUJSQOy17KSDeGRRh1D8jQZ9WGBAOaQCfGf1bLIy87HYDmfaxlNppWBfx
server  |                 UNUJpLngzmXB9"
server  |             DNS name: "90KmQlXF8YOV6jOFLYNdI9CXEIu9Ea6sgZ64UTWFNYTCm4IPJKmitB
server  |                 blH4lXkWimbIH7p8dqXoPVq2tok9opc9xXoAftN4d7rvgTuk0EDMltdKcy7IR
server  |                 0Zg4usOZKN8RIM63XCl4omQao7nMiBAAjioT84PrarqxbUigJB9intm330TjH
server  |                 Zjb962sUj0pcEZUDvxvr7l1gBMUPZmqNOvlbB3lNu6IOP6FqV6Am1C8AUyIYI
server  |                 lXvgYouYWXzt4"
server  |             DNS name: "gcxqjaaSCiTanNZascIR2Xwzu5UnyD1H7G9phmkSOY9dHGPMUOEi2O
server  |                 ljSF8wkBJtcwLc9sKbrjtYf1jdrSrgKKDxDPH6r37AoJlCiERH50VhSycI7fo
server  |                 w7ZvyH9OW4uz8U1ThqoGls3ekL8veTzMmu9IWRxVADlyRHdN1PyVjltNvxrJd
server  |                 f6ki3225J3VlsyRaC7GGCNrXxm4y5EynnJdJ4LR0NuBSimZ2GfAbXNLjI7Tiu
server  |                 YpqUWxug37r4P"
server  |             DNS name: "Da5cW5zUYeRgMA9vUmjgLkKfybUDClADAQ1Uovz6pMAKSt3yQu9R19
server  |                 SAu0H7DQlCXod8UKbsM2o0E8vB78XTs0gl0e3woASF6NdgP6Ctp7GekElldpB
server  |                 at17YwjTbC3o6ljnnmrVEXTNMxsofpzA1rshOeGhocGnB9UTvATtasiXfwFGZ
server  |                 dh2RbxwNEvOa32qaxxGOBqtqkU57ZupR71wWw5O3fkUATMQNyJpd7TxlGlEcA
server  |                 kne2I8aX777w4"
server  |             DNS name: "W6dDPB1ugc4DvMkkWg6D57j4CyjVigepV5fTVWwPZYN1DAykWptzEZ
server  |                 sspqTBSxCUrXeDs14gwy9YuRWeUr8TyQw4PJDIWFgbbrkLcm5wrS2QGrBhehR
server  |                 YNtVz0S7fZNw6xoslWkoDNJWlWSpj7GUlnLrSvBLCSxFXo47vByWnGxDHI7GY
server  |                 OXfWCSPtCuiVXu9TmSE3fMY6EjhTHJsP0F7xlXbA6mjdlxUETm0KeP1BEJdI2
server  |                 hgrbSKkJcpBfQ"
server  |             DNS name: "cIz70ZxlrgzlEMmg3TAVaV1fKkV83ni1ggBukwAwstNEn4R8FJkgFN
server  |                 XsrMu81EQk5WNXWWmph0LssPbCdS5HmvcR2nsDp8qjjy73pLEhVC3kpAFcX0Q
server  |                 2Xpbtpvdl6DNvuaNrpjcDnFdI9fNZCUAxmA42SS05vp4JoRiLcHy0CnAiTaXJ
server  |                 HLIxeZsDVYr2TdfcKVIX96vGVUS0gxUDsxEhtHWdrfJ5fh89YAgz1da4ygy50
server  |                 Zcs2tF8WuAQR4"
server  |             DNS name: "iuTR1uev593luMOzl1t8HYpN9sSE7BRLGtzKk2wp4Juyd9oHJZggMG
server  |                 NP194lsVMOZexbzZ2HyOsxtfMDfHBfZdqvpa8ddoBKQuyg56oFLpSKdKhMPON
server  |                 JivBPWoWgIgl2uYg9Q99yF2ju438qO1jaN4vp1EtB5Nu3tyM0CZ0FICydRjut
server  |                 f3rnbxZOE360KXJqlD0vpl4ydJSND2t9aLxFKHMmZOXzHTPb7TfhYQjJMJpSV
server  |                 7IRt5diFFIFLK"
server  | 
server  |             Name: Certificate Subject Key ID
server  |             Data:
server  |                 55:71:12:fc:ce:e2:3f:e7:91:ec:ce:1c:32:1d:d5:3e:
server  |                 f3:11:a2:b7
server  | 
server  |             Name: Certificate Authority Key Identifier
server  |             Key ID:
server  |                 3f:3d:b2:39:2c:7b:f5:c4:94:e4:56:5d:4b:d4:59:61:
server  |                 ac:c7:1a:21
server  | 
server  |     Signature Algorithm: X9.62 ECDSA signature with SHA256
server  |     Signature:
server  |         30:44:02:20:1f:e3:b4:da:ad:f0:aa:0d:9a:6f:5d:74:
server  |         09:b0:99:b2:73:03:09:ee:3f:97:aa:7a:96:c6:a6:3e:
server  |         d8:4b:86:8a:02:20:30:33:ee:44:f8:68:6c:91:fa:89:
server  |         c5:79:d8:56:47:9a:90:5d:51:8d:96:33:ac:0d:ab:d9:
server  |         f8:39:3f:64:f5:7e
server  |     Fingerprint (SHA-256):
server  |         1A:4E:8B:8D:AB:94:54:86:59:63:74:6B:C6:D5:A8:5C:E0:BF:BA:82:1F:6C:C0:D4:B0:EA:18:96:6B:0F:05:E9
server  |     Fingerprint (SHA1):
server  |         AD:5F:B7:89:67:A0:29:00:27:66:81:6B:42:F0:A8:3F:68:F6:17:82
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  | + '[' transfer = connectionmigration ']'
server  | + RUST_LOG=debug
server  | + RUST_BACKTRACE=1
server  | + neqo-server --cc cubic --qns-test transfer --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.728 DEBUG [Server] Unsupported version: 57414954
server  | 0.728 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:58130 IpTos(Cs0, NotEct) len 15
sim     | server:443 is available after 1.004120401s
server  | 0.729 DEBUG [Server] Unsupported version: 57414954
server  | 0.729 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:58130 IpTos(Cs0, NotEct) len 15
server  | 0.729 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
server  | 0.729 DEBUG [Server] Unsupported version: 57414954
server  | 0.729 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:58130 IpTos(Cs0, NotEct) len 15
server  | 0.729 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
sim     | Using scenario: droplist --delay=15ms --bandwidth=10Mbps --queue=25 --drops_to_server=2,3,4,5,6,7
sim     | tcpdump: listening on eth1, link-type EN10MB (Ethernet), snapshot length 262144 bytes
sim     | tcpdump: listening on eth0, link-type EN10MB (Ethernet), snapshot length 262144 bytes
client  | wait-for-it: sim:57832 is available after 1 seconds
client  | ## Starting quiche client...
client  | ## Client params: 
client  | ## Requests: https://server4:443/ijffjdvfzb
client  | ## Test case: transfer
server  | 0.984 DEBUG [Server] Handle initial
server  | 0.984 INFO AddressValidation: no token; accepting
server  | 0.984 INFO [Server] Accept connection CID [16]: ca42caf8f3720d741992db39e9a0da34
server  | 0.984 DEBUG Overwrite initial version Version1 ==> Version1
server  | 0.988 DEBUG Outbound interface eth0 for destination ::ffff:193.167.0.100 has MTU 1500
server  | 0.988 INFO [Server ...] Received valid Initial packet with scid CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000 dcid CID [16]: ca42caf8f3720d741992db39e9a0da34
server  | 0.988 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Server dcid=ca42caf8f3720d741992db39e9a0da34
server  | 0.988 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
server  | 0.988 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
server  | 0.988 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] State change from Init -> WaitInitial
server  | 0.988 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=0 type=Initial unv-path [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 333
server  |   -> RX Crypto { offset: 0, len: 266 }
server  | 0.988 DEBUG Read Ok(266) bytes
server  | 0.988 DEBUG 0-RTT: no token, no 0-RTT
server  | 0.988 DEBUG Read secret available for Handshake: SymKey [32]: 83b1badd6fccb2debc0fccddc617e24e048d0bdae4a09d072367981e834cd1fb
server  | 0.988 DEBUG Write secret available for Handshake: SymKey [32]: 023e5ee304ea4a8a69d38f52d6be76efe68e0be1d6a23ce5b96bf1c43a0286df
server  | 0.988 DEBUG Writing transport parameters, msg=8
server  | 0.989 DEBUG Read secret available for ApplicationData: SymKey [32]: 7e044c059f45405bd4b063de0dff6698d54c5fc9ef4f707595db132bbb57d3e0
server  | 0.989 DEBUG Write secret available for ApplicationData: SymKey [32]: f9e8cd16d81b48798a2e5e11b8a998fe7fb4012e34085e4a8f30f2dc9b31efb0
server  | 0.989 DEBUG [Agent 0x561d529ca1d0] state -> InProgress
server  | 0.989 DEBUG Making Write Handshake CryptoDxState, v=Version1 cipher=4865
server  | 0.989 DEBUG Making Read Handshake CryptoDxState, v=Version1 cipher=4865
server  | 0.989 DEBUG [Crypto] Handshake keys installed
server  | 0.989 DEBUG Making Write ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 0.989 DEBUG [Crypto] Application write key installed
server  | 0.989 DEBUG [Recvd-in] Set ACK timer to Instant { tv_sec: 433, tv_nsec: 188256759 }
server  | 0.989 DEBUG [unv-path [::]:443->[::ffff:193.167.0.100]:51249] Make permanent
server  | 0.989 DEBUG [unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] set as primary path
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] State change from WaitInitial -> Handshaking
server  | 0.989 WARN [Server ...] Dropped received packet: Coalesced packet has different DCID; Total: 1
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG Building Initial dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG CRYPTO for in offset=0, len=90
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=0 type=Initial pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 156
server  |   TX -> Ack { largest_acknowledged: 0, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: None }
server  |   TX -> Crypto { offset: 0, len: 90 }
server  | 0.989 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG CRYPTO for hs offset=0, len=1016
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=0 type=Handshake pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 0, len: 1016 }
server  | 0.989 DEBUG packet_sent this=0x561d529c9b40, pn=0, ps=1076
server  | 0.989 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 0.989 DEBUG packet_sent this=0x561d529c9b40, pn=0, ps=156
server  | 0.989 DEBUG ECN probing: sent 1 probes
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG Building Initial dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG CRYPTO for hs offset=1016, len=1171
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=1 type=Handshake pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 1016, len: 1171 }
server  | 0.989 DEBUG packet_sent this=0x561d529c9b40, pn=1, ps=1232
server  | 0.989 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 0.989 DEBUG ECN probing: sent 2 probes
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1136, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG Building Initial dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG CRYPTO for hs offset=2187, len=1075
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=2 type=Handshake pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1136
server  |   TX -> Crypto { offset: 2187, len: 1075 }
server  | 0.989 DEBUG packet_sent this=0x561d529c9b40, pn=2, ps=1136
server  | 0.989 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 0.989 DEBUG ECN probing: sent 3 probes
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG Building Initial dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 0.989 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 29.995031899s
server  | 0.989 DEBUG Setting timeout of 29.995031899s
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG Building Initial dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 0.989 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 0.989 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 0.989 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 29.994995952s
server  | 0.989 DEBUG Setting timeout of 29.994995952s
sim     | Dropping packet 2 (1200 bytes) from 193.167.0.100
sim     | Dropping packet 3 (61 bytes) from 193.167.0.100
sim     | Dropping packet 4 (61 bytes) from 193.167.0.100
sim     | Dropping packet 5 (63 bytes) from 193.167.0.100
sim     | Dropping packet 6 (65 bytes) from 193.167.0.100
sim     | Dropping packet 7 (65 bytes) from 193.167.0.100
server  | 1.914 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Drop packet number space in
server  | 1.914 DEBUG [LossRecovery] Reset loss recovery state for Initial
server  | 1.914 INFO [pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] discarding a packet without an RTT estimate; guessing RTT=930.017867ms
server  | 1.914 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=8 type=Handshake pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 65
server  |   -> RX Ack { largest_acknowledged: 2, ack_delay: 111457, first_ack_range: 2, ack_ranges: [], ecn_count: None }
server  |   -> RX Ping
server  | 1.914 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[0..=2]
server  | 1.914 DEBUG [LossRecovery] ACK for Handshake - largest_acked=2
server  | 1.914 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=3444
server  | 1.914 DEBUG Acked crypto frame space=hs offset=2187 length=1075
server  | 1.914 DEBUG Acked crypto frame space=hs offset=1016 length=1171
server  | 1.914 DEBUG Acked crypto frame space=hs offset=0 length=1016
server  | 1.914 DEBUG [Recvd-hs] immediate_ack at Instant { tv_sec: 434, tv_nsec: 118274626 }
server  | 1.914 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 434, tv_nsec: 118274626 }
server  | 1.914 DEBUG [pri-unv-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 118274626 }
server  | 1.914 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.914 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.914 DEBUG CRYPTO for hs offset=3262, len=1166
server  | 1.914 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=3 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Ack { largest_acknowledged: 8, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: None }
server  |   TX -> Crypto { offset: 3262, len: 1166 }
server  | 1.915 DEBUG packet_sent this=0x561d529c9b40, pn=3, ps=1232
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG ECN probing: sent 4 probes
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.915 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.915 DEBUG CRYPTO for hs offset=4428, len=1171
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=4 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 4428, len: 1171 }
server  | 1.915 DEBUG packet_sent this=0x561d529c9b40, pn=4, ps=1232
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG ECN probing: sent 5 probes
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.915 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.915 DEBUG CRYPTO for hs offset=5599, len=1171
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=5 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 5599, len: 1171 }
server  | 1.915 DEBUG packet_sent this=0x561d529c9b40, pn=5, ps=1232
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG ECN probing: sent 6 probes
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 46.006417ms
server  | 1.915 DEBUG Setting timeout of 46.006417ms
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=9 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 65
server  |   -> RX Ack { largest_acknowledged: 2, ack_delay: 111473, first_ack_range: 2, ack_ranges: [], ecn_count: None }
server  |   -> RX Ping
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[0..=2]
server  | 1.915 DEBUG [Recvd-hs] immediate_ack at Instant { tv_sec: 434, tv_nsec: 118851240 }
server  | 1.915 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 434, tv_nsec: 118851240 }
server  | 1.915 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 118851240 }
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=6 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 61
server  |   TX -> Ack { largest_acknowledged: 9, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: None }
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG ECN probing: sent 7 probes
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 46.358046ms
server  | 1.915 DEBUG Setting timeout of 46.358046ms
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.915 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.915 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.915 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 46.324974ms
server  | 1.915 DEBUG Setting timeout of 46.324974ms
server  | 1.946 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=10 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 61
server  |   -> RX Ack { largest_acknowledged: 3, ack_delay: 11, first_ack_range: 0, ack_ranges: [], ecn_count: None }
server  | 1.946 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[3..=3]
server  | 1.946 DEBUG [LossRecovery] ACK for Handshake - largest_acked=3
server  | 1.946 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=2464, cwnd=12320, state=SlowStart, new_acked=1232
server  | 1.946 DEBUG Acked crypto frame space=hs offset=3262 length=1166
server  | 1.946 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 150080581 }
server  | 1.946 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.946 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.946 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.946 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.946 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 9.630911ms
server  | 1.946 DEBUG Setting timeout of 9.630911ms
server  | 1.946 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.946 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.946 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.946 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.946 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 9.544947ms
server  | 1.946 DEBUG Setting timeout of 9.544947ms
server  | 1.947 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=11 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 61
server  |   -> RX Ack { largest_acknowledged: 4, ack_delay: 8, first_ack_range: 1, ack_ranges: [], ecn_count: None }
server  | 1.947 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[3..=4]
server  | 1.947 DEBUG [LossRecovery] ACK for Handshake - largest_acked=4
server  | 1.947 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=1232, cwnd=12320, state=SlowStart, new_acked=1232
server  | 1.947 DEBUG Acked crypto frame space=hs offset=4428 length=1171
server  | 1.947 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 151060754 }
server  | 1.947 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.947 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.947 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.947 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.947 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 3.746305ms
server  | 1.947 DEBUG Setting timeout of 3.746305ms
server  | 1.947 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.947 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.947 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.947 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.947 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 3.687696ms
server  | 1.947 DEBUG Setting timeout of 3.687696ms
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=12 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 61
server  |   -> RX Ack { largest_acknowledged: 6, ack_delay: 3, first_ack_range: 3, ack_ranges: [], ecn_count: None }
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[3..=6]
server  | 1.948 DEBUG [LossRecovery] ACK for Handshake - largest_acked=6
server  | 1.948 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 1.948 DEBUG Acked crypto frame space=hs offset=5599 length=1171
server  | 1.948 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 152054097 }
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.948 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.948 DEBUG CRYPTO for hs offset=6770, len=1171
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=7 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 6770, len: 1171 }
server  | 1.948 DEBUG packet_sent this=0x561d529c9b40, pn=7, ps=1232
server  | 1.948 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.948 DEBUG ECN probing: sent 8 probes
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.948 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.948 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.948 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 30.047832ms
server  | 1.948 DEBUG Setting timeout of 30.047832ms
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.948 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.948 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.948 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.948 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 30.016003ms
server  | 1.948 DEBUG Setting timeout of 30.016003ms
server  | 1.979 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.979 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.979 DEBUG CRYPTO for hs offset=7941, len=1171
server  | 1.979 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=8 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 7941, len: 1171 }
server  | 1.979 DEBUG packet_sent this=0x561d529c9b40, pn=8, ps=1232
server  | 1.979 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.979 DEBUG ECN probing: sent 9 probes
server  | 1.979 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.979 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.979 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.980 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 30.487644ms
server  | 1.980 DEBUG Setting timeout of 30.487644ms
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.980 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.980 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 30.45302ms
server  | 1.980 DEBUG Setting timeout of 30.45302ms
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=13 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 61
server  |   -> RX Ack { largest_acknowledged: 7, ack_delay: 7, first_ack_range: 4, ack_ranges: [], ecn_count: None }
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[3..=7]
server  | 1.980 DEBUG [LossRecovery] ACK for Handshake - largest_acked=7
server  | 1.980 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=1232, cwnd=12320, state=SlowStart, new_acked=1232
server  | 1.980 DEBUG Acked crypto frame space=hs offset=6770 length=1171
server  | 1.980 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 183697442 }
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.980 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.980 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 26.567625ms
server  | 1.980 DEBUG Setting timeout of 26.567625ms
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 1.980 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 1.980 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 1.980 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 26.476445ms
server  | 1.980 DEBUG Setting timeout of 26.476445ms
server  | 2.008 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.008 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.008 DEBUG CRYPTO for hs offset=9112, len=863
server  | 2.008 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=9 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, Ect0) len 924
server  |   TX -> Crypto { offset: 9112, len: 863 }
server  | 2.008 DEBUG packet_sent this=0x561d529c9b40, pn=9, ps=924
server  | 2.008 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.008 DEBUG ECN probing: sent 10 probes
server  | 2.008 DEBUG ECN probing concluded with 10 probes sent
server  | 2.008 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.008 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.008 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.008 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.008 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 19.102248ms
server  | 2.008 DEBUG Setting timeout of 19.102248ms
server  | 2.008 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.008 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.008 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.008 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.008 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 19.067844ms
server  | 2.008 DEBUG Setting timeout of 19.067844ms
server  | 2.011 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=14 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 61
server  |   -> RX Ack { largest_acknowledged: 8, ack_delay: 5, first_ack_range: 5, ack_ranges: [], ecn_count: None }
server  | 2.011 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[3..=8]
server  | 2.011 DEBUG [LossRecovery] ACK for Handshake - largest_acked=8
server  | 2.011 WARN ECN validation failed, no ECN counts in ACK frame
server  | 2.011 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=924, cwnd=12320, state=SlowStart, new_acked=1232
server  | 2.011 DEBUG Acked crypto frame space=hs offset=7941 length=1171
server  | 2.011 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 214907974 }
server  | 2.011 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.011 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.011 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.011 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.011 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 14.037474ms
server  | 2.011 DEBUG Setting timeout of 14.037474ms
server  | 2.011 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.011 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.011 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.011 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.011 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 13.968685ms
server  | 2.011 DEBUG Setting timeout of 13.968685ms
server  | 2.026 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.026 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.026 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.026 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.026 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 2.785157015s
server  | 2.026 DEBUG Setting timeout of 2.785157015s
server  | 2.026 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.026 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.026 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.026 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.026 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 2.78513292s
server  | 2.026 DEBUG Setting timeout of 2.78513292s
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=15 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 102
server  |   -> RX Ack { largest_acknowledged: 9, ack_delay: 95, first_ack_range: 6, ack_ranges: [], ecn_count: None }
server  |   -> RX Crypto { offset: 0, len: 36 }
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=hs, ranges=[3..=9]
server  | 2.041 DEBUG [LossRecovery] ACK for Handshake - largest_acked=9
server  | 2.041 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=924
server  | 2.041 DEBUG Acked crypto frame space=hs offset=9112 length=863
server  | 2.041 DEBUG Read Ok(36) bytes
server  | 2.041 DEBUG [Agent 0x561d529ca1d0] 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  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] TLS connection complete
server  | 2.041 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 244530090 }
server  | 2.041 DEBUG Making Read ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 2.041 DEBUG [Crypto] application read keys installed
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] State change from Handshaking -> Connected
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] State change from Connected -> Confirmed
server  | 2.041 DEBUG PMTUD started with probe size 1380
server  | 2.041 INFO [Server ca42caf8f3720d741992db39e9a0da34] Connection established
server  | 2.041 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 434, tv_nsec: 244530090 }
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=16 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 330
server  |   -> RX NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [234, 167, 95, 249, 114, 113, 62, 243, 251, 134, 41, 82, 216, 21, 14, 179, 112, 142, 233, 7], stateless_reset_token: [14, 111, 250, 247, 254, 106, 232, 46, 88, 129, 97, 38, 9, 4, 133, 197] }
server  |   -> RX NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [206, 191, 53, 97, 63, 5, 42, 158, 101, 141, 219, 189, 149, 141, 21, 71, 127, 111, 148, 42], stateless_reset_token: [103, 56, 9, 177, 113, 195, 20, 215, 75, 197, 202, 254, 23, 45, 109, 91] }
server  |   -> RX NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [143, 77, 2, 242, 20, 124, 185, 5, 127, 70, 165, 12, 87, 208, 74, 57, 142, 12, 184, 220], stateless_reset_token: [49, 238, 226, 158, 25, 130, 48, 229, 47, 51, 213, 73, 145, 217, 201, 216] }
server  |   -> RX NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [116, 17, 69, 32, 144, 226, 194, 128, 155, 153, 191, 217, 230, 246, 191, 117, 172, 234, 200, 212], stateless_reset_token: [89, 32, 167, 240, 172, 39, 126, 133, 184, 237, 87, 180, 83, 138, 61, 46] }
server  |   -> RX NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [50, 44, 137, 164, 91, 238, 142, 225, 196, 246, 25, 15, 29, 113, 193, 186, 230, 237, 36, 130], stateless_reset_token: [4, 17, 185, 37, 230, 102, 61, 158, 123, 60, 137, 223, 150, 25, 175, 163] }
server  |   -> RX NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [171, 231, 236, 133, 225, 82, 222, 223, 92, 116, 148, 245, 35, 56, 39, 87, 242, 187, 69, 218], stateless_reset_token: [245, 146, 104, 68, 149, 51, 38, 118, 123, 125, 1, 223, 91, 59, 45, 184] }
server  |   -> RX NewConnectionId { sequence_number: 7, retire_prior: 0, connection_id: [232, 175, 29, 43, 61, 149, 98, 110, 171, 173, 129, 126, 243, 156, 81, 178, 234, 84, 137, 116], stateless_reset_token: [1, 15, 240, 72, 21, 227, 39, 198, 239, 169, 186, 66, 118, 140, 162, 75] }
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 17, fin: true }
server  | 2.041 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 434, tv_nsec: 244530090 }
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.041 DEBUG Building Handshake dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000) scid Some(CID [10]: 330dd96550599e24a7f6)
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=10 type=Handshake pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 61
server  |   TX -> Ack { largest_acknowledged: 15, ack_delay: 0, first_ack_range: 7, ack_ranges: [], ecn_count: None }
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Drop packet number space hs
server  | 2.041 DEBUG [LossRecovery] Reset loss recovery state for Handshake
server  | 2.041 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=0 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 1332
server  |   TX -> Ack { largest_acknowledged: 16, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: None }
server  |   TX -> HandshakeDone
server  |   TX -> NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [185, 214, 59, 204, 123, 109, 198, 63, 13, 211], stateless_reset_token: [149, 238, 156, 217, 61, 81, 168, 79, 135, 166, 136, 52, 225, 213, 248, 73] }
server  |   TX -> NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [241, 13, 212, 137, 238, 202, 186, 69, 74, 189], stateless_reset_token: [34, 150, 186, 101, 75, 145, 82, 0, 158, 89, 161, 10, 88, 80, 167, 115] }
server  |   TX -> NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [73, 203, 34, 113, 14, 143, 56, 208, 129, 109], stateless_reset_token: [246, 105, 148, 215, 231, 167, 178, 117, 7, 242, 118, 177, 96, 58, 190, 225] }
server  |   TX -> NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [99, 192, 181, 138, 241, 202, 81, 209, 214, 93], stateless_reset_token: [154, 190, 135, 140, 245, 193, 196, 61, 195, 42, 229, 156, 106, 34, 12, 137] }
server  |   TX -> NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [252, 24, 30, 135, 204, 104, 57, 142, 1, 23], stateless_reset_token: [240, 103, 234, 147, 102, 124, 125, 126, 215, 183, 39, 130, 184, 142, 7, 180] }
server  |   TX -> NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [76, 146, 240, 5, 121, 44, 15, 76, 134, 145], stateless_reset_token: [142, 73, 211, 24, 81, 42, 232, 194, 50, 0, 248, 231, 239, 215, 133, 192] }
server  |   TX -> NewConnectionId { sequence_number: 7, retire_prior: 0, connection_id: [222, 125, 170, 80, 236, 205, 128, 199, 165, 85], stateless_reset_token: [49, 152, 59, 107, 237, 223, 244, 112, 120, 45, 25, 21, 115, 53, 82, 149] }
server  |   TX -> Padding { len: 1017 }
server  | 2.041 DEBUG packet_sent this=0x561d529c9b40, pn=0, ps=1271
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.041 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.041 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.041 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 5.2485ms
server  | 2.041 DEBUG Setting timeout of 5.2485ms
server  | 2.042 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] send session ticket 406b0010ca42caf8f3720d741992db39e9a0da340104800075300408ffffffffffffffff0504801000000604801000000704801000000801100901100b01140e01080f0a330dd96550599e24a7f6110c000000013aaaea5a000000016ab200c0000000ff02de1a0243e8200100686921
server  | 2.042 DEBUG Path = 'ijffjdvfzb'
server  | 2.042 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.042 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.042 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.042 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 4.249546ms
server  | 2.042 DEBUG Setting timeout of 4.249546ms
server  | 2.048 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.048 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.048 DEBUG Sending PMTUD probe of size 1380, count 1
server  | 2.048 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=1 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 1332
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 0, len: >>1291, fin: false }
server  | 2.048 DEBUG packet_sent this=0x561d529c9b40, pn=1, ps=1332
server  | 2.048 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.048 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.048 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.048 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 21.587252ms
server  | 2.048 DEBUG Setting timeout of 21.587252ms
server  | 2.048 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.049 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.049 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.049 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 21.560863ms
server  | 2.049 DEBUG Setting timeout of 21.560863ms
server  | 2.071 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 2.071 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.071 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=2 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 1291, len: >>1190, fin: false }
server  | 2.071 DEBUG packet_sent this=0x561d529c9b40, pn=2, ps=1232
server  | 2.071 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.071 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.071 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.071 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 21.103196ms
server  | 2.071 DEBUG Setting timeout of 21.103196ms
server  | 2.071 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.071 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.071 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.071 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 21.072199ms
server  | 2.071 DEBUG Setting timeout of 21.072199ms
server  | 2.073 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=17 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 33
server  |   -> RX Ack { largest_acknowledged: 0, ack_delay: 13, first_ack_range: 0, ack_ranges: [], ecn_count: None }
server  | 2.073 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=ap, ranges=[0..=0]
server  | 2.073 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=0
server  | 2.073 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=2564, cwnd=12320, state=SlowStart, new_acked=1271
server  | 2.073 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.073 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.073 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.073 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 16.227858ms
server  | 2.073 DEBUG Setting timeout of 16.227858ms
server  | 2.073 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.073 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.073 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.073 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 16.159991ms
server  | 2.073 DEBUG Setting timeout of 16.159991ms
server  | 2.080 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=18 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 33
server  |   -> RX Ack { largest_acknowledged: 1, ack_delay: 6, first_ack_range: 1, ack_ranges: [], ecn_count: None }
server  | 2.080 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=ap, ranges=[0..=1]
server  | 2.080 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=1
server  | 2.080 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=1232, cwnd=12320, state=SlowStart, new_acked=1332
server  | 2.080 DEBUG PMTUD probe of size 1380 succeeded
server  | 2.080 DEBUG PMTUD started with probe size 1420
server  | 2.080 DEBUG PLPMTU changed from 1232 to 1332, updating pacer
server  | 2.080 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.080 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.080 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.080 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 8.545829ms
server  | 2.080 DEBUG Setting timeout of 8.545829ms
server  | 2.080 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.080 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.080 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.080 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 8.464207ms
server  | 2.080 DEBUG Setting timeout of 8.464207ms
server  | 2.090 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 2.090 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.090 DEBUG Sending PMTUD probe of size 1420, count 1
server  | 2.090 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=3 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 1372
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 2481, len: >>1329, fin: false }
server  | 2.090 DEBUG packet_sent this=0x561d529c9b40, pn=3, ps=1372
server  | 2.090 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.090 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.090 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.090 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 17.247113ms
server  | 2.090 DEBUG Setting timeout of 17.247113ms
server  | 2.090 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.090 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.090 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.090 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 17.218881ms
server  | 2.090 DEBUG Setting timeout of 17.218881ms
server  | 2.102 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=19 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 33
server  |   -> RX Ack { largest_acknowledged: 2, ack_delay: 5, first_ack_range: 2, ack_ranges: [], ecn_count: None }
server  | 2.102 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=ap, ranges=[0..=2]
server  | 2.102 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=2
server  | 2.102 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=1372, cwnd=12320, state=SlowStart, new_acked=1232
server  | 2.102 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.102 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.102 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.102 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 3.384193ms
server  | 2.102 DEBUG Setting timeout of 3.384193ms
server  | 2.102 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.102 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.102 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.102 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 3.302331ms
server  | 2.102 DEBUG Setting timeout of 3.302331ms
server  | 2.107 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 2.107 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.107 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=4 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 1332
server  |   TX -> Stream { stream_id: 0, offset: 3810, len: >>1290, fin: false }
server  | 2.107 DEBUG packet_sent this=0x561d529c9b40, pn=4, ps=1332
server  | 2.107 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.107 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.107 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.107 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 14.432344ms
server  | 2.107 DEBUG Setting timeout of 14.432344ms
server  | 2.107 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.107 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.108 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.108 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 14.404863ms
server  | 2.108 DEBUG Setting timeout of 14.404863ms
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=20 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 33
server  |   -> RX Ack { largest_acknowledged: 3, ack_delay: 6, first_ack_range: 3, ack_ranges: [], ecn_count: None }
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=ap, ranges=[0..=3]
server  | 2.122 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=3
server  | 2.122 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=1332, cwnd=12320, state=SlowStart, new_acked=1372
server  | 2.122 DEBUG PMTUD probe of size 1420 succeeded
server  | 2.122 DEBUG PMTUD started with probe size 1470
server  | 2.122 DEBUG PLPMTU changed from 1332 to 1372, updating pacer
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.122 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.122 DEBUG Sending PMTUD probe of size 1470, count 1
server  | 2.122 DEBUG CRYPTO for ap offset=0, len=321
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=5 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 1422
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 5100, len: 20, fin: true }
server  |   TX -> Crypto { offset: 0, len: 321 }
server  |   TX -> NewToken { token: [173, 154, 139, 141, 134, 1, 0, 193, 65, 192, 128, 107, 182, 237, 132, 29, 143, 24, 83, 167, 215, 85, 130, 83, 166, 34, 3, 54, 139, 35, 24, 216, 143, 128, 154, 214, 10, 89, 59, 156, 232, 90, 66] }
server  |   TX -> Padding { len: 988 }
server  | 2.122 DEBUG packet_sent this=0x561d529c9b40, pn=5, ps=1422
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.122 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.122 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 14.0857ms
server  | 2.122 DEBUG Setting timeout of 14.0857ms
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.122 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.122 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 2.122 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 14.049873ms
server  | 2.122 DEBUG Setting timeout of 14.049873ms
server  | 2.137 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.137 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.137 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.137 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 1.841731888s
server  | 2.137 DEBUG Setting timeout of 1.841731888s
server  | 2.137 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.137 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.137 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.137 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 1.841702954s
server  | 2.137 DEBUG Setting timeout of 1.841702954s
server  | 2.139 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=21 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 33
server  |   -> RX Ack { largest_acknowledged: 4, ack_delay: 6, first_ack_range: 4, ack_ranges: [], ecn_count: None }
server  | 2.139 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] Rx ACK space=ap, ranges=[0..=4]
server  | 2.139 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=4
server  | 2.139 DEBUG on_packets_acked this=0x561d529c9b40, limited=1, bytes_in_flight=1422, cwnd=12320, state=SlowStart, new_acked=1332
server  | 2.139 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.139 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.139 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.139 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 1.655782447s
server  | 2.139 DEBUG Setting timeout of 1.655782447s
server  | 2.139 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.139 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.139 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.139 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] delay duration 1.655724689s
server  | 2.139 DEBUG Setting timeout of 1.655724689s
server  | 2.154 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=22 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 38
server  |   -> RX ConnectionClose { error_code: Application(0), frame_type: 0, reason_phrase: "kthxbye" }
server  | 2.154 INFO [Server ca42caf8f3720d741992db39e9a0da34] ConnectionClose received. Error code: Application(0) frame type 0 reason kthxbye
server  | 2.154 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] State change from Confirmed -> Draining { error: Transport(PeerApplicationError(0)), timeout: Instant { tv_sec: 439, tv_nsec: 376330062 } }
server  | 2.154 DEBUG [pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249] Path validated Instant { tv_sec: 434, tv_nsec: 357745670 }
server  | 2.154 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 2.154 DEBUG Building Short dcid Some(CID [20]: 7feaa0ef24feb4a8a6bebb2cada6148255a0b000)
server  | 2.154 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 434, tv_nsec: 357745670 }
server  | 2.154 DEBUG [Server ca42caf8f3720d741992db39e9a0da34] pn=6 type=Short pri-path:7feaa0ef24feb4a8a6bebb2cada6148255a0b000 [::]:443->[::ffff:193.167.0.100]:51249 IpTos(Cs0, NotEct) len 47
server  |   TX -> Ack { largest_acknowledged: 22, ack_delay: 0, first_ack_range: 6, ack_ranges: [], ecn_count: None }
server  |   TX -> ConnectionClose { error_code: Transport(0), frame_type: 29, reason_phrase: "" }
server  | 2.154 DEBUG Setting timeout of 5.018463139s
server  | 2.154 DEBUG Setting timeout of 5.018447811s

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 10:30:12,970 Using the client's key log file.
2025-04-30 10:30:12,979 
2025-04-30 10:30:12,980 Using the client's key log file.
2025-04-30 10:30:12,980 Using the client's key log file.
2025-04-30 10:30:12,988 
2025-04-30 10:30:12,989 Using the client's key log file.
2025-04-30 10:30:12,989 Using the client's key log file.
2025-04-30 10:30:13,615 Check of downloaded files succeeded.
2025-04-30 10:30:13,928 Server sent 9975 bytes in Handshake CRYPTO frames.
2025-04-30 10:30:14,277 Received a 1200 byte Initial packet from the client. Amplification limit: 3600
2025-04-30 10:30:14,277 Received a 1232 byte Handshake packet from the server. Total: 1232
2025-04-30 10:30:14,277 Received a 1232 byte Handshake packet from the server. Total: 2464
2025-04-30 10:30:14,277 Received a 1136 byte Handshake packet from the server. Total: 3600