2025-04-30 10:25:45,422 Generated random file: bnnpbzbysh of size: 5120
2025-04-30 10:25:45,422 Requests: https://server4:443/bnnpbzbysh
2025-04-30 10:25:45,807 
2025-04-30 10:25:45,808 Command: WAITFORSERVER=server:443 CERTS=/tmp/certs_5l09z65u/ TESTCASE_SERVER=transfer TESTCASE_CLIENT=transfer WWW=/tmp/www_xphbqx42/ DOWNLOADS=/tmp/download_ko850r7z/ SERVER_LOGS=/tmp/logs_server_9wib_ekb CLIENT_LOGS=/tmp/logs_client_xzdnivik SCENARIO="droplist --delay=15ms --bandwidth=10Mbps --queue=25 --drops_to_server=2,3,4,5,6,7" CLIENT=ghcr.io/ngtcp2/ngtcp2-interop:latest SERVER=ghcr.io/mozilla/neqo-qns:latest REQUESTS="https://server4:443/bnnpbzbysh"  docker compose --env-file empty.env up --abort-on-container-exit --timeout 1 sim client server 
2025-04-30 10:26:00,185  Container sim  Recreate
 Container sim  Recreated
 Container server  Recreate
 Container client  Recreate
 Container server  Recreated
 Container client  Recreated
Attaching to client, server, sim
sim     | waiting 10s for server:443
server  | Setting up routes...
server  | Actual changes:
server  | tx-checksum-ip-generic: off
server  | tx-tcp-segmentation: off [not requested]
server  | tx-tcp-ecn-segmentation: off [not requested]
server  | tx-tcp-mangleid-segmentation: off [not requested]
server  | tx-tcp6-segmentation: off [not requested]
server  | tx-udp-segmentation: off [not requested]
server  | tx-checksum-sctp: off
server  | Endpoint's IPv4 address is 193.167.100.100
server  | Endpoint's IPv6 address is fd00:cafe:cafe:100::100
client  | Setting up routes...
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
server  | + CERT=cert
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  | ++ mktemp
server  | + P12CERT=/tmp/tmp.Q9TTSxNEaQ
server  | + mkdir -p /neqo/db
client  | Endpoint's IPv4 address is 193.167.0.100
server  | + certutil -N -d sql:/neqo/db --empty-password
client  | Endpoint's IPv6 address is fd00:cafe:cafe::100
server  | + openssl pkcs12 -export -nodes -in /certs/cert.pem -inkey /certs/priv.key -name cert -passout pass: -out /tmp/tmp.Q9TTSxNEaQ
client  | wait-for-it.sh: waiting 30 seconds for sim:57832
server  | Warning: output encryption option -nodes ignored with -export
server  | + pk12util -d sql:/neqo/db -i /tmp/tmp.Q9TTSxNEaQ -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  |             22:a0:96:b3:36:ac:b3:74:86:3b:ec:f5:5a:e9:ec:ea:
server  |             ac:c3:ef:50
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:25:45 2025
server  |             Not After : Sat May 10 10:25:45 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:61:06:7f:00:db:cb:fd:89:6d:b2:6c:d4:ce:b6:36:
server  |                     b5:b9:40:35:25:16:e7:7d:65:43:ca:a7:63:37:81:ad:
server  |                     89:75:21:47:26:ce:c6:32:b7:1d:5a:85:72:6f:a4:a0:
server  |                     06:7f:84:01:a0:93:0c:6a:2b:73:39:21:d6:00:14:cc:
server  |                     85
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: "5n6H7VTAu2CsqrA1evR6tUvBNVHdcGELhV4zPEOYQk9mPQeRERrtwn
server  |                 pkOQCfQcM8FVcPQmA5CiYNtWWsts8b6MBbnlGpcjRFfUp3uYjTzfAt4KkU9dB
server  |                 K7tquIT0H2CuE32D98u0jby94hzKicP67MI8gXwi6UnBdCwSdRu2WjtF5npRz
server  |                 q07bqSyHTQURRG7dX9n1Wz6YMjOpflrCE5wVEuQxnMGNHf5bnkZKINf5imkoh
server  |                 Kla44mc6PNwLr"
server  |             DNS name: "5xiZ2jGDHhwySiKFo1IMudBd5V3AaxysMdTwQznrdaW0bbdOtj7KcB
server  |                 L64uUbTZyz8mWrxlY6ocoSGGJAwafpzjhx8I8m0CuK60KRSVwC3gsA4M5jQRG
server  |                 G0YbxHq42iSHuU1cMx0EtgMUCEL0k2y9Sem7gDKf4Yg8BduUAdrukdjRiVH9B
server  |                 0BYF9rxT5kInwV4KkxOMcEEToaIDkmApRKorZU2jXHxUTdHVhSR32vUx2Lu8m
server  |                 8xA56POWElu6n"
server  |             DNS name: "MAnlRF6BVWFhhCS73lqdqFpcrnNe0N9IqYlDfLroFK3qaAFHTKBRae
server  |                 xMg9ZWZ7yMknUFcBnbZ5zJ5Tubrvn4nYXGEVvJBNUfxndCMWjxmC6XliGihCw
server  |                 ObTdLEbJ47XVW7J7177grSkKam48PzGxceBiTwOJeJKPBKgfUKTyYwudribGx
server  |                 wbxX3ioDuQNAfnlxSuyNayFIq45YiR6JqoHfvKBIq6Mbc6zQaGfKk3XppCryz
server  |                 joplomTkyJ3kT"
server  |             DNS name: "VBmAeQMwDZWHO7ijJA9GatCMgkrdqCcAcMb9bWOCQHr9ZBYgslQtwx
server  |                 PKOMHvqOuRoG6JWLxv1YCFiQ9Lr1mCpNm0Fr1sHDthGtaT24Kia20NB1jsbaf
server  |                 xLgJvLwqOVDrkQyFKe59iVWpPGL9RdlGkXfKqqNTivNYEdUboeeVCA52zMIgC
server  |                 P4k0Al8nSCyUuUBJ844iTMkt4wUdYaOzmt8hFELgswpLHdb4soxXqdBN135jt
server  |                 qCe8KFtLKKQAz"
server  |             DNS name: "VeptFoT93rCQPkJt0dCnFLahvlZPBkTuLzJaqxkUzUXshTLR5bXDdF
server  |                 EPdG21aTVUeO4C4SZkr9STd8bJFf3uAI0Zdanw0fGi1fGLrmPRBR93O9N7VgU
server  |                 V4KTafM5bCdZS67gtaemsaLmJwH9aLzhb6Ru5vScKDqVJMsUwGYcEc1z2oVFM
server  |                 W4vzwqq3bA6ibhIj5tAcVfYWP8PRBillkaal8OUdvkIrsN8YfohWrodQiRgGO
server  |                 H51aOdyxKfH9i"
server  |             DNS name: "KmyVJiBXZHbMeaRK4VWWa9vX6o9k9pklcGnzJdl9U284U0K4hIPvzb
server  |                 dkb1wtdM90DfJ8BEiolUwMNuOVC601yqdFeBv8SvjV8e2zhXm2Hsh7HeNZ0A6
server  |                 wOCmJFdUstyEn4rzrNv7Xuduhay5fwFLzL3BViEwav9IzwddasXrswsYKzy1I
server  |                 EaI5tnvmzAsWY4z2vOlsdg7O7WRHKhgEf7M9Sem0VTSMzCmYTFfUmjqXffTbX
server  |                 RNrubapuythF2"
server  |             DNS name: "7T0hm99taoDALnbiS7VPNyd5QytRHVaX1Nyayw026P9wCkxkFXGwxA
server  |                 fnOktDfhr9ei2y7DDG6401QRRXAmlKfRpZ2uVfeqC5uBtWGqLi6lDvORDpWR0
server  |                 Iay2CULkIMdtlWBHmfqpVsVDCElIDyzFu9aan1uF4HMb5TbMzC5FyJ0gwpZON
server  |                 CAHgER1DQ31PoUOXOvb8gxB8WnFDTxIFH0Vl1OhcXjBlovhY6rR9seRbV2Qm2
server  |                 WJ42pk2lUrcvk"
server  |             DNS name: "XMAdedmPbHJFi8Jfmt6mHLg5MmgrR5ukPwVTdyWTnZQRvifW1zzZss
server  |                 ZzPUFwuSC6iZUASU9PU1EG71bBAN1J7xcKJRwFsiyGZGjfF2lOYg5oBlgxTO3
server  |                 Ww7giSg8iMk0KcQrhkjltH5gAkH5ThPycSzlM0kHjAMLIW1wcU566XXCF6ZmQ
server  |                 emaAp7mdgkSSt9QK4hdFjeAGMGQHAhMTW7oXbD7CEDaGSZHOFTpMGdTlPmXbv
server  |                 moZSIVxMUI2lf"
server  |             DNS name: "w580ayuQxCQEdMW8bcLm24hftHvWNYeBaenPKwxvHXlUsUzctwlI1Z
server  |                 qrWhxNv3hipD5wnDdLsDGurpHjNrT1jh66OfOkPgrz6N7Ms1VNNU3aI4Z8CF6
server  |                 j9jmaCVMK9wx7yyTZvPtVSBjJOIYyrkuziX9CPQCjBrXQsJyTGsJJ1RXRosCe
server  |                 GjBtMruZXIPQipB1CvH2ivkcVsiMZjczYffMRTUx7fsXG0N5TTckhsP6l4orw
server  |                 dsWEctMG6kEQY"
server  |             DNS name: "EJHCd2glDiRaWAu3FEc2cb68GkMsswtXYYhR5heCBwQCMJnkN14FxS
server  |                 7F5fq6EW86y4Ar219saizopJLVQFhrEnwOa7VOzXIVdP1BjECJ9fyx0vZcu3c
server  |                 dqoesR6QsJN5HOj6EcOyz5vBnNWuf96YnRuKQY97JNgPHPHhJqB6f3wv5zqWc
server  |                 h1HXt795OolTRnGcIimpAnBMb9n95CeVtlTx7rqnzF228DbawlwgID72WsY3e
server  |                 rXrhWjUdukDEq"
server  |             DNS name: "cOTkHz1Q7fN1ZgBpQm8NcsImb4aeGeeAcYRGXqAzHieeYQx27x1W0F
server  |                 9oCmVD4ZbeVp8tkbT6Wwnefdil6K5nOHC9yWBH5cGl4WUxBBlOLnVY68pvzT1
server  |                 CCEGJJNUyIj0BgMS9gGBffIugn6mYYqP5FsyUtmiCa64RInI00LUcVvsgiTcq
server  |                 2tHazAsPCsLJ1yvlzskGzKz4HMN6mazjf04MNHa6U7ePpXu3W4zJzzSzrCIWO
server  |                 UD2MVd9DU1Elu"
server  |             DNS name: "zQWM3Ws5oEQftLWBGJ7HuIxtZobwtYwDqujgo3aB1Sau6ogqUALo0A
server  |                 lOOQSVcvREMCb8CS9YekIL05dWAh66CpXx5DEUEekkk6kslJF3j7Y64xI5QxO
server  |                 kXGmlZER9jB7xpX80oIy0txUvN99xECJxhHwC0iJ98nybIhBShLzoaJ2cUQKL
server  |                 1e1YGLRxcZE35lELnm9Gpm60r2RczNxJG6ltGTIeVCfrhJT4u9DmU7Gbi36Wr
server  |                 2rguJM23atJZX"
server  |             DNS name: "5E72SSqlI7FL7gUTg3WGiorPxuDFvkwYYOT5X0gjjWpEGgUFFob8RI
server  |                 dhS0KrygHWASvqf0ol66Ey1RZwoSFEVzDQIy5UkaPoRJ8ybHdhrybB1svQSZz
server  |                 HvMTcpl4u9SFGtzGifNWxLf0TIu6DIKGyjowGvdYKm4AVZxD01PDu1WRJq0EW
server  |                 2HbE5jjcIzd2NWYrS9phQad8HE434hFlEGfHIHy56p6D9fCH3ndWkypXDtD39
server  |                 NfzIoECxowTqI"
server  |             DNS name: "q9KLnXsTFMR5tWWGH2Dt1qSKXTyJT52LYTI0YNOSh2WMSE7A8FLDNC
server  |                 Twpko1EcHrF531WNTvSh6aSSghPQO43sN4T7OS97tuZnFJ2zkLtswXQS3xWsr
server  |                 zwvErK68z8TjPigbvVsUVVLJ4CkY9xjBsgSQ4iFI4fcJMhPTFZaZ3OP8bLnIy
server  |                 1DKwUH6Zkaa58PhYxehh8xaloAH7OQ6yWOmS9OqAc2hf8ePqaeh6ya1TQTvie
server  |                 USImPuD77gNjf"
server  |             DNS name: "a7I72X3fx0IuAdnExxYOhlOwNI3YXY5CIHl9vFlff8BupexBJxSE9X
server  |                 1Fl9u1GhnaOTuA27iLEfufgfw4HDqumq3Siv4erc4cJKcfgh3puyIiE3q7rIf
server  |                 Ue98mgv6vccywGC4LpQbm8rIK7jFQwXXTJc9Tg1XLXN71L32SWjJNHFdDKIAj
server  |                 CuiN99hdkeKn6BH2wFWjK9iL7W1jckUeIF9QMVdNaYYdf397lB2oBsv21BhKm
server  |                 KHA8UCw4roPeW"
server  |             DNS name: "7MOzeKTJom4dR4zoa4NaCrFxAjF6WuK85NehIewjT4jREOcGE92v7r
server  |                 uifrTE24QTMdqbbNfezYgS6yduV6dGiLewREVV59CkWfAdymQc1Zd0Uu0lOt8
server  |                 axl83xPm8VrF2WVKXVFY7nbUkJwXpYwIfoC7W1N3C4wyClzfOH0yGtTKRnJwt
server  |                 RX5C4JglSkIRZK390pcMAAn3fIW3HgzTTOFssMZLKQRLZDR3b036y8k7Q8JHm
server  |                 dloUwfkgru7Jm"
server  |             DNS name: "z41Uv8bAUKmu9UlAA7Lc1oi49Odf3oSERU5stNIK9nKi1WB4iL71nW
server  |                 eI6V5LYqxBVvTIAIovQBsfZskgsPVWrUbrpXKuLmPEev4fFWyX5QfnAVUbzG9
server  |                 JqVSktsfC9Q6UW9jwsM5WhQ1DlTBDEn2IY57davE3ubSfNGDEzOcVE2IMMm1c
server  |                 ptdXgmc1sAxBINkLFaymvIMaiGjg6WXo82msPITJpbSNtxOlEzJsXbycJLLxF
server  |                 md32oTvDPYuzW"
server  |             DNS name: "HEAXsNgG9ITUGKPus73KN9VAXfEuAl78rLqeaheQwJGjqK9VAc9mv4
server  |                 kFBery1pjwQKTeIdqtkRE8rvSJ1vwxEKN1KRAxb2NXROpX6O7ixTjNR62n9Z8
server  |                 uhjut368yomKV4T4KXX8wimooJMtr1elTwTuXXrcEuKIOisQRVbYnIdDWQmeX
server  |                 W1IYgfy2zaisYx4jGBJGwaEAk1lsfZVjAm9kCzRp2dQsnSZq295MMwtGqpjzD
server  |                 Fvi9ZQCQ4KbNf"
server  |             DNS name: "RXFILSdp4vQySO2Iz2KvOiPG1Sro8d5jIX7kxFP7Ac86xIE9ZGYIoh
server  |                 ZODH0wd6aoF2pdRIQ83916N8mxd4EdTJcWvFDGlNzex38Dq81aSEZisSuTgMg
server  |                 J0HYs2q0avJnUlDlC6ryBBQJI0T4UBNhD0BlHV6Nz91O4tmHbLGr8Ox7Fw8DT
server  |                 YtOFmlSLmCU5LrxgMO00zrzS8WHS00zynCoemiPJ9IWWOuU1ze6QEL376ZTRN
server  |                 bddmoM0rwqDkd"
server  |             DNS name: "LhOg0iAQ4EHs8RPCx5J9VtgUbl3oZsQ42xzcTcItTpFZY68nq7H13Z
server  |                 LJ07fugRXzrZUtsM9NVG8VpNfVBOl4liT173asgIHUjFUcJCj528HS6GM7ozN
server  |                 Y3CM2ku5EVr58ieFWgT74mveOCjfxonabOuEJlW41qgOoDAC5qaMWzzAlyqLZ
server  |                 IPaLtLT1kSLUKBi81CEVZK8BRdo9ZOebOsuDp77P668TgZN1C7aMMiz8j6sm6
server  |                 AS9XKF4NJAabP"
server  | 
server  |             Name: Certificate Subject Key ID
server  |             Data:
server  |                 b5:bf:e1:6e:d3:2a:46:4a:a5:68:00:99:77:7d:2b:a7:
server  |                 2e:df:e4:51
server  | 
server  |             Name: Certificate Authority Key Identifier
server  |             Key ID:
server  |                 4b:1e:2d:e4:52:84:63:ee:b2:64:bf:ef:72:4c:fd:19:
server  |                 9a:86:a8:04
server  | 
server  |     Signature Algorithm: X9.62 ECDSA signature with SHA256
server  |     Signature:
server  |         30:44:02:20:6c:e6:c6:ac:a5:cd:52:a4:a2:7e:87:68:
server  |         ad:c6:cb:ae:19:d0:72:66:5c:12:41:e4:c0:4e:fe:43:
server  |         7d:63:91:69:02:20:17:56:78:80:8f:3a:19:cf:fd:10:
server  |         d4:9d:12:f9:d1:8b:b7:d0:d9:6e:51:b3:1c:8b:41:d1:
server  |         7e:e1:d7:e8:90:6c
server  |     Fingerprint (SHA-256):
server  |         3A:AA:49:3D:56:0E:17:DC:C1:01:E4:5F:FD:48:33:D9:C7:F3:0D:4A:81:EA:F2:8C:61:49:8B:7F:53:13:7B:8F
server  |     Fingerprint (SHA1):
server  |         C0:B8:F2:D6:AB:BC:3C:52:3B:21:2A:3C:37:7D:8F:94:FF:2D:30:AB
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.715 DEBUG [Server] Unsupported version: 57414954
server  | 0.715 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:48651 IpTos(Cs0, NotEct) len 15
server  | 0.715 DEBUG [Server] Unsupported version: 57414954
sim     | server:443 is available after 1.002567044s
server  | 0.715 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:48651 IpTos(Cs0, NotEct) len 15
server  | 0.715 ERROR failed to create NeqoQlog: IoError(Os { code: 17, kind: AlreadyExists, message: "File exists" })
server  | 0.715 DEBUG [Server] Unsupported version: 57414954
server  | 0.715 DEBUG [Server] type=VersionNegotiation path: [::]:443->[::ffff:193.167.100.2]:48651 IpTos(Cs0, NotEct) len 15
server  | 0.715 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.sh: sim:57832 is available after 1 seconds
server  | 1.037 DEBUG [Server] Handle initial
server  | 1.037 INFO AddressValidation: no token; accepting
server  | 1.037 INFO [Server] Accept connection CID [18]: fe7746d754e28d4aa3cb8f7e1c01f86132c2
server  | 1.037 DEBUG Overwrite initial version Version1 ==> Version1
server  | 1.041 DEBUG Outbound interface eth0 for destination ::ffff:193.167.0.100 has MTU 1500
server  | 1.041 INFO [Server ...] Received valid Initial packet with scid CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a dcid CID [18]: fe7746d754e28d4aa3cb8f7e1c01f86132c2
server  | 1.041 DEBUG [CryptoStates] Creating initial cipher state v=Version1, role=Server dcid=fe7746d754e28d4aa3cb8f7e1c01f86132c2
server  | 1.041 DEBUG Making Write Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.041 DEBUG Making Read Initial CryptoDxState, v=Version1 cipher=4865
server  | 1.041 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] State change from Init -> WaitInitial
server  | 1.041 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355728 type=Initial unv-path [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1200
server  |   -> RX Crypto { offset: 0, len: 263 }
server  |   -> RX Padding { len: 866 }
server  | 1.041 DEBUG Read Ok(263) bytes
server  | 1.042 DEBUG 0-RTT: no token, no 0-RTT
server  | 1.042 DEBUG Read secret available for Handshake: SymKey [32]: 2295ef65c25dfc93b0a76c5d4d29426da252a50a4ef80578be1bcdb30e3dccfc
server  | 1.042 DEBUG Write secret available for Handshake: SymKey [32]: 658795fa4dcc2e8a2f2291d36304702c2bfa84c9a1280c39bcd18c9af1cad0c7
server  | 1.042 DEBUG Writing transport parameters, msg=8
server  | 1.042 DEBUG Read secret available for ApplicationData: SymKey [32]: fa12df310b7ef92f8232253d57fdae88bd7aa556c3c30f5a27b666574174014d
server  | 1.042 DEBUG Write secret available for ApplicationData: SymKey [32]: 6f21deda4289687ccc4181a817793154e82633213aa12f23e129052f0ef455b6
server  | 1.042 DEBUG [Agent 0x55eb9b3be1d0] state -> InProgress
server  | 1.042 DEBUG Making Write Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.042 DEBUG Making Read Handshake CryptoDxState, v=Version1 cipher=4865
server  | 1.042 DEBUG [Crypto] Handshake keys installed
server  | 1.042 DEBUG Making Write ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 1.042 DEBUG [Crypto] Application write key installed
server  | 1.042 DEBUG [Recvd-in] Set ACK timer to Instant { tv_sec: 371, tv_nsec: 245777728 }
server  | 1.042 DEBUG [unv-path [::]:443->[::ffff:193.167.0.100]:40722] Make permanent
server  | 1.042 DEBUG [unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] set as primary path
server  | 1.042 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] State change from WaitInitial -> Handshaking
server  | 1.042 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.042 DEBUG Building Initial dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.042 DEBUG CRYPTO for in offset=0, len=90
server  | 1.042 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=0 type=Initial pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 163
server  |   TX -> Ack { largest_acknowledged: 1105355728, 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.042 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.042 DEBUG CRYPTO for hs offset=0, len=1012
server  | 1.042 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=0 type=Handshake pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 0, len: 1012 }
server  | 1.043 DEBUG packet_sent this=0x55eb9b3bdb40, pn=0, ps=1069
server  | 1.043 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 1.043 DEBUG packet_sent this=0x55eb9b3bdb40, pn=0, ps=163
server  | 1.043 DEBUG ECN probing: sent 1 probes
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 1.043 DEBUG Building Initial dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG CRYPTO for hs offset=1012, len=1174
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1 type=Handshake pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 1012, len: 1174 }
server  | 1.043 DEBUG packet_sent this=0x55eb9b3bdb40, pn=1, ps=1232
server  | 1.043 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 1.043 DEBUG ECN probing: sent 2 probes
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1136, pto: None, probe: EnumSet(), paced: false }
server  | 1.043 DEBUG Building Initial dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG CRYPTO for hs offset=2186, len=1078
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=2 type=Handshake pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1136
server  |   TX -> Crypto { offset: 2186, len: 1078 }
server  | 1.043 DEBUG packet_sent this=0x55eb9b3bdb40, pn=2, ps=1136
server  | 1.043 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 1.043 DEBUG ECN probing: sent 3 probes
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.043 DEBUG Building Initial dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 1.043 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 29.994388303s
server  | 1.043 DEBUG Setting timeout of 29.994388303s
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.043 DEBUG Building Initial dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 1.043 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 1.043 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: false }
server  | 1.043 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 29.994347356s
server  | 1.043 DEBUG Setting timeout of 29.994347356s
sim     | Dropping packet 2 (1200 bytes) from 193.167.0.100
sim     | Dropping packet 3 (66 bytes) from 193.167.0.100
sim     | Dropping packet 4 (66 bytes) from 193.167.0.100
sim     | Dropping packet 5 (59 bytes) from 193.167.0.100
sim     | Dropping packet 6 (59 bytes) from 193.167.0.100
sim     | Dropping packet 7 (59 bytes) from 193.167.0.100
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Drop packet number space in
server  | 3.039 DEBUG [LossRecovery] Reset loss recovery state for Initial
server  | 3.039 INFO [pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] discarding a packet without an RTT estimate; guessing RTT=2.001642485s
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355734 type=Handshake pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 59
server  |   -> RX Ping
server  | 3.039 DEBUG [Recvd-hs] immediate_ack at Instant { tv_sec: 373, tv_nsec: 247420213 }
server  | 3.039 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 247420213 }
server  | 3.039 DEBUG [pri-unv-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 247420213 }
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.039 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.039 DEBUG CRYPTO for hs offset=0, len=1160
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=3 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Ack { largest_acknowledged: 1105355734, 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: 1160 }
server  | 3.039 DEBUG packet_sent this=0x55eb9b3bdb40, pn=3, ps=1232
server  | 3.039 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.039 DEBUG ECN probing: sent 4 probes
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.039 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.039 DEBUG CRYPTO for hs offset=1160, len=1174
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=4 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 1160, len: 1174 }
server  | 3.039 DEBUG packet_sent this=0x55eb9b3bdb40, pn=4, ps=1232
server  | 3.039 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.039 DEBUG ECN probing: sent 5 probes
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.039 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.039 DEBUG CRYPTO for hs offset=2334, len=1174
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=5 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 2334, len: 1174 }
server  | 3.039 DEBUG packet_sent this=0x55eb9b3bdb40, pn=5, ps=1232
server  | 3.039 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.039 DEBUG ECN probing: sent 6 probes
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.039 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.039 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.039 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 99.76027ms
server  | 3.039 DEBUG Setting timeout of 99.76027ms
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.039 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.039 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.039 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.039 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 99.727369ms
server  | 3.039 DEBUG Setting timeout of 99.727369ms
server  | 3.071 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355735 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 63
server  |   -> RX Ack { largest_acknowledged: 3, ack_delay: 0, first_ack_range: 3, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 4, Ce: 0})) }
server  | 3.071 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[0..=3]
server  | 3.071 DEBUG [LossRecovery] ACK for Handshake - largest_acked=3
server  | 3.071 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=2464, cwnd=12320, state=SlowStart, new_acked=4669
server  | 3.071 DEBUG Acked crypto frame space=hs offset=0 length=1160
server  | 3.071 DEBUG Acked crypto frame space=hs offset=2186 length=1078
server  | 3.071 DEBUG Acked crypto frame space=hs offset=1012 length=1174
server  | 3.071 DEBUG Acked crypto frame space=hs offset=0 length=1012
server  | 3.071 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 279631041 }
server  | 3.071 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.071 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.071 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.071 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.071 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 55.688572ms
server  | 3.071 DEBUG Setting timeout of 55.688572ms
server  | 3.071 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.071 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.071 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.071 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.071 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 55.542157ms
server  | 3.071 DEBUG Setting timeout of 55.542157ms
server  | 3.072 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355736 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 63
server  |   -> RX Ack { largest_acknowledged: 4, ack_delay: 0, first_ack_range: 4, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 5, Ce: 0})) }
server  | 3.072 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[0..=4]
server  | 3.072 DEBUG [LossRecovery] ACK for Handshake - largest_acked=4
server  | 3.072 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=1232, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.072 DEBUG Acked crypto frame space=hs offset=1160 length=1174
server  | 3.072 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 280170343 }
server  | 3.072 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.072 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.072 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.072 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.072 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 44.406896ms
server  | 3.072 DEBUG Setting timeout of 44.406896ms
server  | 3.072 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.072 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.072 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.072 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.072 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 44.321816ms
server  | 3.072 DEBUG Setting timeout of 44.321816ms
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355737 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 63
server  |   -> RX Ack { largest_acknowledged: 5, ack_delay: 0, first_ack_range: 5, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[0..=5]
server  | 3.073 DEBUG [LossRecovery] ACK for Handshake - largest_acked=5
server  | 3.073 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.073 DEBUG Acked crypto frame space=hs offset=2334 length=1174
server  | 3.073 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 281192200 }
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.073 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.073 DEBUG CRYPTO for hs offset=3508, len=1174
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=6 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 3508, len: 1174 }
server  | 3.073 DEBUG packet_sent this=0x55eb9b3bdb40, pn=6, ps=1232
server  | 3.073 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.073 DEBUG ECN probing: sent 7 probes
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.073 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.073 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.073 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 67.408771ms
server  | 3.073 DEBUG Setting timeout of 67.408771ms
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.073 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.073 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.073 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.073 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 67.379426ms
server  | 3.073 DEBUG Setting timeout of 67.379426ms
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355738 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 63
server  |   -> RX Ack { largest_acknowledged: 6, ack_delay: 0, first_ack_range: 6, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[0..=6]
server  | 3.105 DEBUG [LossRecovery] ACK for Handshake - largest_acked=6
server  | 3.105 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.105 DEBUG Acked crypto frame space=hs offset=3508 length=1174
server  | 3.105 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 313283584 }
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.105 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.105 DEBUG CRYPTO for hs offset=4682, len=1174
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=7 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 4682, len: 1174 }
server  | 3.105 DEBUG packet_sent this=0x55eb9b3bdb40, pn=7, ps=1232
server  | 3.105 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.105 DEBUG ECN probing: sent 8 probes
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.105 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.105 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.105 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 59.126353ms
server  | 3.105 DEBUG Setting timeout of 59.126353ms
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.105 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.105 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.105 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.105 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 59.085235ms
server  | 3.105 DEBUG Setting timeout of 59.085235ms
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355739 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 64
server  |   -> RX Ack { largest_acknowledged: 7, ack_delay: 0, first_ack_range: 7, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 8, Ce: 0})) }
server  |   -> RX Ping
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[0..=7]
server  | 3.137 DEBUG [LossRecovery] ACK for Handshake - largest_acked=7
server  | 3.137 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.137 DEBUG Acked crypto frame space=hs offset=4682 length=1174
server  | 3.137 DEBUG [Recvd-hs] immediate_ack at Instant { tv_sec: 373, tv_nsec: 345470153 }
server  | 3.137 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 345470153 }
server  | 3.137 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 345470153 }
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.137 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.137 DEBUG CRYPTO for hs offset=5856, len=1159
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=8 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Ack { largest_acknowledged: 1105355739, ack_delay: 0, first_ack_range: 5, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  |   TX -> Crypto { offset: 5856, len: 1159 }
server  | 3.137 DEBUG packet_sent this=0x55eb9b3bdb40, pn=8, ps=1232
server  | 3.137 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.137 DEBUG ECN probing: sent 9 probes
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.137 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.137 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.137 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 51.935892ms
server  | 3.137 DEBUG Setting timeout of 51.935892ms
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.137 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.137 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.137 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.137 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 51.902249ms
server  | 3.137 DEBUG Setting timeout of 51.902249ms
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355740 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 63
server  |   -> RX Ack { largest_acknowledged: 8, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[8..=8]
server  | 3.169 DEBUG [LossRecovery] ACK for Handshake - largest_acked=8
server  | 3.169 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.169 DEBUG Acked crypto frame space=hs offset=5856 length=1159
server  | 3.169 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 377613905 }
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.169 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.169 DEBUG CRYPTO for hs offset=7015, len=1174
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=9 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 7015, len: 1174 }
server  | 3.169 DEBUG packet_sent this=0x55eb9b3bdb40, pn=9, ps=1232
server  | 3.169 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.169 DEBUG ECN probing: sent 10 probes
server  | 3.169 DEBUG ECN probing concluded with 10 probes sent
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.169 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.169 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.169 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 45.609096ms
server  | 3.169 DEBUG Setting timeout of 45.609096ms
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.169 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.169 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.169 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.169 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 45.573901ms
server  | 3.169 DEBUG Setting timeout of 45.573901ms
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355741 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 63
server  |   -> RX Ack { largest_acknowledged: 9, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 10, Ce: 0})) }
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[8..=9]
server  | 3.201 DEBUG [LossRecovery] ACK for Handshake - largest_acked=9
server  | 3.201 INFO ECN validation succeeded, path is capable
server  | 3.201 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.201 DEBUG Acked crypto frame space=hs offset=7015 length=1174
server  | 3.201 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 409616270 }
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.201 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.201 DEBUG CRYPTO for hs offset=8189, len=1174
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=10 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Crypto { offset: 8189, len: 1174 }
server  | 3.201 DEBUG packet_sent this=0x55eb9b3bdb40, pn=10, ps=1232
server  | 3.201 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.201 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.201 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.201 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 40.101445ms
server  | 3.201 DEBUG Setting timeout of 40.101445ms
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.201 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.201 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.201 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.201 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 40.070717ms
server  | 3.201 DEBUG Setting timeout of 40.070717ms
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355742 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 64
server  |   -> RX Ack { largest_acknowledged: 10, ack_delay: 0, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 11, Ce: 0})) }
server  |   -> RX Ping
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[8..=10]
server  | 3.233 DEBUG [LossRecovery] ACK for Handshake - largest_acked=10
server  | 3.233 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.233 DEBUG Acked crypto frame space=hs offset=8189 length=1174
server  | 3.233 DEBUG [Recvd-hs] immediate_ack at Instant { tv_sec: 373, tv_nsec: 441632913 }
server  | 3.233 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 441632913 }
server  | 3.233 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 441632913 }
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.233 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.233 DEBUG CRYPTO for hs offset=9363, len=616
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=11 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 689
server  |   TX -> Ack { largest_acknowledged: 1105355742, ack_delay: 0, first_ack_range: 8, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 9, Ce: 0})) }
server  |   TX -> Crypto { offset: 9363, len: 616 }
server  | 3.233 DEBUG packet_sent this=0x55eb9b3bdb40, pn=11, ps=689
server  | 3.233 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.233 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.233 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.233 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 23.001484ms
server  | 3.233 DEBUG Setting timeout of 23.001484ms
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.233 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.233 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.233 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.233 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 22.96204ms
server  | 3.233 DEBUG Setting timeout of 22.96204ms
server  | 3.257 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.257 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.257 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.257 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.257 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 4.922134492s
server  | 3.257 DEBUG Setting timeout of 4.922134492s
server  | 3.257 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.257 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.257 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.257 DEBUG TX blocked, profile=SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.257 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 4.922078357s
server  | 3.257 DEBUG Setting timeout of 4.922078357s
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355743 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 102
server  |   -> RX Ack { largest_acknowledged: 11, ack_delay: 0, first_ack_range: 0, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 12, Ce: 0})) }
server  |   -> RX Crypto { offset: 0, len: 36 }
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=hs, ranges=[11..=11]
server  | 3.267 DEBUG [LossRecovery] ACK for Handshake - largest_acked=11
server  | 3.267 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=0, cwnd=12320, state=SlowStart, new_acked=689
server  | 3.267 DEBUG Acked crypto frame space=hs offset=9363 length=616
server  | 3.267 DEBUG Read Ok(36) bytes
server  | 3.267 DEBUG [Agent 0x55eb9b3be1d0] 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  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] TLS connection complete
server  | 3.267 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 475326121 }
server  | 3.267 DEBUG Making Read ApplicationData CryptoDxState, v=Version1 cipher=4865
server  | 3.267 DEBUG [Crypto] application read keys installed
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] State change from Handshaking -> Connected
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] State change from Connected -> Confirmed
server  | 3.267 DEBUG PMTUD started with probe size 1380
server  | 3.267 INFO [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Connection established
server  | 3.267 DEBUG [Recvd-hs] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 475326121 }
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355728 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 310
server  |   -> RX NewConnectionId { sequence_number: 7, retire_prior: 0, connection_id: [179, 28, 156, 11, 132, 46, 111, 146, 125, 14, 209, 148, 220, 158, 32, 56, 17], stateless_reset_token: [12, 18, 183, 132, 53, 126, 73, 61, 84, 92, 157, 172, 234, 196, 170, 218] }
server  |   -> RX NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [247, 244, 240, 238, 55, 55, 6, 222, 111, 62, 87, 212, 158, 178, 220, 103, 89], stateless_reset_token: [175, 110, 157, 135, 44, 154, 211, 228, 202, 45, 168, 53, 115, 77, 2, 5] }
server  |   -> RX NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [102, 41, 95, 128, 199, 207, 51, 151, 146, 38, 208, 250, 8, 148, 121, 167, 33], stateless_reset_token: [99, 97, 14, 198, 67, 7, 235, 215, 131, 134, 132, 224, 38, 196, 252, 128] }
server  |   -> RX NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [95, 69, 178, 43, 4, 147, 82, 67, 241, 131, 131, 124, 68, 242, 160, 113, 22], stateless_reset_token: [45, 21, 15, 35, 43, 74, 2, 149, 63, 188, 232, 87, 11, 106, 83, 182] }
server  |   -> RX NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [222, 185, 48, 209, 252, 128, 223, 241, 163, 194, 86, 188, 71, 36, 83, 105, 168], stateless_reset_token: [253, 243, 154, 119, 9, 191, 52, 204, 243, 199, 203, 191, 253, 161, 227, 125] }
server  |   -> RX NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [231, 0, 107, 177, 176, 143, 62, 47, 0, 64, 189, 211, 244, 142, 148, 127, 199], stateless_reset_token: [10, 32, 220, 146, 98, 161, 20, 106, 116, 227, 79, 75, 17, 165, 172, 93] }
server  |   -> RX NewConnectionId { sequence_number: 1, retire_prior: 0, connection_id: [163, 164, 96, 196, 197, 186, 156, 53, 32, 30, 171, 150, 76, 14, 243, 111, 73], stateless_reset_token: [42, 163, 90, 34, 1, 55, 47, 181, 54, 209, 158, 251, 68, 161, 25, 168] }
server  |   -> RX Stream { stream_id: 0, offset: 0, len: 17, fin: true }
server  | 3.267 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 475326121 }
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.267 DEBUG Building Handshake dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a) scid Some(CID [10]: 3c23d01fd3d3254b879a)
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=12 type=Handshake pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 68
server  |   TX -> Ack { largest_acknowledged: 1105355743, ack_delay: 0, first_ack_range: 9, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 10, Ce: 0})) }
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Drop packet number space hs
server  | 3.267 DEBUG [LossRecovery] Reset loss recovery state for Handshake
server  | 3.267 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=0 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ack { largest_acknowledged: 1105355728, 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: [136, 33, 108, 89, 159, 35, 185, 22, 245, 133], stateless_reset_token: [79, 180, 215, 7, 153, 183, 175, 102, 178, 247, 177, 166, 77, 192, 0, 229] }
server  |   TX -> NewConnectionId { sequence_number: 2, retire_prior: 0, connection_id: [173, 84, 117, 33, 142, 142, 118, 66, 213, 53], stateless_reset_token: [247, 6, 219, 208, 192, 28, 217, 201, 129, 150, 229, 238, 85, 136, 251, 119] }
server  |   TX -> NewConnectionId { sequence_number: 3, retire_prior: 0, connection_id: [227, 168, 202, 40, 195, 72, 204, 144, 174, 158], stateless_reset_token: [1, 114, 19, 177, 29, 177, 103, 254, 116, 97, 207, 73, 92, 97, 42, 70] }
server  |   TX -> NewConnectionId { sequence_number: 4, retire_prior: 0, connection_id: [78, 244, 63, 189, 185, 179, 193, 83, 93, 123], stateless_reset_token: [211, 145, 120, 184, 4, 65, 198, 25, 77, 110, 130, 142, 103, 72, 68, 249] }
server  |   TX -> NewConnectionId { sequence_number: 5, retire_prior: 0, connection_id: [51, 210, 35, 193, 245, 210, 10, 57, 139, 53], stateless_reset_token: [129, 93, 132, 41, 14, 70, 174, 255, 113, 210, 248, 74, 165, 182, 105, 12] }
server  |   TX -> NewConnectionId { sequence_number: 6, retire_prior: 0, connection_id: [21, 111, 190, 18, 98, 123, 112, 216, 76, 17], stateless_reset_token: [47, 251, 98, 22, 53, 159, 54, 254, 227, 96, 66, 90, 55, 107, 137, 20] }
server  |   TX -> Padding { len: 1033 }
server  | 3.267 DEBUG packet_sent this=0x55eb9b3bdb40, pn=0, ps=1264
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.267 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.267 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.267 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 19.970676ms
server  | 3.267 DEBUG Setting timeout of 19.970676ms
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] send session ticket 406d0012fe7746d754e28d4aa3cb8f7e1c01f86132c20104800075300408ffffffffffffffff0504801000000604801000000704801000000801100901100b01140e01080f0a3c23d01fd3d3254b879a110c000000018abaca2a000000016ab200c0000000ff02de1a0243e8200100686921
server  | 3.268 DEBUG Path = 'bnnpbzbysh'
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.268 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.268 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 18.909385ms
server  | 3.268 DEBUG Setting timeout of 18.909385ms
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355729 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1406
server  |   -> RX Ping
server  |   -> RX Padding { len: 1374 }
server  | 3.268 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 373, tv_nsec: 477051107 }
server  | 3.268 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 477051107 }
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.268 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 50
server  |   TX -> Ack { largest_acknowledged: 1105355729, ack_delay: 0, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 2, Ce: 0})) }
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.268 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.268 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.268 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 20.018658ms
server  | 3.269 DEBUG Setting timeout of 20.018658ms
server  | 3.269 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.269 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.269 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.269 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 19.99805ms
server  | 3.269 DEBUG Setting timeout of 19.99805ms
server  | 3.290 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.290 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.290 DEBUG Sending PMTUD probe of size 1380, count 1
server  | 3.290 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=2 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 0, len: >>1294, fin: false }
server  | 3.290 DEBUG packet_sent this=0x55eb9b3bdb40, pn=2, ps=1332
server  | 3.290 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.290 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.290 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.290 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 31.044155ms
server  | 3.290 DEBUG Setting timeout of 31.044155ms
server  | 3.290 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.290 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.290 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.290 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 31.016604ms
server  | 3.290 DEBUG Setting timeout of 31.016604ms
server  | 3.305 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355730 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 1, ack_delay: 655, first_ack_range: 1, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 2, Ce: 0})) }
server  |   -> RX Padding { len: 2 }
server  | 3.305 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=ap, ranges=[0..=1]
server  | 3.305 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=1
server  | 3.305 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=1332, cwnd=12320, state=SlowStart, new_acked=1264
server  | 3.305 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.305 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.305 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.305 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 11.962475ms
server  | 3.305 DEBUG Setting timeout of 11.962475ms
server  | 3.305 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.305 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.305 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.305 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 11.847359ms
server  | 3.305 DEBUG Setting timeout of 11.847359ms
server  | 3.317 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1232, pto: None, probe: EnumSet(), paced: false }
server  | 3.317 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.317 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=3 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1232
server  |   TX -> Stream { stream_id: 0, offset: 1294, len: >>1193, fin: false }
server  | 3.318 DEBUG packet_sent this=0x55eb9b3bdb40, pn=3, ps=1232
server  | 3.318 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.318 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.318 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.318 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 27.157623ms
server  | 3.318 DEBUG Setting timeout of 27.157623ms
server  | 3.318 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.318 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.318 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.318 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 27.126625ms
server  | 3.318 DEBUG Setting timeout of 27.126625ms
server  | 3.327 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355731 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 2, ack_delay: 647, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 3, Ce: 0})) }
server  |   -> RX Padding { len: 2 }
server  | 3.327 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=ap, ranges=[0..=2]
server  | 3.327 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=2
server  | 3.327 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=1232, cwnd=12320, state=SlowStart, new_acked=1332
server  | 3.327 DEBUG PMTUD probe of size 1380 succeeded
server  | 3.327 DEBUG PMTUD started with probe size 1420
server  | 3.327 DEBUG PLPMTU changed from 1232 to 1332, updating pacer
server  | 3.327 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.327 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.327 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.327 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 16.910452ms
server  | 3.327 DEBUG Setting timeout of 16.910452ms
server  | 3.327 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.327 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.327 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.327 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 16.832706ms
server  | 3.327 DEBUG Setting timeout of 16.832706ms
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355732 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1444
server  |   -> RX Ping
server  |   -> RX Padding { len: 1415 }
server  | 3.331 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 373, tv_nsec: 539597566 }
server  | 3.331 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 539597566 }
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.331 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=4 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 50
server  |   TX -> Ack { largest_acknowledged: 1105355732, ack_delay: 0, first_ack_range: 4, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 5, Ce: 0})) }
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.331 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.331 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 13.46651ms
server  | 3.331 DEBUG Setting timeout of 13.46651ms
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.331 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.331 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.331 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 13.436774ms
server  | 3.331 DEBUG Setting timeout of 13.436774ms
server  | 3.346 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 3.346 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.346 DEBUG Sending PMTUD probe of size 1420, count 1
server  | 3.346 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=5 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1372
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 2487, len: >>1332, fin: false }
server  | 3.346 DEBUG packet_sent this=0x55eb9b3bdb40, pn=5, ps=1372
server  | 3.346 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.346 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.346 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.346 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 25.251481ms
server  | 3.346 DEBUG Setting timeout of 25.251481ms
server  | 3.346 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.346 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.346 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.346 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 25.223778ms
server  | 3.346 DEBUG Setting timeout of 25.223778ms
server  | 3.354 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355733 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 3, ack_delay: 656, first_ack_range: 3, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 4, Ce: 0})) }
server  |   -> RX Padding { len: 2 }
server  | 3.355 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=ap, ranges=[0..=3]
server  | 3.355 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=3
server  | 3.355 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=1372, cwnd=12320, state=SlowStart, new_acked=1232
server  | 3.355 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.355 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.355 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.355 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 14.24353ms
server  | 3.355 DEBUG Setting timeout of 14.24353ms
server  | 3.355 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.355 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.355 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.355 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 14.046557ms
server  | 3.355 DEBUG Setting timeout of 14.046557ms
server  | 3.370 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1332, pto: None, probe: EnumSet(), paced: false }
server  | 3.370 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.370 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=6 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1332
server  |   TX -> Stream { stream_id: 0, offset: 3819, len: >>1293, fin: false }
server  | 3.370 DEBUG packet_sent this=0x55eb9b3bdb40, pn=6, ps=1332
server  | 3.370 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.370 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.370 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.370 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 22.107146ms
server  | 3.370 DEBUG Setting timeout of 22.107146ms
server  | 3.370 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.370 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.370 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.370 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 22.08301ms
server  | 3.370 DEBUG Setting timeout of 22.08301ms
server  | 3.383 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355734 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 5, ack_delay: 646, first_ack_range: 2, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 6, Ce: 0})) }
server  |   -> RX Padding { len: 2 }
server  | 3.383 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=ap, ranges=[3..=5]
server  | 3.383 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=5
server  | 3.383 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=1332, cwnd=12320, state=SlowStart, new_acked=1372
server  | 3.383 DEBUG PMTUD probe of size 1420 succeeded
server  | 3.383 DEBUG PMTUD started with probe size 1470
server  | 3.383 DEBUG PLPMTU changed from 1332 to 1372, updating pacer
server  | 3.383 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.383 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.383 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.383 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 6.659688ms
server  | 3.383 DEBUG Setting timeout of 6.659688ms
server  | 3.383 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.383 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.383 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.383 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 6.541567ms
server  | 3.383 DEBUG Setting timeout of 6.541567ms
server  | 3.391 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 3.391 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.391 DEBUG Sending PMTUD probe of size 1470, count 1
server  | 3.391 DEBUG CRYPTO for ap offset=0, len=321
server  | 3.391 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=7 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 1422
server  |   TX -> Ping
server  |   TX -> Stream { stream_id: 0, offset: 5112, len: 8, fin: true }
server  |   TX -> Crypto { offset: 0, len: 321 }
server  |   TX -> NewToken { token: [173, 154, 139, 141, 134, 1, 0, 96, 118, 192, 214, 65, 151, 211, 59, 135, 236, 12, 22, 48, 2, 154, 160, 205, 41, 101, 117, 249, 54, 67, 57, 154, 210, 245, 227, 145, 129, 91, 187, 85, 177, 199, 31] }
server  |   TX -> Padding { len: 1003 }
server  | 3.391 DEBUG packet_sent this=0x55eb9b3bdb40, pn=7, ps=1422
server  | 3.391 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.391 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.391 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.391 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 21.058065ms
server  | 3.391 DEBUG Setting timeout of 21.058065ms
server  | 3.391 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.391 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.391 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.391 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 21.030143ms
server  | 3.391 DEBUG Setting timeout of 21.030143ms
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355735 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 39
server  |   -> RX Ack { largest_acknowledged: 6, ack_delay: 647, first_ack_range: 3, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 7, Ce: 0})) }
server  |   -> RX Ping
server  |   -> RX Padding { len: 1 }
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] Rx ACK space=ap, ranges=[3..=6]
server  | 3.407 DEBUG [LossRecovery] ACK for ApplicationData - largest_acked=6
server  | 3.407 DEBUG on_packets_acked this=0x55eb9b3bdb40, limited=1, bytes_in_flight=1422, cwnd=12320, state=SlowStart, new_acked=1332
server  | 3.407 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 373, tv_nsec: 615428587 }
server  | 3.407 DEBUG [Recvd-ap] Set ACK timer to Instant { tv_sec: 373, tv_nsec: 615428587 }
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.407 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=8 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 50
server  |   TX -> Ack { largest_acknowledged: 1105355735, ack_delay: 0, first_ack_range: 7, ack_ranges: [], ecn_count: Some(Count({NotEct: 0, Ect1: 0, Ect0: 8, Ce: 0})) }
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.407 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.407 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 3.189244ms
server  | 3.407 DEBUG Setting timeout of 3.189244ms
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.407 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.407 DEBUG TX blocked, profile=SendProfile { limit: 255, pto: None, probe: EnumSet(), paced: true }
server  | 3.407 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 3.147416ms
server  | 3.407 DEBUG Setting timeout of 3.147416ms
server  | 3.411 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 3.411 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.411 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 3.411 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 2.555348742s
server  | 3.411 DEBUG Setting timeout of 2.555348742s
server  | 3.411 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 3.411 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.411 DEBUG TX blocked, profile=SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 3.411 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] delay duration 2.555306623s
server  | 3.411 DEBUG Setting timeout of 2.555306623s
server  | 3.423 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=1105355736 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 39
server  |   -> RX ConnectionClose { error_code: Transport(0), frame_type: 0, reason_phrase: "" }
server  |   -> RX Padding { len: 7 }
server  | 3.423 INFO [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] ConnectionClose received. Error code: Transport(0) frame type 0 reason 
server  | 3.423 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] State change from Confirmed -> Draining { error: Transport(PeerError(0)), timeout: Instant { tv_sec: 381, tv_nsec: 358664407 } }
server  | 3.423 DEBUG [pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722] Path validated Instant { tv_sec: 373, tv_nsec: 631252677 }
server  | 3.423 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] output_path send_profile SendProfile { limit: 1372, pto: None, probe: EnumSet(), paced: false }
server  | 3.423 DEBUG Building Short dcid Some(CID [17]: 7dc71affd858cf89946b9a88c89bfd6e7a)
server  | 3.423 DEBUG [Recvd-ap] immediate_ack at Instant { tv_sec: 373, tv_nsec: 631252677 }
server  | 3.423 DEBUG [Server fe7746d754e28d4aa3cb8f7e1c01f86132c2] pn=9 type=Short pri-path:7dc71affd858cf89946b9a88c89bfd6e7a [::]:443->[::ffff:193.167.0.100]:40722 IpTos(Cs0, Ect0) len 54
server  |   TX -> Ack { largest_acknowledged: 1105355736, 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  | 3.423 DEBUG Setting timeout of 7.727243925s
server  | 3.423 DEBUG Setting timeout of 7.727233806s

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:26:00,293 Using the client's key log file.
2025-04-30 10:26:00,307 
2025-04-30 10:26:00,307 Using the client's key log file.
2025-04-30 10:26:00,307 Using the client's key log file.
2025-04-30 10:26:00,320 
2025-04-30 10:26:00,321 Using the client's key log file.
2025-04-30 10:26:00,321 Using the client's key log file.
2025-04-30 10:26:01,004 Check of downloaded files succeeded.
2025-04-30 10:26:01,351 Server sent 9979 bytes in Handshake CRYPTO frames.
2025-04-30 10:26:01,743 Received a 1200 byte Initial packet from the client. Amplification limit: 3600
2025-04-30 10:26:01,743 Received a 1232 byte Handshake packet from the server. Total: 1232
2025-04-30 10:26:01,743 Received a 1232 byte Handshake packet from the server. Total: 2464
2025-04-30 10:26:01,743 Received a 1136 byte Handshake packet from the server. Total: 3600