[2025-12-13T10:34:23.244424078Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-12-13T10:34:23.244730652Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:47886 with scid 2622ed82f99a3c5fd3e903b3b5a93d343947f965
[2025-12-13T10:34:23.244773061Z TRACE quiche::tls] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 write message lvl=Initial len=266
[2025-12-13T10:34:23.244792257Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Initial version=1 dcid=aded022317aa7c077b318b7eb942e84f scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=270 pn=0 
[2025-12-13T10:34:23.244796044Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm CRYPTO off=0 len=266
[2025-12-13T10:34:23.244811453Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=998.926603ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=333 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 489, tv_nsec: 603553208 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 603553208 }, 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: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 489, tv_nsec: 603553208 }, next_time: Instant { tv_sec: 489, tv_nsec: 603553208 }, max_datagram_size: 1350, 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:34:23.244869571Z TRACE quiche_apps::client] written 1200
[2025-12-13T10:34:23.283209474Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:23.283228220Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Initial version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa token= len=116 pn=0 
[2025-12-13T10:34:23.283240933Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm ACK delay=0 blocks=[0..0] ecn_counts=None
[2025-12-13T10:34:23.283247796Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 0
[2025-12-13T10:34:23.283253747Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=0 len=90
[2025-12-13T10:34:23.283356840Z TRACE quiche::tls] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 set write secret lvl=Handshake
[2025-12-13T10:34:23.283367430Z TRACE quiche::tls] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 set read secret lvl=Handshake
[2025-12-13T10:34:23.283396925Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=985 pn=0 
[2025-12-13T10:34:23.283404870Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=0 len=964
[2025-12-13T10:34:23.283423605Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:23.283429886Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:23.283433603Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:23.283450515Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Initial version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=1 
[2025-12-13T10:34:23.283455033Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=27 blocks=[0..0] ecn_counts=None
[2025-12-13T10:34:23.283464281Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=115.216489ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 642231975 }, next_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, max_datagram_size: 1350, last_packet_size: Some(0), 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:34:23.283497853Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=2 
[2025-12-13T10:34:23.283502282Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=12 blocks=[0..0] ecn_counts=None
[2025-12-13T10:34:23.283510347Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=115.170573ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 642231975 }, next_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, max_datagram_size: 1350, last_packet_size: Some(0), 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:34:23.283526727Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 dropped epoch 0 state
[2025-12-13T10:34:23.283564017Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:23.283577041Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:23.284181752Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:23.284211106Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=1 
[2025-12-13T10:34:23.284226375Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=964 len=1129
[2025-12-13T10:34:23.284242776Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:23.284248306Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:23.284251963Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:23.284263384Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=3 
[2025-12-13T10:34:23.284273884Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=6 blocks=[0..1] ecn_counts=None
[2025-12-13T10:34:23.284283131Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=114.614945ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, end_of_app_limited: 1, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 642231975 }, next_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, max_datagram_size: 1350, last_packet_size: Some(0), 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:34:23.284327544Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:23.284338725Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:23.285147817Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:23.285153418Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=2 
[2025-12-13T10:34:23.285160872Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=2093 len=1129
[2025-12-13T10:34:23.285172473Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:23.285176571Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:23.285179426Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:23.285208471Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=4 
[2025-12-13T10:34:23.285216836Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=6 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:23.285224491Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=113.673816ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, end_of_app_limited: 1, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 642231975 }, next_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, max_datagram_size: 1350, last_packet_size: Some(0), 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:34:23.285265537Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:23.285276017Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:23.399455133Z TRACE quiche_apps::client] timed out
[2025-12-13T10:34:23.399480730Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 loss detection timeout expired
[2025-12-13T10:34:23.399486471Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=230.905702ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, end_of_app_limited: 1, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 642231975 }, next_time: Instant { tv_sec: 489, tv_nsec: 642232005 }, max_datagram_size: 1350, last_packet_size: Some(0), 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:34:23.399513011Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:23.399543137Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=7 pn=5 
[2025-12-13T10:34:23.399548136Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=14298 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:23.399554338Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm PING mtu_probe=None
[2025-12-13T10:34:23.399572502Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=230.86238ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=73 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 73, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 758336128 }, next_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, max_datagram_size: 1350, last_packet_size: Some(73), 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:34:23.399650638Z TRACE quiche_apps::client] written 73 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:23.399662881Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:23.630951572Z TRACE quiche_apps::client] timed out
[2025-12-13T10:34:23.630975457Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 loss detection timeout expired
[2025-12-13T10:34:23.630982300Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=230.365056ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=73 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 73, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 758336128 }, next_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, max_datagram_size: 1350, last_packet_size: Some(73), 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:34:23.631020151Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:23.631055637Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=9 pn=6 
[2025-12-13T10:34:23.631060877Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=43237 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:23.631067559Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm PING mtu_probe=None
[2025-12-13T10:34:23.631089911Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=461.767221ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=148 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 75, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 989844942 }, next_time: Instant { tv_sec: 489, tv_nsec: 989844942 }, max_datagram_size: 1350, last_packet_size: Some(75), 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:34:23.631174018Z TRACE quiche_apps::client] written 75 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:23.631216117Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=9 pn=7 
[2025-12-13T10:34:23.631223792Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=43257 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:23.631231366Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm PING mtu_probe=None
[2025-12-13T10:34:23.631245001Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=461.764164ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=223 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 150, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 989844942 }, next_time: Instant { tv_sec: 489, tv_nsec: 989844942 }, max_datagram_size: 1350, last_packet_size: Some(75), 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:34:23.631299302Z TRACE quiche_apps::client] written 75 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:23.631312527Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.093834812Z TRACE quiche_apps::client] timed out
[2025-12-13T10:34:24.093857855Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 loss detection timeout expired
[2025-12-13T10:34:24.093864517Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=460.97134ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=223 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 150, rate: 438475, last_update: Instant { tv_sec: 489, tv_nsec: 989844942 }, next_time: Instant { tv_sec: 489, tv_nsec: 989844942 }, max_datagram_size: 1350, last_packet_size: Some(75), 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:34:24.093895085Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.093928808Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=9 pn=8 
[2025-12-13T10:34:24.093934268Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=101096 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:24.093940990Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm PING mtu_probe=None
[2025-12-13T10:34:24.093960006Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=923.597298ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=298 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 75, rate: 438475, last_update: Instant { tv_sec: 490, tv_nsec: 452718172 }, next_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, max_datagram_size: 1350, last_packet_size: Some(75), 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:34:24.094028945Z TRACE quiche_apps::client] written 75 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.094044373Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=9 pn=9 
[2025-12-13T10:34:24.094048852Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=101111 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:24.094053230Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm PING mtu_probe=None
[2025-12-13T10:34:24.094061085Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=923.627655ms latest_rtt=38.485576ms srtt=38.485576ms min_rtt=38.485576ms rttvar=19.242788ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=373 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, first_sent_time: Instant { tv_sec: 489, tv_nsec: 758336128 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 38.485576ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 603553208 }), send_elapsed: 0ns, ack_elapsed: 38.485576ms, rtt: 38.485576ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 150, rate: 438475, last_update: Instant { tv_sec: 490, tv_nsec: 452718172 }, next_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, max_datagram_size: 1350, last_packet_size: Some(75), 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:34:24.094096811Z TRACE quiche_apps::client] written 75 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.094103424Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.125458880Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.125477084Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=3 
[2025-12-13T10:34:24.125490369Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm ACK delay=0 blocks=[8..8] ecn_counts=None
[2025-12-13T10:34:24.125496841Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 8
[2025-12-13T10:34:24.125503353Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet 5 lost on epoch 1
[2025-12-13T10:34:24.125508022Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet 6 lost on epoch 1
[2025-12-13T10:34:24.125512421Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet 7 lost on epoch 1
[2025-12-13T10:34:24.125529152Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=3222 len=1124
[2025-12-13T10:34:24.125555571Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.125561693Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.125565409Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.125588042Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=10 
[2025-12-13T10:34:24.125592841Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=14 blocks=[3..3] ecn_counts=None
[2025-12-13T10:34:24.125629419Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=70.670744ms latest_rtt=31.569427ms srtt=37.621057ms min_rtt=31.569427ms rttvar=16.161128ms cwnd=9450 ssthresh=9450 bytes_in_flight=75 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 484287599 }) Rate { delivered: 408, delivered_time: Instant { tv_sec: 490, tv_nsec: 484287599 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 8, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 725.951471ms, delivered: 75, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 725.951471ms, rtt: 31.569427ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313986, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, max_datagram_size: 1350, last_packet_size: None, iv: 477.728µs, 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.125679623Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.125687408Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.126424235Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.126432420Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=4 
[2025-12-13T10:34:24.126440395Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=4346 len=1129
[2025-12-13T10:34:24.126451926Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.126456124Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.126459010Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.126467996Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=11 
[2025-12-13T10:34:24.126471463Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=4 blocks=[3..4] ecn_counts=None
[2025-12-13T10:34:24.126478837Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=69.821708ms latest_rtt=31.569427ms srtt=37.621057ms min_rtt=31.569427ms rttvar=16.161128ms cwnd=9450 ssthresh=9450 bytes_in_flight=75 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 484287599 }) Rate { delivered: 408, delivered_time: Instant { tv_sec: 490, tv_nsec: 484287599 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, end_of_app_limited: 9, last_sent_packet: 11, largest_acked: 8, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 725.951471ms, delivered: 75, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 725.951471ms, rtt: 31.569427ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313986, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.126517489Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.126523290Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.127405899Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.127413804Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=5 
[2025-12-13T10:34:24.127421549Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=5475 len=1129
[2025-12-13T10:34:24.127433571Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.127437579Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.127440514Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.127449150Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=12 
[2025-12-13T10:34:24.127452527Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=4 blocks=[3..5] ecn_counts=None
[2025-12-13T10:34:24.127459379Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=68.841275ms latest_rtt=31.569427ms srtt=37.621057ms min_rtt=31.569427ms rttvar=16.161128ms cwnd=9450 ssthresh=9450 bytes_in_flight=75 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 484287599 }) Rate { delivered: 408, delivered_time: Instant { tv_sec: 490, tv_nsec: 484287599 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, end_of_app_limited: 9, last_sent_packet: 12, largest_acked: 8, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 725.951471ms, delivered: 75, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 725.951471ms, rtt: 31.569427ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313986, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.127492211Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.127497500Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.128389077Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.128396741Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=6 
[2025-12-13T10:34:24.128404215Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=6604 len=1129
[2025-12-13T10:34:24.128414314Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.128418161Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.128421007Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.128429292Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=13 
[2025-12-13T10:34:24.128437688Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=4 blocks=[3..6] ecn_counts=None
[2025-12-13T10:34:24.128444561Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=67.856074ms latest_rtt=31.569427ms srtt=37.621057ms min_rtt=31.569427ms rttvar=16.161128ms cwnd=9450 ssthresh=9450 bytes_in_flight=75 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 484287599 }) Rate { delivered: 408, delivered_time: Instant { tv_sec: 490, tv_nsec: 484287599 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, end_of_app_limited: 9, last_sent_packet: 13, largest_acked: 8, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 725.951471ms, delivered: 75, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 725.951471ms, rtt: 31.569427ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313986, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.128476530Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.128481650Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.129372826Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.129380520Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1151 pn=7 
[2025-12-13T10:34:24.129387794Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=7733 len=1129
[2025-12-13T10:34:24.129398995Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.129403022Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.129405827Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.129414223Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=5 pn=14 
[2025-12-13T10:34:24.129417459Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=4 blocks=[3..7] ecn_counts=None
[2025-12-13T10:34:24.129424012Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=66.876663ms latest_rtt=31.569427ms srtt=37.621057ms min_rtt=31.569427ms rttvar=16.161128ms cwnd=9450 ssthresh=9450 bytes_in_flight=75 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 484287599 }) Rate { delivered: 408, delivered_time: Instant { tv_sec: 490, tv_nsec: 484287599 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 452718172 }, end_of_app_limited: 9, last_sent_packet: 14, largest_acked: 8, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 725.951471ms, delivered: 75, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 725.951471ms, rtt: 31.569427ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313986, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.129460059Z TRACE quiche_apps::client] written 71 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.129465569Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.130333481Z TRACE quiche_apps::client] got 1171 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.130341476Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=1122 pn=8 
[2025-12-13T10:34:24.130348900Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=8862 len=1100
[2025-12-13T10:34:24.130845709Z TRACE quiche::tls] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 write message lvl=Handshake len=36
[2025-12-13T10:34:24.130851480Z TRACE quiche::tls] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 set write secret lvl=OneRTT
[2025-12-13T10:34:24.130860937Z TRACE quiche::tls] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 set read secret lvl=OneRTT
[2025-12-13T10:34:24.130875244Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 connection established: proto=Ok("h3") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=false TransportParams { original_destination_connection_id: Some(aded022317aa7c077b318b7eb942e84f), max_idle_timeout: 75000, stateless_reset_token: Some(138930313429379524809530829386565340114), max_udp_payload_size: 65527, initial_max_data: 8585216, initial_max_stream_data_bidi_local: 65536, initial_max_stream_data_bidi_remote: 65536, initial_max_stream_data_uni: 65536, initial_max_streams_bidi: 128, initial_max_streams_uni: 3, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 2, initial_source_connection_id: Some(0000000000001004288370e542621b7be88b3faa), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-12-13T10:34:24.130900942Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1171 bytes
[2025-12-13T10:34:24.130906763Z TRACE quiche_apps::client] got 70 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.130911131Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Handshake version=1 dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 scid=0000000000001004288370e542621b7be88b3faa len=22 pn=9 
[2025-12-13T10:34:24.130917804Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm ACK delay=0 blocks=[8..9] ecn_counts=None
[2025-12-13T10:34:24.130921811Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 9
[2025-12-13T10:34:24.130931269Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 70 bytes
[2025-12-13T10:34:24.130935296Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.130938191Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.130954282Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm SETTINGS stream=2 len=18
[2025-12-13T10:34:24.130971223Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm GREASE stream=0 len=0
[2025-12-13T10:34:24.130977736Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm GREASE stream=0 len=18
[2025-12-13T10:34:24.130985941Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm HEADERS stream=0 len=34 fin=true
[2025-12-13T10:34:24.130992343Z DEBUG quiche_apps::common] Sent HTTP request [":method: GET", ":scheme: https", ":authority: server4", ":path: /icy-zesty-wizard", "user-agent: quiche"]
[2025-12-13T10:34:24.131051443Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Handshake version=1 dcid=0000000000001004288370e542621b7be88b3faa scid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 len=45 pn=15 
[2025-12-13T10:34:24.131056403Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=17 blocks=[3..9] ecn_counts=None
[2025-12-13T10:34:24.131065229Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm CRYPTO off=0 len=36
[2025-12-13T10:34:24.131074276Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=86.610986ms latest_rtt=37.005767ms srtt=37.544144ms min_rtt=31.569427ms rttvar=12.274668ms cwnd=9450 ssthresh=9450 bytes_in_flight=111 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 483, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 14, last_sent_packet: 15, largest_acked: 9, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 731.387811ms, delivered: 150, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 731.387811ms, rtt: 37.005767ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 314629, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.131097269Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=64 pn=16 
[2025-12-13T10:34:24.131100715Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[da, d5, 9f, 8d, 40, 3a, 3e, b5, 1f, 92, 73, 3d, a5, 55, 72, 66, d4, d4, 65, c9] reset_token=[91, 6f, e5, be, 88, 17, 6f, e0, 3a, ff, 54, f2, ba, 46, 3a, d6]
[2025-12-13T10:34:24.131107849Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm STREAM id=2 off=0 len=19 fin=false
[2025-12-13T10:34:24.131125351Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=86.559871ms latest_rtt=37.005767ms srtt=37.544144ms min_rtt=31.569427ms rttvar=12.274668ms cwnd=9450 ssthresh=9450 bytes_in_flight=213 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 483, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 15, last_sent_packet: 16, largest_acked: 9, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 731.387811ms, delivered: 150, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 731.387811ms, rtt: 37.005767ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 314629, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.131163152Z TRACE quiche_apps::client] written 213 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.131172019Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=6 pn=17 
[2025-12-13T10:34:24.131175355Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm STREAM id=6 off=0 len=1 fin=false
[2025-12-13T10:34:24.131181537Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=86.503866ms latest_rtt=37.005767ms srtt=37.544144ms min_rtt=31.569427ms rttvar=12.274668ms cwnd=9450 ssthresh=9450 bytes_in_flight=257 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 483, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 16, last_sent_packet: 17, largest_acked: 9, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 731.387811ms, delivered: 150, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 731.387811ms, rtt: 37.005767ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 314629, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.131247850Z TRACE quiche_apps::client] written 44 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.131257619Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=6 pn=18 
[2025-12-13T10:34:24.131260955Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm STREAM id=10 off=0 len=1 fin=false
[2025-12-13T10:34:24.131267587Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=86.417725ms latest_rtt=37.005767ms srtt=37.544144ms min_rtt=31.569427ms rttvar=12.274668ms cwnd=9450 ssthresh=9450 bytes_in_flight=301 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 483, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 17, last_sent_packet: 18, largest_acked: 9, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 731.387811ms, delivered: 150, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 731.387811ms, rtt: 37.005767ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 314629, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.131294287Z TRACE quiche_apps::client] written 44 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.131300719Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=77 pn=19 
[2025-12-13T10:34:24.131303865Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm STREAM id=0 off=0 len=72 fin=true
[2025-12-13T10:34:24.131309856Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=86.375546ms latest_rtt=37.005767ms srtt=37.544144ms min_rtt=31.569427ms rttvar=12.274668ms cwnd=9450 ssthresh=9450 bytes_in_flight=416 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 483, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 18, last_sent_packet: 19, largest_acked: 9, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 731.387811ms, delivered: 150, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 489, tv_nsec: 758336128 }), send_elapsed: 694.382044ms, ack_elapsed: 731.387811ms, rtt: 37.005767ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 314629, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.131340033Z TRACE quiche_apps::client] written 115 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.131344701Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.162619983Z TRACE quiche_apps::client] got 890 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.162636394Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=869 pn=0 
[2025-12-13T10:34:24.162650029Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm ACK delay=0 blocks=[16..16] ecn_counts=None
[2025-12-13T10:34:24.162655920Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 16
[2025-12-13T10:34:24.162661822Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm CRYPTO off=0 len=540
[2025-12-13T10:34:24.162693150Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm HANDSHAKE_DONE
[2025-12-13T10:34:24.162699502Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 dropped epoch 1 state
[2025-12-13T10:34:24.162706415Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, 18, 62, 19, a5, 34, 3b, 8d, 4f, ff, ac, f3, cf] reset_token=[7f, 31, 20, 2e, b5, eb, 81, 3f, 2f, 61, 9c, 8e, 48, 60, 7e, ae]
[2025-12-13T10:34:24.162716624Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, e0, 8b, 3f, e6, 1c, 29, 61, 10, 40, 50, fd, e1] reset_token=[cf, 4f, 06, 8a, fc, 99, a9, d1, d9, 0c, ad, 79, 72, ab, 1a, 40]
[2025-12-13T10:34:24.162725040Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, 53, 1a, bf, db, 6b, d2, 25, 2c, c7, fb, 41, 6e] reset_token=[aa, 0b, e9, 27, 64, 21, 42, 90, 8f, 64, 0a, 97, 93, 80, 7f, 95]
[2025-12-13T10:34:24.162732694Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, 4b, 66, 66, f8, 3c, 9d, 4d, 53, a7, 7b, ec, 71] reset_token=[94, ae, 55, 53, 8b, f0, 9b, 2d, 85, 53, c1, 68, b2, bc, 19, 88]
[2025-12-13T10:34:24.162740589Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, d0, a4, 29, 0b, 22, 8e, 63, b9, c3, 0b, 6e, 15] reset_token=[54, 77, de, 76, b1, f4, cc, e9, d8, 9e, b7, 29, 49, 8d, b2, 63]
[2025-12-13T10:34:24.162748413Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, 72, 26, 67, 9e, d2, 65, 92, a2, b7, 5e, c2, f3] reset_token=[f0, 18, 9a, 16, c1, 6b, 80, dd, d5, d4, 41, f2, a2, 85, 77, d3]
[2025-12-13T10:34:24.162756208Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 04, 3c, ae, 37, dc, 36, 20, 01, c3, 45, 7c, db, 6e] reset_token=[24, a3, 16, 38, ae, a7, fc, bf, 2f, fa, 2b, 2c, 8f, b5, ea, a1]
[2025-12-13T10:34:24.162770495Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=3 off=0 len=1 fin=false
[2025-12-13T10:34:24.162775474Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=3 off=1 len=8 fin=false
[2025-12-13T10:34:24.162779642Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=7 off=0 len=1 fin=false
[2025-12-13T10:34:24.162799419Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 890 bytes
[2025-12-13T10:34:24.162806212Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.162811211Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=22 pn=1 
[2025-12-13T10:34:24.162817513Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm ACK delay=0 blocks=[16..18] ecn_counts=None
[2025-12-13T10:34:24.162821981Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 17
[2025-12-13T10:34:24.162825488Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 18
[2025-12-13T10:34:24.162834775Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 43 bytes
[2025-12-13T10:34:24.162839584Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.162843060Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.162846787Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 3 is readable
[2025-12-13T10:34:24.162853329Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 3
[2025-12-13T10:34:24.162859301Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 open peer's control stream 3
[2025-12-13T10:34:24.162864080Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 3
[2025-12-13T10:34:24.162868608Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 3
[2025-12-13T10:34:24.162873367Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 6 bytes on stream 3
[2025-12-13T10:34:24.162877525Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm SETTINGS max_field_section=None, qpack_max_table=Some(4096), qpack_blocked=Some(128) raw=Some([(1, 4096), (7, 128)]), additional_settings=None stream=3 payload_len=6
[2025-12-13T10:34:24.162886542Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 7 is readable
[2025-12-13T10:34:24.162891371Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 7
[2025-12-13T10:34:24.162903594Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=5 pn=20 
[2025-12-13T10:34:24.162907911Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=11 blocks=[0..1] ecn_counts=None
[2025-12-13T10:34:24.162916107Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=60.961716ms latest_rtt=35.870145ms srtt=37.132569ms min_rtt=31.569427ms rttvar=7.612033ms cwnd=9450 ssthresh=9450 bytes_in_flight=115 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 673, delivered_time: Instant { tv_sec: 490, tv_nsec: 521624280 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 19, last_sent_packet: 20, largest_acked: 18, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 35.870145ms, delivered: 190, prior_delivered: 483, prior_time: Some(Instant { tv_sec: 490, tv_nsec: 485754135 }), send_elapsed: 0ns, ack_elapsed: 35.870145ms, rtt: 35.870145ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 318116, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.162970438Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.162977602Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.163652443Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.163665918Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=1179 pn=2 
[2025-12-13T10:34:24.163673372Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm ACK delay=0 blocks=[16..19] ecn_counts=None
[2025-12-13T10:34:24.163677460Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 packet newly acked 19
[2025-12-13T10:34:24.163682840Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=0 off=0 len=1152 fin=false
[2025-12-13T10:34:24.163693920Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.163698269Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.163701184Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.163704200Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 0 is readable
[2025-12-13T10:34:24.163708257Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 0
[2025-12-13T10:34:24.163712054Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 0
[2025-12-13T10:34:24.163715541Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 0
[2025-12-13T10:34:24.163719599Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 144 bytes on stream 0
[2025-12-13T10:34:24.163722785Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm HEADERS stream=0 payload_len=144
[2025-12-13T10:34:24.163726421Z TRACE quiche::h3::qpack::decoder] Header count=0 base=0
[2025-12-13T10:34:24.163729437Z TRACE quiche::h3::qpack::decoder] Indexed index=25 static=true
[2025-12-13T10:34:24.163734496Z TRACE quiche::h3::qpack::decoder] Literal name_idx=92 static=true value=[110, 103, 105, 110, 120, 47, 49, 46, 50, 57, 46, 52]
[2025-12-13T10:34:24.163741199Z TRACE quiche::h3::qpack::decoder] Literal name_idx=6 static=true value=[83, 97, 116, 44, 32, 49, 51, 32, 68, 101, 99, 32, 50, 48, 50, 53, 32, 49, 48, 58, 51, 52, 58, 50, 52, 32, 71, 77, 84]
[2025-12-13T10:34:24.163746148Z TRACE quiche::h3::qpack::decoder] Literal name_idx=53 static=true value=[97, 112, 112, 108, 105, 99, 97, 116, 105, 111, 110, 47, 111, 99, 116, 101, 116, 45, 115, 116, 114, 101, 97, 109]
[2025-12-13T10:34:24.163750426Z TRACE quiche::h3::qpack::decoder] Literal name_idx=4 static=true value=[53, 49, 50, 48]
[2025-12-13T10:34:24.163753953Z TRACE quiche::h3::qpack::decoder] Literal name_idx=10 static=true value=[83, 97, 116, 44, 32, 49, 51, 32, 68, 101, 99, 32, 50, 48, 50, 53, 32, 49, 48, 58, 51, 52, 58, 50, 49, 32, 71, 77, 84]
[2025-12-13T10:34:24.163759613Z TRACE quiche::h3::qpack::decoder] Literal Without Name Reference name=[101, 116, 97, 103] value=[34, 54, 57, 51, 100, 52, 49, 50, 100, 45, 49, 52, 48, 48, 34]
[2025-12-13T10:34:24.163764543Z TRACE quiche::h3::qpack::decoder] Literal Without Name Reference name=[97, 108, 116, 45, 115, 118, 99] value=[104, 51, 61, 34, 58, 52, 52, 51, 34, 59, 32, 109, 97, 61, 56, 54, 52, 48, 48]
[2025-12-13T10:34:24.163769071Z TRACE quiche::h3::qpack::decoder] Literal Without Name Reference name=[97, 99, 99, 101, 112, 116, 45, 114, 97, 110, 103, 101, 115] value=[98, 121, 116, 101, 115]
[2025-12-13T10:34:24.163779561Z DEBUG quiche_apps::common] got response headers [(":status", "200"), ("server", "nginx/1.29.4"), ("date", "Sat, 13 Dec 2025 10:34:24 GMT"), ("content-type", "application/octet-stream"), ("content-length", "5120"), ("last-modified", "Sat, 13 Dec 2025 10:34:21 GMT"), ("etag", "\"693d412d-1400\""), ("alt-svc", "h3=\":443\"; ma=86400"), ("accept-ranges", "bytes")] on stream id 0
[2025-12-13T10:34:24.163792094Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 0 is readable
[2025-12-13T10:34:24.163795911Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 0
[2025-12-13T10:34:24.163799558Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 0
[2025-12-13T10:34:24.163803075Z TRACE quiche::h3::stream] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 read 1 bytes on stream 0
[2025-12-13T10:34:24.163806000Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm DATA stream=0 wire_payload_len=5120
[2025-12-13T10:34:24.163820768Z DEBUG quiche_apps::common] got 1002 bytes of response data on stream 0
[2025-12-13T10:34:24.163830155Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=5 pn=21 
[2025-12-13T10:34:24.163833561Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=20 blocks=[0..2] ecn_counts=None
[2025-12-13T10:34:24.163840675Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=none latest_rtt=36.724311ms srtt=37.081535ms min_rtt=31.569427ms rttvar=5.811088ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 788, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 20, last_sent_packet: 21, largest_acked: 19, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 36.724311ms, delivered: 305, prior_delivered: 483, prior_time: Some(Instant { tv_sec: 490, tv_nsec: 485754135 }), send_elapsed: 0ns, ack_elapsed: 36.724311ms, rtt: 36.724311ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 318554, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.163877253Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.163882493Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.164648364Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.164662611Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=1179 pn=3 
[2025-12-13T10:34:24.164670656Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=0 off=1152 len=1156 fin=false
[2025-12-13T10:34:24.164678872Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.164682939Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.164685774Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.164688850Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 0 is readable
[2025-12-13T10:34:24.164694060Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-12-13T10:34:24.164702986Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=5 pn=22 
[2025-12-13T10:34:24.164706343Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=5 blocks=[0..3] ecn_counts=None
[2025-12-13T10:34:24.164718796Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=none latest_rtt=36.724311ms srtt=37.081535ms min_rtt=31.569427ms rttvar=5.811088ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 788, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 20, last_sent_packet: 22, largest_acked: 19, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 36.724311ms, delivered: 305, prior_delivered: 483, prior_time: Some(Instant { tv_sec: 490, tv_nsec: 485754135 }), send_elapsed: 0ns, ack_elapsed: 36.724311ms, rtt: 36.724311ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 318554, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.164753471Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.164758921Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.165616073Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.165627214Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=1179 pn=4 
[2025-12-13T10:34:24.165634357Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=0 off=2308 len=1156 fin=false
[2025-12-13T10:34:24.165642442Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.165646460Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.165649295Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.165652271Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 0 is readable
[2025-12-13T10:34:24.165657330Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-12-13T10:34:24.165666046Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=5 pn=23 
[2025-12-13T10:34:24.165669283Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=4 blocks=[0..4] ecn_counts=None
[2025-12-13T10:34:24.165676025Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=none latest_rtt=36.724311ms srtt=37.081535ms min_rtt=31.569427ms rttvar=5.811088ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 788, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 20, last_sent_packet: 23, largest_acked: 19, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 36.724311ms, delivered: 305, prior_delivered: 483, prior_time: Some(Instant { tv_sec: 490, tv_nsec: 485754135 }), send_elapsed: 0ns, ack_elapsed: 36.724311ms, rtt: 36.724311ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 318554, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.165714116Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.165719777Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.166602837Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.166614259Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=1179 pn=5 
[2025-12-13T10:34:24.166621332Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=0 off=3464 len=1156 fin=false
[2025-12-13T10:34:24.166629247Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 1200 bytes
[2025-12-13T10:34:24.166633294Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.166636110Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.166639105Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 0 is readable
[2025-12-13T10:34:24.166644075Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-12-13T10:34:24.166652510Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=5 pn=24 
[2025-12-13T10:34:24.166655736Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm ACK delay=4 blocks=[0..5] ecn_counts=None
[2025-12-13T10:34:24.166662900Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=none latest_rtt=36.724311ms srtt=37.081535ms min_rtt=31.569427ms rttvar=5.811088ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 521295050 }) Rate { delivered: 788, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 20, last_sent_packet: 24, largest_acked: 19, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 36.724311ms, delivered: 305, prior_delivered: 483, prior_time: Some(Instant { tv_sec: 490, tv_nsec: 485754135 }), send_elapsed: 0ns, ack_elapsed: 36.724311ms, rtt: 36.724311ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 318554, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.166695871Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.166700550Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.167181439Z TRACE quiche_apps::client] got 699 bytes from 193.167.100.100:443 to 0.0.0.0:47886
[2025-12-13T10:34:24.167205464Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx pkt Short dcid=2622ed82f99a3c5fd3e903b3b5a93d343947f965 key_phase=false len=678 pn=6 
[2025-12-13T10:34:24.167215393Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=0 off=4620 len=650 fin=false
[2025-12-13T10:34:24.167219490Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 rx frm STREAM id=0 off=5270 len=0 fin=true
[2025-12-13T10:34:24.167227144Z TRACE quiche_apps::client] 0.0.0.0:47886: processed 699 bytes
[2025-12-13T10:34:24.167231332Z TRACE quiche_apps::client] 0.0.0.0:47886: recv() would block
[2025-12-13T10:34:24.167234188Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.167237143Z TRACE quiche::h3] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 stream id 0 is readable
[2025-12-13T10:34:24.167248655Z DEBUG quiche_apps::common] got 650 bytes of response data on stream 0
[2025-12-13T10:34:24.167251971Z DEBUG quiche_apps::common] 1/1 responses received
[2025-12-13T10:34:24.167254856Z INFO  quiche_apps::common] 1/1 response(s) received in 922.378332ms, closing...
[2025-12-13T10:34:24.167263612Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx pkt Short dcid=0000000000001004288370e542621b7be88b3faa key_phase=false len=11 pn=25 
[2025-12-13T10:34:24.167266959Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 tx frm APPLICATION_CLOSE err=100 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-12-13T10:34:24.167274653Z TRACE quiche::recovery::congestion::recovery] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 timer=85.310228ms latest_rtt=36.724311ms srtt=37.081535ms min_rtt=31.569427ms rttvar=5.811088ms cwnd=9450 ssthresh=9450 bytes_in_flight=49 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 490, tv_nsec: 557256822 }) Rate { delivered: 788, delivered_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, first_sent_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, end_of_app_limited: 24, last_sent_packet: 25, largest_acked: 19, rate_sample: RateSample { bandwidth: 69.22 Kbps, is_app_limited: true, interval: 36.724311ms, delivered: 305, prior_delivered: 483, prior_time: Some(Instant { tv_sec: 490, tv_nsec: 485754135 }), send_elapsed: 0ns, ack_elapsed: 36.724311ms, rtt: 36.724311ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 318554, last_update: Instant { tv_sec: 490, tv_nsec: 484392304 }, next_time: Instant { tv_sec: 490, tv_nsec: 485754135 }, max_datagram_size: 1350, last_packet_size: Some(0), 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=1.9574338205844317 w_max=13500 } 
[2025-12-13T10:34:24.167314338Z TRACE quiche_apps::client] written 49 bytes from 0.0.0.0:47886 to 193.167.100.100:443
[2025-12-13T10:34:24.167322242Z TRACE quiche_apps::client] 0.0.0.0:47886 -> 193.167.100.100:443: done writing
[2025-12-13T10:34:24.348545616Z TRACE quiche_apps::client] timed out
[2025-12-13T10:34:24.348560123Z TRACE quiche] 2622ed82f99a3c5fd3e903b3b5a93d343947f965 draining timeout expired
[2025-12-13T10:34:24.348587224Z TRACE quiche_apps::client] done reading
[2025-12-13T10:34:24.348591823Z INFO  quiche_apps::client] connection closed, recv=18 sent=26 lost=6 retrans=0 sent_bytes=2026 recv_bytes=17273 lost_bytes=223 [local_addr=0.0.0.0:47886 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=18 sent=26 lost=6 retrans=0 rtt=37.081535ms min_rtt=Some(31.569427ms) rttvar=5.811088ms cwnd=9450 sent_bytes=2026 recv_bytes=17273 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=8652]