[2025-12-13T10:48:30.119431558Z INFO quiche_server] listening on [::]:443 [2025-12-13T10:48:30.119459130Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-12-13T10:48:30.119466453Z TRACE quiche_server] GSO detected: false [2025-12-13T10:48:30.452597354Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:43716 to [::]:443 [2025-12-13T10:48:30.452636286Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-12-13T10:48:30.452644391Z WARN quiche_server] Doing version negotiation [2025-12-13T10:48:30.452709042Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.167088629Z TRACE quiche_server] got 1200 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.167118425Z TRACE quiche_server] got packet Initial version=1 dcid=ff3edb481bcee06a scid=d1655a5d962c7693 token= [2025-12-13T10:48:31.167136529Z DEBUG quiche_server] New connection: dcid=ff3edb481bcee06a scid=073bed07892daf0354e38a0186b8a1c92d522d15 [2025-12-13T10:48:31.167316144Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Initial version=1 dcid=ff3edb481bcee06a scid=d1655a5d962c7693 token= len=1174 pn=0 [2025-12-13T10:48:31.167329619Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm CRYPTO off=0 len=305 [2025-12-13T10:48:31.167358012Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-12-13T10:48:31.167362571Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-12-13T10:48:31.167472887Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 write message lvl=Initial len=123 [2025-12-13T10:48:31.167506921Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 set write secret lvl=Handshake [2025-12-13T10:48:31.167593713Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 write message lvl=Handshake len=695 [2025-12-13T10:48:31.167599474Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 set write secret lvl=OneRTT [2025-12-13T10:48:31.167606777Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 set read secret lvl=Handshake [2025-12-13T10:48:31.167626444Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm PADDING len=845 [2025-12-13T10:48:31.167644378Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 1200 bytes [2025-12-13T10:48:31.167662892Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.167676658Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Initial version=1 dcid=d1655a5d962c7693 scid=073bed07892daf0354e38a0186b8a1c92d522d15 len=132 pn=0 [2025-12-13T10:48:31.167680646Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm ACK delay=46 blocks=[0..0] ecn_counts=None [2025-12-13T10:48:31.167685695Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm CRYPTO off=0 len=123 [2025-12-13T10:48:31.167694641Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=998.970234ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=187 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 393131885 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 393131885 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 393131885 }, next_time: Instant { tv_sec: 972, tv_nsec: 393131885 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.167726341Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Handshake version=1 dcid=d1655a5d962c7693 scid=073bed07892daf0354e38a0186b8a1c92d522d15 len=699 pn=1 [2025-12-13T10:48:31.167730078Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm CRYPTO off=0 len=695 [2025-12-13T10:48:31.167736049Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=998.929267ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=940 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 393131885 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 393131885 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 393131885 }, next_time: Instant { tv_sec: 972, tv_nsec: 393131885 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.167776915Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 393131885 } }) [2025-12-13T10:48:31.167784770Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.167790561Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.167795941Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.167798846Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.201319666Z TRACE quiche_server] got 96 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.201335565Z TRACE quiche_server] got packet Handshake version=1 dcid=073bed07892daf0354e38a0186b8a1c92d522d15 scid=d1655a5d962c7693 [2025-12-13T10:48:31.201346235Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Handshake version=1 dcid=073bed07892daf0354e38a0186b8a1c92d522d15 scid=d1655a5d962c7693 len=59 pn=0 [2025-12-13T10:48:31.201354471Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm CRYPTO off=0 len=36 [2025-12-13T10:48:31.201368096Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 set read secret lvl=OneRTT [2025-12-13T10:48:31.201397501Z TRACE quiche::tls] 073bed07892daf0354e38a0186b8a1c92d522d15 write message lvl=OneRTT len=396 [2025-12-13T10:48:31.201405927Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 dropped epoch 1 state [2025-12-13T10:48:31.201409824Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("P-256") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 120000, stateless_reset_token: None, max_udp_payload_size: 1200, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 16777216, initial_max_stream_data_bidi_remote: 16777216, initial_max_stream_data_uni: 16777216, initial_max_streams_bidi: 128, initial_max_streams_uni: 128, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: true, active_conn_id_limit: 8, initial_source_connection_id: Some(d1655a5d962c7693), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-12-13T10:48:31.201436193Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 dropped epoch 0 state [2025-12-13T10:48:31.201439610Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 96 bytes [2025-12-13T10:48:31.201445971Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.201465608Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=681 pn=2 [2025-12-13T10:48:31.201469345Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[ea, 49, eb, 3b, 28, 44, 32, f5, 18, 93, 82, 98, ff, 34, 35, 84, 11, 73, 7a, e3] reset_token=[3a, 27, 7a, 5c, 51, 31, 23, b5, ae, 14, bc, df, ab, bf, 97, 3f] [2025-12-13T10:48:31.201476869Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[cb, dd, a0, d6, b5, ea, 17, cf, 55, 43, 62, 34, 33, cf, 7a, f0, 89, 77, e0, ec] reset_token=[e6, da, ae, ed, da, 36, 38, f9, bc, 0f, 59, e4, c7, 34, ce, 8b] [2025-12-13T10:48:31.201483381Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[fb, 80, 13, d6, 42, 0f, 2c, 06, fa, fe, 2a, c9, a5, 95, ad, b4, 91, 15, c6, d5] reset_token=[56, 24, 56, 1e, 9c, 11, 9f, e9, 2b, c1, c0, e2, a7, 99, 42, 11] [2025-12-13T10:48:31.201489904Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[d9, 71, 72, 0b, a1, 81, 66, e1, 2f, 1a, 6d, 9a, 68, 20, ad, 0b, bf, 83, 22, 70] reset_token=[13, 63, 7f, b3, 25, 44, 67, 93, 9d, 0d, 33, fa, cc, e0, de, bf] [2025-12-13T10:48:31.201496376Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[cb, fa, 1b, 7f, 92, 33, a3, 63, a9, 19, e5, 7c, fb, 26, 67, a4, e7, 93, a6, 38] reset_token=[46, 34, 39, cc, c4, ef, 2b, 1f, 05, 98, 42, 22, 04, c7, 7c, 1c] [2025-12-13T10:48:31.201502617Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[88, 96, 7f, 3a, 2d, c4, c0, 90, 1a, 8c, ba, 22, 6d, a6, 4e, 47, 0a, 30, b1, 89] reset_token=[6b, 59, c5, 89, cb, 00, 44, 62, 54, 08, 2a, 41, 6a, 09, 2f, 5d] [2025-12-13T10:48:31.201508929Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[49, 62, c5, e3, c0, ef, 7d, 91, 37, 10, 2d, 55, 1c, 42, d5, a7, dd, eb, 98, 91] reset_token=[db, b0, 3b, 16, 22, 81, 33, b7, 05, 0b, d9, 8a, e1, 51, b6, 34] [2025-12-13T10:48:31.201515161Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm HANDSHAKE_DONE [2025-12-13T10:48:31.201517916Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm CRYPTO off=0 len=396 [2025-12-13T10:48:31.201529868Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023924539s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=707 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 426921156 }, next_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.201602183Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 707 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 426921156 } }) [2025-12-13T10:48:31.201611250Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.201625828Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.201631248Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.201634163Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.202306161Z TRACE quiche_server] got 1200 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.202314767Z TRACE quiche_server] got packet Initial version=1 dcid=073bed07892daf0354e38a0186b8a1c92d522d15 scid=d1655a5d962c7693 token= [2025-12-13T10:48:31.202321339Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 dropped invalid packet [2025-12-13T10:48:31.202324545Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 1200 bytes [2025-12-13T10:48:31.202329966Z TRACE quiche_server] got 63 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.202333232Z TRACE quiche_server] got packet Handshake version=1 dcid=073bed07892daf0354e38a0186b8a1c92d522d15 scid=d1655a5d962c7693 [2025-12-13T10:48:31.202337740Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 dropped invalid packet [2025-12-13T10:48:31.202340475Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 63 bytes [2025-12-13T10:48:31.202344022Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.202347238Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.202349933Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.202480797Z TRACE quiche_server] got 76 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.202484945Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.202489834Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=55 pn=0 [2025-12-13T10:48:31.202496126Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm STREAM id=0 off=0 len=31 fin=true [2025-12-13T10:48:31.202505454Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 76 bytes [2025-12-13T10:48:31.202508980Z DEBUG quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 response stream 0 is writable with capacity Ok(11293) [2025-12-13T10:48:31.202516144Z TRACE quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 received 31 bytes [2025-12-13T10:48:31.202519169Z TRACE quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 stream 0 has 31 bytes (fin? true) [2025-12-13T10:48:31.202524670Z INFO quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 got GET request for "/www/angry-indigo-necromancer" on stream 0 [2025-12-13T10:48:31.202572609Z INFO quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 sending response of size 5120 on stream 0 [2025-12-13T10:48:31.202587216Z TRACE quiche_server] got 69 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.202591204Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.202596043Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=48 pn=1 [2025-12-13T10:48:31.202601092Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm STREAM id=4 off=0 len=24 fin=true [2025-12-13T10:48:31.202607554Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 69 bytes [2025-12-13T10:48:31.202610580Z DEBUG quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 response stream 4 is writable with capacity Ok(11293) [2025-12-13T10:48:31.202614708Z TRACE quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 received 24 bytes [2025-12-13T10:48:31.202617423Z TRACE quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 stream 4 has 24 bytes (fin? true) [2025-12-13T10:48:31.202621110Z INFO quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 got GET request for "/www/dull-jealous-ring" on stream 4 [2025-12-13T10:48:31.202637000Z INFO quiche_apps::common] 073bed07892daf0354e38a0186b8a1c92d522d15 sending response of size 10240 on stream 4 [2025-12-13T10:48:31.202649413Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.202657718Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=3 [2025-12-13T10:48:31.202661094Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm ACK delay=7 blocks=[0..1] ecn_counts=None [2025-12-13T10:48:31.202665142Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=0 off=0 len=1164 fin=false [2025-12-13T10:48:31.202672987Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023978701s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=1907 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428118276 }, next_time: Instant { tv_sec: 972, tv_nsec: 428118276 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202688466Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=4 [2025-12-13T10:48:31.202691651Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=0 len=1169 fin=false [2025-12-13T10:48:31.202696811Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023989139s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=3107 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428152379 }, next_time: Instant { tv_sec: 972, tv_nsec: 428152379 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202709144Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=5 [2025-12-13T10:48:31.202712160Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=0 off=1164 len=1168 fin=false [2025-12-13T10:48:31.202716929Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023990062s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=4307 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428173419 }, next_time: Instant { tv_sec: 972, tv_nsec: 428173419 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202732338Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=6 [2025-12-13T10:48:31.202735444Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=1169 len=1168 fin=false [2025-12-13T10:48:31.202740683Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.02398957s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=5507 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428196672 }, next_time: Instant { tv_sec: 972, tv_nsec: 428196672 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202752535Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=7 [2025-12-13T10:48:31.202755621Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=0 off=2332 len=1168 fin=false [2025-12-13T10:48:31.202760200Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023990372s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=6707 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428216990 }, next_time: Instant { tv_sec: 972, tv_nsec: 428216990 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202771852Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=8 [2025-12-13T10:48:31.202774907Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=2337 len=1168 fin=false [2025-12-13T10:48:31.202798441Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023971116s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=7907 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428236386 }, next_time: Instant { tv_sec: 972, tv_nsec: 428236386 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202811716Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=9 [2025-12-13T10:48:31.202814832Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=0 off=3500 len=1168 fin=false [2025-12-13T10:48:31.202819771Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023989501s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=9107 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428275710 }, next_time: Instant { tv_sec: 972, tv_nsec: 428275710 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202831513Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=10 [2025-12-13T10:48:31.202834589Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=3505 len=1168 fin=false [2025-12-13T10:48:31.202839388Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023990181s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=10307 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 10, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428295997 }, next_time: Instant { tv_sec: 972, tv_nsec: 428295997 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202854145Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=458 pn=11 [2025-12-13T10:48:31.202857251Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=0 off=4668 len=452 fin=true [2025-12-13T10:48:31.202862030Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023990132s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=10791 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 11, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428318590 }, next_time: Instant { tv_sec: 972, tv_nsec: 428318590 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202941418Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 10084 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 428118276 } }) [2025-12-13T10:48:31.202947349Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.202952088Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.202957067Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=12 [2025-12-13T10:48:31.202960173Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=4673 len=1168 fin=false [2025-12-13T10:48:31.202965894Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=1.023988138s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=11991 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 12, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 428420530 }, next_time: Instant { tv_sec: 972, tv_nsec: 428420530 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.202978337Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.202992203Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 428420530 } }) [2025-12-13T10:48:31.202996621Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.232984429Z TRACE quiche_server] got 69 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.233005839Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.233015076Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=48 pn=2 [2025-12-13T10:48:31.233026968Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[d5, fb, df, c0, d2, 95, 71, 55] reset_token=[35, 89, 75, 5f, 86, 0c, ce, 94, 91, f0, 62, 6c, 53, cc, e2, 3e] [2025-12-13T10:48:31.233043279Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 69 bytes [2025-12-13T10:48:31.233050973Z TRACE quiche_server] got 69 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.233055351Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.233060792Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=48 pn=3 [2025-12-13T10:48:31.233067674Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[20, e6, e8, bb, 24, fb, 50, 8f] reset_token=[39, cf, 7c, ef, 98, 3d, 21, 61, 2f, 94, c8, 5e, 43, fa, e9, c6] [2025-12-13T10:48:31.233078384Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 69 bytes [2025-12-13T10:48:31.233086960Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.233100596Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=5 pn=13 [2025-12-13T10:48:31.233107869Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm ACK delay=4 blocks=[0..3] ecn_counts=None [2025-12-13T10:48:31.233120443Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=993.833148ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=12000 ssthresh=18446744073709551615 bytes_in_flight=11991 app_limited=false congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 426921156 }, end_of_app_limited: 1, last_sent_packet: 13, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 12000, used: 0, rate: 0, last_update: Instant { tv_sec: 972, tv_nsec: 458558809 }, next_time: Instant { tv_sec: 972, tv_nsec: 458558809 }, max_datagram_size: 1200, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.233164255Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 31 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 458558809 } }) [2025-12-13T10:48:31.233171258Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.233177049Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.233183390Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.233186867Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.234505261Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.234517454Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.234524507Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=4 [2025-12-13T10:48:31.234531189Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=31 blocks=[2..3] ecn_counts=None [2025-12-13T10:48:31.234566365Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 2 [2025-12-13T10:48:31.234577446Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 3 [2025-12-13T10:48:31.234593596Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.234598846Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.234606790Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=14 [2025-12-13T10:48:31.234610157Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=5841 len=1168 fin=false [2025-12-13T10:48:31.234617681Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=120.596087ms latest_rtt=31.870936ms srtt=31.870936ms min_rtt=31.870936ms rttvar=15.935468ms cwnd=13350 ssthresh=18446744073709551615 bytes_in_flight=11284 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1907, delivered_time: Instant { tv_sec: 972, tv_nsec: 459989212 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 428118276 }, end_of_app_limited: 0, last_sent_packet: 14, largest_acked: 3, rate_sample: RateSample { bandwidth: 461.34 Kbps, is_app_limited: true, interval: 33.068056ms, delivered: 1907, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 972, tv_nsec: 426921156 }), send_elapsed: 1.19712ms, ack_elapsed: 33.068056ms, rtt: 31.870936ms } } pacer=Pacer { enabled: false, capacity: 13200, used: 0, rate: 523596, last_update: Instant { tv_sec: 972, tv_nsec: 460067548 }, next_time: Instant { tv_sec: 972, tv_nsec: 460067548 }, max_datagram_size: 1200, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(14) last_round_min_rtt=31.870936ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.234635684Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=15 [2025-12-13T10:48:31.234639001Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=7009 len=1168 fin=false [2025-12-13T10:48:31.234644280Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=120.601767ms latest_rtt=31.870936ms srtt=31.870936ms min_rtt=31.870936ms rttvar=15.935468ms cwnd=13350 ssthresh=18446744073709551615 bytes_in_flight=12484 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1907, delivered_time: Instant { tv_sec: 972, tv_nsec: 459989212 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 428118276 }, end_of_app_limited: 0, last_sent_packet: 15, largest_acked: 3, rate_sample: RateSample { bandwidth: 461.34 Kbps, is_app_limited: true, interval: 33.068056ms, delivered: 1907, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 972, tv_nsec: 426921156 }), send_elapsed: 1.19712ms, ack_elapsed: 33.068056ms, rtt: 31.870936ms } } pacer=Pacer { enabled: false, capacity: 13200, used: 0, rate: 523596, last_update: Instant { tv_sec: 972, tv_nsec: 460067548 }, next_time: Instant { tv_sec: 972, tv_nsec: 460067548 }, max_datagram_size: 1200, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(14) last_round_min_rtt=31.870936ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.234658307Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=840 pn=16 [2025-12-13T10:48:31.234661463Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=8177 len=834 fin=false [2025-12-13T10:48:31.234666452Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=120.602569ms latest_rtt=31.870936ms srtt=31.870936ms min_rtt=31.870936ms rttvar=15.935468ms cwnd=13350 ssthresh=18446744073709551615 bytes_in_flight=13350 app_limited=false congestion_recovery_start_time=None Rate { delivered: 1907, delivered_time: Instant { tv_sec: 972, tv_nsec: 459989212 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 428118276 }, end_of_app_limited: 0, last_sent_packet: 16, largest_acked: 3, rate_sample: RateSample { bandwidth: 461.34 Kbps, is_app_limited: true, interval: 33.068056ms, delivered: 1907, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 972, tv_nsec: 426921156 }), send_elapsed: 1.19712ms, ack_elapsed: 33.068056ms, rtt: 31.870936ms } } pacer=Pacer { enabled: false, capacity: 13200, used: 0, rate: 523596, last_update: Instant { tv_sec: 972, tv_nsec: 460067548 }, next_time: Instant { tv_sec: 972, tv_nsec: 460067548 }, max_datagram_size: 1200, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(14) last_round_min_rtt=31.870936ms current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.234715744Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 3266 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 460067548 } }) [2025-12-13T10:48:31.234721896Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.234726103Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.234730772Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.234733487Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.236355428Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.236364505Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.236370055Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=5 [2025-12-13T10:48:31.236376007Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=13 blocks=[2..5] ecn_counts=None [2025-12-13T10:48:31.236380014Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 4 [2025-12-13T10:48:31.236382899Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 5 [2025-12-13T10:48:31.236393419Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.236397957Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.236403698Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=1174 pn=17 [2025-12-13T10:48:31.236406774Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=9011 len=1168 fin=false [2025-12-13T10:48:31.236413246Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=106.561522ms latest_rtt=33.661602ms srtt=32.081769ms min_rtt=31.870936ms rttvar=12.373267ms cwnd=16050 ssthresh=18446744073709551615 bytes_in_flight=12150 app_limited=true congestion_recovery_start_time=None Rate { delivered: 4307, delivered_time: Instant { tv_sec: 972, tv_nsec: 461835021 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 428173419 }, end_of_app_limited: 0, last_sent_packet: 17, largest_acked: 5, rate_sample: RateSample { bandwidth: 986.88 Kbps, is_app_limited: true, interval: 34.913865ms, delivered: 4307, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 972, tv_nsec: 426921156 }), send_elapsed: 1.252263ms, ack_elapsed: 34.913865ms, rtt: 33.661602ms } } pacer=Pacer { enabled: false, capacity: 13200, used: 0, rate: 625355, last_update: Instant { tv_sec: 972, tv_nsec: 460067548 }, next_time: Instant { tv_sec: 972, tv_nsec: 460067548 }, max_datagram_size: 1200, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(14) last_round_min_rtt=31.870936ms current_round_min_rtt=33.661602ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=2 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.236432742Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx pkt Short dcid=d1655a5d962c7693 key_phase=false len=67 pn=18 [2025-12-13T10:48:31.236435959Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 tx frm STREAM id=4 off=10179 len=61 fin=true [2025-12-13T10:48:31.236440868Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 timer=106.564527ms latest_rtt=33.661602ms srtt=32.081769ms min_rtt=31.870936ms rttvar=12.373267ms cwnd=16050 ssthresh=18446744073709551615 bytes_in_flight=12243 app_limited=true congestion_recovery_start_time=None Rate { delivered: 4307, delivered_time: Instant { tv_sec: 972, tv_nsec: 461835021 }, first_sent_time: Instant { tv_sec: 972, tv_nsec: 428173419 }, end_of_app_limited: 0, last_sent_packet: 18, largest_acked: 5, rate_sample: RateSample { bandwidth: 986.88 Kbps, is_app_limited: true, interval: 34.913865ms, delivered: 4307, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 972, tv_nsec: 426921156 }), send_elapsed: 1.252263ms, ack_elapsed: 34.913865ms, rtt: 33.661602ms } } pacer=Pacer { enabled: false, capacity: 13200, used: 0, rate: 625355, last_update: Instant { tv_sec: 972, tv_nsec: 460067548 }, next_time: Instant { tv_sec: 972, tv_nsec: 460067548 }, max_datagram_size: 1200, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(14) last_round_min_rtt=31.870936ms current_round_min_rtt=33.661602ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=2 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-13T10:48:31.236477105Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 written 1293 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:39895, at: Instant { tv_sec: 972, tv_nsec: 460067548 } }) [2025-12-13T10:48:31.236482425Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.236486302Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.236489358Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.236491963Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.238343553Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.238355085Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.238361166Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=6 [2025-12-13T10:48:31.238367067Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=12 blocks=[2..7] ecn_counts=None [2025-12-13T10:48:31.238371015Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 6 [2025-12-13T10:48:31.238373830Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 7 [2025-12-13T10:48:31.238384500Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.238389068Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.238392585Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.238395280Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.240362075Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.240374218Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.240379828Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=7 [2025-12-13T10:48:31.240390869Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=12 blocks=[2..9] ecn_counts=None [2025-12-13T10:48:31.240394866Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 8 [2025-12-13T10:48:31.240397692Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 9 [2025-12-13T10:48:31.240408572Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.240413171Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.240416687Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.240419452Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.241883518Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.241894448Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.241900209Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=8 [2025-12-13T10:48:31.241906050Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=18 blocks=[2..11] ecn_counts=None [2025-12-13T10:48:31.241909977Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 10 [2025-12-13T10:48:31.241912813Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 11 [2025-12-13T10:48:31.241924885Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.241929384Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.241932971Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.241935706Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.266201691Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.266222620Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.266233831Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=9 [2025-12-13T10:48:31.266245012Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=13 blocks=[2..14] ecn_counts=None [2025-12-13T10:48:31.266251614Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 12 [2025-12-13T10:48:31.266255501Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 13 [2025-12-13T10:48:31.266258868Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 14 [2025-12-13T10:48:31.266281219Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.266290036Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.266296057Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.266299994Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.267903661Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.267911125Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.267916455Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=10 [2025-12-13T10:48:31.267921835Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=13 blocks=[2..16] ecn_counts=None [2025-12-13T10:48:31.267925712Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 15 [2025-12-13T10:48:31.267928608Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 16 [2025-12-13T10:48:31.267960617Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.267965206Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.267968422Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.267971097Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.269041297Z TRACE quiche_server] got 46 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.269049242Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.269054522Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=25 pn=11 [2025-12-13T10:48:31.269060192Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm ACK delay=15 blocks=[2..18] ecn_counts=None [2025-12-13T10:48:31.269063859Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 17 [2025-12-13T10:48:31.269066714Z TRACE quiche::recovery::congestion::recovery] 073bed07892daf0354e38a0186b8a1c92d522d15 packet newly acked 18 [2025-12-13T10:48:31.269079308Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 46 bytes [2025-12-13T10:48:31.269083506Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.269086802Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.269089467Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.637570734Z TRACE quiche_server] got 45 bytes from [fd00:cafe:cafe::100]:39895 to [::]:443 [2025-12-13T10:48:31.637601261Z TRACE quiche_server] got packet Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false [2025-12-13T10:48:31.637616600Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx pkt Short dcid=073bed07892daf0354e38a0186b8a1c92d522d15 key_phase=false len=24 pn=12 [2025-12-13T10:48:31.637630927Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[] [2025-12-13T10:48:31.637650112Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 processed 45 bytes [2025-12-13T10:48:31.637658037Z TRACE quiche_server] recv() would block [2025-12-13T10:48:31.637662185Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.637666283Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.786877935Z TRACE quiche_server] timed out [2025-12-13T10:48:31.786910726Z TRACE quiche] 073bed07892daf0354e38a0186b8a1c92d522d15 draining timeout expired [2025-12-13T10:48:31.786958004Z TRACE quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 done writing [2025-12-13T10:48:31.786962663Z TRACE quiche_server] Collecting garbage [2025-12-13T10:48:31.786969806Z INFO quiche_server] 073bed07892daf0354e38a0186b8a1c92d522d15 connection collected recv=15 sent=19 lost=0 retrans=0 sent_bytes=17521 recv_bytes=1992 lost_bytes=0 [local_addr=[::]:443 peer_addr=[fd00:cafe:cafe::100]:39895 validation_state=Validated active=true recv=15 sent=19 lost=0 retrans=0 rtt=33.629369ms min_rtt=Some(31.629435ms) rttvar=3.988725ms cwnd=16050 sent_bytes=17521 recv_bytes=1992 lost_bytes=0 stream_retrans_bytes=0 pmtu=1200 delivery_rate=374580]