[2025-09-12T10:03:01.219179382Z INFO  quiche_server] listening on [::]:443
[2025-09-12T10:03:01.219200401Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-09-12T10:03:01.219206343Z TRACE quiche_server] GSO detected: false
[2025-09-12T10:03:01.561343336Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:33015 to [::]:443
[2025-09-12T10:03:01.561378682Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-09-12T10:03:01.561385455Z WARN  quiche_server] Doing version negotiation
[2025-09-12T10:03:01.561448883Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:02.260353338Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:02.260376821Z TRACE quiche_server] got packet Initial version=1 dcid=871826ebe0c78635 scid= token=
[2025-09-12T10:03:02.260392220Z DEBUG quiche_server] New connection: dcid=871826ebe0c78635 scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf
[2025-09-12T10:03:02.260582955Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Initial version=1 dcid=871826ebe0c78635 scid= token= len=1234 pn=26 
[2025-09-12T10:03:02.260597572Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm CRYPTO off=0 len=1213
[2025-09-12T10:03:02.260631496Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 1252 bytes
[2025-09-12T10:03:02.260641915Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:02.260655310Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Initial version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=5 pn=0 
[2025-09-12T10:03:02.260659408Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm ACK delay=11 blocks=[26..26] ecn_counts=None
[2025-09-12T10:03:02.260672342Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=none latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=false congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 362, tv_nsec: 821706296 }, first_sent_time: Instant { tv_sec: 362, tv_nsec: 821706296 }, end_of_app_limited: 0, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 362, tv_nsec: 821706296 }, next_time: Instant { tv_sec: 362, tv_nsec: 821706296 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=None 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-09-12T10:03:02.260732153Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 362, tv_nsec: 821706296 } })
[2025-09-12T10:03:02.260743915Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:02.260751770Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:02.260760496Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:02.260765155Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.510736631Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.510764233Z TRACE quiche_server] got packet Initial version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= token=
[2025-09-12T10:03:09.510779892Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Initial version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= token= len=349 pn=33 
[2025-09-12T10:03:09.510794509Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm CRYPTO off=1213 len=327
[2025-09-12T10:03:09.510842468Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-09-12T10:03:09.510847398Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-09-12T10:03:09.510991837Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf write message lvl=Initial len=90
[2025-09-12T10:03:09.511028545Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf set write secret lvl=Handshake
[2025-09-12T10:03:09.511137077Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf write message lvl=Handshake len=9945
[2025-09-12T10:03:09.511142437Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf set write secret lvl=OneRTT
[2025-09-12T10:03:09.511150963Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf set read secret lvl=Handshake
[2025-09-12T10:03:09.511180037Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf dropped invalid packet
[2025-09-12T10:03:09.511183644Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 1252 bytes
[2025-09-12T10:03:09.511203090Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511217858Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Initial version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=101 pn=1 
[2025-09-12T10:03:09.511221755Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm ACK delay=54 blocks=[26..26, 33..33] ecn_counts=None
[2025-09-12T10:03:09.511227375Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=0 len=90
[2025-09-12T10:03:09.511238727Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.967189ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=148 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72267151 }, next_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511264104Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1006 pn=2 
[2025-09-12T10:03:09.511267530Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=0 len=1002
[2025-09-12T10:03:09.511274543Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.931633ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1200 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72267151 }, next_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511329726Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72267151 } })
[2025-09-12T10:03:09.511341247Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511348862Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511363489Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=3 
[2025-09-12T10:03:09.511369300Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=1002 len=1149
[2025-09-12T10:03:09.511380601Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.825565ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, end_of_app_limited: 2, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72413744 }, next_time: Instant { tv_sec: 370, tv_nsec: 72413744 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511419944Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72413744 } })
[2025-09-12T10:03:09.511429041Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511436074Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511450140Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=4 
[2025-09-12T10:03:09.511455681Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=2151 len=1149
[2025-09-12T10:03:09.511465489Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.740677ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3600 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, end_of_app_limited: 3, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72501037 }, next_time: Instant { tv_sec: 370, tv_nsec: 72501037 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511502458Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72501037 } })
[2025-09-12T10:03:09.511518869Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511525902Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511539777Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=5 
[2025-09-12T10:03:09.511544025Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=3300 len=1149
[2025-09-12T10:03:09.511552561Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.653655ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, end_of_app_limited: 4, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72590473 }, next_time: Instant { tv_sec: 370, tv_nsec: 72590473 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511588558Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72590473 } })
[2025-09-12T10:03:09.511597926Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511604257Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511616190Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=6 
[2025-09-12T10:03:09.511620528Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=4449 len=1149
[2025-09-12T10:03:09.511629114Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.577182ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6000 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, end_of_app_limited: 5, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72668849 }, next_time: Instant { tv_sec: 370, tv_nsec: 72668849 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511658869Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72668849 } })
[2025-09-12T10:03:09.511665963Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511671473Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511688825Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=7 
[2025-09-12T10:03:09.511692482Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=5598 len=1149
[2025-09-12T10:03:09.511700487Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.505799ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7200 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, end_of_app_limited: 6, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72741014 }, next_time: Instant { tv_sec: 370, tv_nsec: 72741014 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511731034Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72741014 } })
[2025-09-12T10:03:09.511738337Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511743687Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511754798Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=214 pn=8 
[2025-09-12T10:03:09.511759517Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=6747 len=209
[2025-09-12T10:03:09.511767021Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=998.439305ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7460 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72267151 }, end_of_app_limited: 7, 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: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 370, tv_nsec: 72807678 }, next_time: Instant { tv_sec: 370, tv_nsec: 72807678 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.511796315Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 260 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 72807678 } })
[2025-09-12T10:03:09.511803098Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.511808468Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.511813678Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.511817174Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.543743110Z TRACE quiche_server] got 105 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.543764540Z TRACE quiche_server] got packet Initial version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= token=
[2025-09-12T10:03:09.543773116Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Initial version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= token= len=23 pn=34 
[2025-09-12T10:03:09.543779288Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=99 blocks=[0..1] ecn_counts=None
[2025-09-12T10:03:09.543783716Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 0
[2025-09-12T10:03:09.543786311Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 1
[2025-09-12T10:03:09.543800136Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=23 pn=0 
[2025-09-12T10:03:09.543804334Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=99 blocks=[2..2] ecn_counts=None
[2025-09-12T10:03:09.543807040Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 2
[2025-09-12T10:03:09.543815696Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf dropped epoch 0 state
[2025-09-12T10:03:09.543818471Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 105 bytes
[2025-09-12T10:03:09.543823430Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.543826596Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.543830583Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=1 
[2025-09-12T10:03:09.543834350Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=5 blocks=[2..3] ecn_counts=None
[2025-09-12T10:03:09.543837035Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 3
[2025-09-12T10:03:09.543843357Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.543846723Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.543855630Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=9 
[2025-09-12T10:03:09.543858605Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=6956 len=1149
[2025-09-12T10:03:09.543865118Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=69.288608ms latest_rtt=32.476983ms srtt=32.557018ms min_rtt=32.476983ms rttvar=9.187005ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6260 app_limited=true congestion_recovery_start_time=None Rate { delivered: 2400, delivered_time: Instant { tv_sec: 370, tv_nsec: 104890727 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72413744 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 3, rate_sample: RateSample { bandwidth: 588.53 Kbps, is_app_limited: true, interval: 32.623576ms, delivered: 2400, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 72267151 }), send_elapsed: 146.593µs, ack_elapsed: 32.623576ms, rtt: 32.476983ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 518321, last_update: Instant { tv_sec: 370, tv_nsec: 104909562 }, next_time: Instant { tv_sec: 370, tv_nsec: 104909562 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.543905593Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 104909562 } })
[2025-09-12T10:03:09.543919839Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.543926602Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.543938424Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=1154 pn=10 
[2025-09-12T10:03:09.543975734Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=8105 len=1149
[2025-09-12T10:03:09.543985652Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=69.248783ms latest_rtt=32.476983ms srtt=32.557018ms min_rtt=32.476983ms rttvar=9.187005ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7460 app_limited=true congestion_recovery_start_time=None Rate { delivered: 2400, delivered_time: Instant { tv_sec: 370, tv_nsec: 104890727 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72413744 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 3, rate_sample: RateSample { bandwidth: 588.53 Kbps, is_app_limited: true, interval: 32.623576ms, delivered: 2400, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 72267151 }), send_elapsed: 146.593µs, ack_elapsed: 32.623576ms, rtt: 32.476983ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 518321, last_update: Instant { tv_sec: 370, tv_nsec: 104909562 }, next_time: Instant { tv_sec: 370, tv_nsec: 104909562 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.544019365Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 104909562 } })
[2025-09-12T10:03:09.544026729Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.544032479Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.544044762Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Handshake version=1 dcid= scid=11ea6f2c536309f3650906f28ad9ffae6fa648cf len=696 pn=11 
[2025-09-12T10:03:09.544048419Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=9254 len=691
[2025-09-12T10:03:09.544073005Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=69.267598ms latest_rtt=32.476983ms srtt=32.557018ms min_rtt=32.476983ms rttvar=9.187005ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8202 app_limited=true congestion_recovery_start_time=None Rate { delivered: 2400, delivered_time: Instant { tv_sec: 370, tv_nsec: 104890727 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 72413744 }, end_of_app_limited: 10, last_sent_packet: 11, largest_acked: 3, rate_sample: RateSample { bandwidth: 588.53 Kbps, is_app_limited: true, interval: 32.623576ms, delivered: 2400, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 72267151 }), send_elapsed: 146.593µs, ack_elapsed: 32.623576ms, rtt: 32.476983ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 518321, last_update: Instant { tv_sec: 370, tv_nsec: 104909562 }, next_time: Instant { tv_sec: 370, tv_nsec: 104909562 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.544106898Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 742 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 104909562 } })
[2025-09-12T10:03:09.544120153Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.544125843Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.544131905Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.544135100Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.544688021Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.544692349Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.544698149Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=2 
[2025-09-12T10:03:09.544703570Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=3 blocks=[2..4] ecn_counts=None
[2025-09-12T10:03:09.544707106Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 4
[2025-09-12T10:03:09.544718317Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.544722054Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.544725491Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.544727805Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.545630566Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.545636738Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.545641106Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=3 
[2025-09-12T10:03:09.545645434Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=3 blocks=[2..5] ecn_counts=None
[2025-09-12T10:03:09.545648270Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 5
[2025-09-12T10:03:09.545656525Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.545659901Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.545663177Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.545665491Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.546595163Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.546600634Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.546604912Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=4 
[2025-09-12T10:03:09.546609160Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=6 blocks=[2..6] ecn_counts=None
[2025-09-12T10:03:09.546611925Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 6
[2025-09-12T10:03:09.546619619Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.546622995Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.546626321Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.546628536Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.547613621Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.547618921Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.547623038Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=5 
[2025-09-12T10:03:09.547627336Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=4 blocks=[2..7] ecn_counts=None
[2025-09-12T10:03:09.547634530Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 7
[2025-09-12T10:03:09.547642474Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.547645951Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.547649387Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.547651631Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.547818883Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.547822440Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.547826557Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=6 
[2025-09-12T10:03:09.547830795Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=5 blocks=[2..8] ecn_counts=None
[2025-09-12T10:03:09.547833601Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 8
[2025-09-12T10:03:09.547841135Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.547844421Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.547847576Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.547849811Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.575349108Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.575362372Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.575368955Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=7 
[2025-09-12T10:03:09.575374665Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=5 blocks=[2..9] ecn_counts=None
[2025-09-12T10:03:09.575378402Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 9
[2025-09-12T10:03:09.575390655Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.575394783Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.575399592Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.575402106Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.576271336Z TRACE quiche_server] got 51 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.576282567Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.576289430Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=22 pn=8 
[2025-09-12T10:03:09.576295922Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=4 blocks=[2..10] ecn_counts=None
[2025-09-12T10:03:09.576299238Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 10
[2025-09-12T10:03:09.576309817Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 51 bytes
[2025-09-12T10:03:09.576313544Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.576317822Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.576320177Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.577787871Z TRACE quiche_server] got 52 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.577799262Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.577805394Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=23 pn=9 
[2025-09-12T10:03:09.577818638Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=114 blocks=[2..11] ecn_counts=None
[2025-09-12T10:03:09.577822886Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 11
[2025-09-12T10:03:09.577835590Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 52 bytes
[2025-09-12T10:03:09.577840178Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.577845548Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.577848604Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.578366950Z TRACE quiche_server] got 143 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.578377770Z TRACE quiche_server] got packet Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid=
[2025-09-12T10:03:09.578384222Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Handshake version=1 dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf scid= len=56 pn=10 
[2025-09-12T10:03:09.578390594Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm CRYPTO off=0 len=36
[2025-09-12T10:03:09.578401965Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf set read secret lvl=OneRTT
[2025-09-12T10:03:09.578435528Z TRACE quiche::tls] 11ea6f2c536309f3650906f28ad9ffae6fa648cf write message lvl=OneRTT len=396
[2025-09-12T10:03:09.578442821Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf dropped epoch 1 state
[2025-09-12T10:03:09.578446788Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 4611686018427387903, initial_max_stream_data_bidi_local: 1048576, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 1048576, initial_max_streams_bidi: 16, initial_max_streams_uni: 16, ack_delay_exponent: 3, max_ack_delay: 20, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(), retry_source_connection_id: None, max_datagram_frame_size: Some(1200), unknown_params: None }
[2025-09-12T10:03:09.578466916Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false len=37 pn=0 
[2025-09-12T10:03:09.578472646Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm STREAM id=0 off=0 len=17 fin=true
[2025-09-12T10:03:09.578480321Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 143 bytes
[2025-09-12T10:03:09.578484419Z DEBUG quiche_apps::common] 11ea6f2c536309f3650906f28ad9ffae6fa648cf response stream 0 is writable with capacity Ok(13500)
[2025-09-12T10:03:09.578491231Z TRACE quiche_apps::common] 11ea6f2c536309f3650906f28ad9ffae6fa648cf received 17 bytes
[2025-09-12T10:03:09.578494227Z TRACE quiche_apps::common] 11ea6f2c536309f3650906f28ad9ffae6fa648cf stream 0 has 17 bytes (fin? true)
[2025-09-12T10:03:09.578499336Z INFO  quiche_apps::common] 11ea6f2c536309f3650906f28ad9ffae6fa648cf got GET request for "/www/qgjfniarxb" on stream 0
[2025-09-12T10:03:09.578524423Z INFO  quiche_apps::common] 11ea6f2c536309f3650906f28ad9ffae6fa648cf sending response of size 5120 on stream 0
[2025-09-12T10:03:09.578533330Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.578546083Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Short dcid= key_phase=false len=1332 pn=12 
[2025-09-12T10:03:09.578550051Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm ACK delay=9 blocks=[0..0] ecn_counts=None
[2025-09-12T10:03:09.578553978Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[0d, df, 69, 60, ab, 79, 81, 83, 65, 5a, b9, e7, ae, 3b, 20, d6, 04, 30, 63, 92] reset_token=[b1, 6d, cc, 58, e5, cf, 4f, bc, 29, 8f, a4, f7, e6, 23, 35, a8]
[2025-09-12T10:03:09.578567894Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[85, ce, b9, 88, 39, 37, 26, d3, 3d, a0, 42, c1, 3d, bc, 46, 32, 9b, 75, 18, 9c] reset_token=[65, 51, 0d, b5, 0e, 61, c9, 87, c9, fd, fd, 63, e4, dc, c2, 40]
[2025-09-12T10:03:09.578574446Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c3, 91, 23, 1d, 42, 5d, f7, 35, 14, 50, ae, 66, 22, 37, cc, 08, 42, 33, 67, 5f] reset_token=[26, a2, 66, 9e, 0f, 4c, 3c, 41, 65, 78, 9e, 64, 48, 99, a1, 64]
[2025-09-12T10:03:09.578580708Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[bb, 4d, 2c, e2, 2d, 05, 82, ae, 4e, ea, b0, 1a, ef, 45, 29, 6a, b1, 36, ca, 20] reset_token=[7d, 38, e2, 7b, 84, 0a, 6b, 1c, a3, 80, f2, b6, 52, 45, ec, df]
[2025-09-12T10:03:09.578586759Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[a3, b0, 65, 38, a8, 53, 23, 7f, b5, b4, fa, 5a, 73, c7, c2, 91, 93, 62, e1, 5b] reset_token=[3b, 69, 38, 43, e2, ad, 4f, b1, 55, 43, 6e, 66, 84, cf, 10, e5]
[2025-09-12T10:03:09.578592610Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[1a, f5, 6b, 44, 39, c0, 9e, 1f, 90, 9f, 80, d1, 49, 96, e4, f8, 46, 0b, 2d, c6] reset_token=[f5, 44, 97, 9a, 2a, 44, 2f, 46, 9e, 5c, aa, 53, 67, a9, 0c, 31]
[2025-09-12T10:03:09.578598551Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[da, bc, 1a, 8d, 54, ee, fe, 06, 59, d7, 30, 6c, 38, 84, 27, a0, 6b, 2c, c1, 0a] reset_token=[a5, 66, ae, cc, dd, 4e, 8d, 0f, 86, d7, d1, 8a, 89, f7, d7, a1]
[2025-09-12T10:03:09.578604743Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm HANDSHAKE_DONE
[2025-09-12T10:03:09.578607498Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm CRYPTO off=0 len=396
[2025-09-12T10:03:09.578610463Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm STREAM id=0 off=0 len=641 fin=false
[2025-09-12T10:03:09.578625451Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=62.120185ms latest_rtt=33.955364ms srtt=33.311596ms min_rtt=31.518735ms rttvar=2.224544ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10602, delivered_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, end_of_app_limited: 11, last_sent_packet: 12, largest_acked: 11, rate_sample: RateSample { bandwidth: 1.93 Mbps, is_app_limited: true, interval: 33.974199ms, delivered: 8202, prior_delivered: 2400, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 104890727 }), send_elapsed: 32.495818ms, ack_elapsed: 33.974199ms, rtt: 33.955364ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506580, last_update: Instant { tv_sec: 370, tv_nsec: 139596910 }, next_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.578644907Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Short dcid= key_phase=false len=1332 pn=13 
[2025-09-12T10:03:09.578648334Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm STREAM id=0 off=641 len=1326 fin=false
[2025-09-12T10:03:09.578654345Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=62.197138ms latest_rtt=33.955364ms srtt=33.311596ms min_rtt=31.518735ms rttvar=2.224544ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10602, delivered_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, end_of_app_limited: 12, last_sent_packet: 13, largest_acked: 11, rate_sample: RateSample { bandwidth: 1.93 Mbps, is_app_limited: true, interval: 33.974199ms, delivered: 8202, prior_delivered: 2400, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 104890727 }), send_elapsed: 32.495818ms, ack_elapsed: 33.974199ms, rtt: 33.955364ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506580, last_update: Instant { tv_sec: 370, tv_nsec: 139596910 }, next_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.578672008Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Short dcid= key_phase=false len=1332 pn=14 
[2025-09-12T10:03:09.578675194Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm STREAM id=0 off=1967 len=1326 fin=false
[2025-09-12T10:03:09.578680554Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=62.199012ms latest_rtt=33.955364ms srtt=33.311596ms min_rtt=31.518735ms rttvar=2.224544ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10602, delivered_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, end_of_app_limited: 13, last_sent_packet: 14, largest_acked: 11, rate_sample: RateSample { bandwidth: 1.93 Mbps, is_app_limited: true, interval: 33.974199ms, delivered: 8202, prior_delivered: 2400, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 104890727 }), send_elapsed: 32.495818ms, ack_elapsed: 33.974199ms, rtt: 33.955364ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506580, last_update: Instant { tv_sec: 370, tv_nsec: 139596910 }, next_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.578692667Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Short dcid= key_phase=false len=1332 pn=15 
[2025-09-12T10:03:09.578695702Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm STREAM id=0 off=3293 len=1326 fin=false
[2025-09-12T10:03:09.578714116Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=62.186509ms latest_rtt=33.955364ms srtt=33.311596ms min_rtt=31.518735ms rttvar=2.224544ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10602, delivered_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, end_of_app_limited: 14, last_sent_packet: 15, largest_acked: 11, rate_sample: RateSample { bandwidth: 1.93 Mbps, is_app_limited: true, interval: 33.974199ms, delivered: 8202, prior_delivered: 2400, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 104890727 }), send_elapsed: 32.495818ms, ack_elapsed: 33.974199ms, rtt: 33.955364ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506580, last_update: Instant { tv_sec: 370, tv_nsec: 139596910 }, next_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.578731399Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Short dcid= key_phase=false len=507 pn=16 
[2025-09-12T10:03:09.578734625Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm STREAM id=0 off=4619 len=501 fin=true
[2025-09-12T10:03:09.578741908Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=62.197048ms latest_rtt=33.955364ms srtt=33.311596ms min_rtt=31.518735ms rttvar=2.224544ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5925 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10602, delivered_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, end_of_app_limited: 15, last_sent_packet: 16, largest_acked: 11, rate_sample: RateSample { bandwidth: 1.93 Mbps, is_app_limited: true, interval: 33.974199ms, delivered: 8202, prior_delivered: 2400, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 104890727 }), send_elapsed: 32.495818ms, ack_elapsed: 33.974199ms, rtt: 33.955364ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506580, last_update: Instant { tv_sec: 370, tv_nsec: 139596910 }, next_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.578831966Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 5925 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 139596910 } })
[2025-09-12T10:03:09.578840672Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.578846803Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.578851392Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.578854207Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.611864358Z TRACE quiche_server] got 1352 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.611877832Z TRACE quiche_server] got packet Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false
[2025-09-12T10:03:09.611885928Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false len=1331 pn=1 
[2025-09-12T10:03:09.611892500Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=40 blocks=[12..12] ecn_counts=None
[2025-09-12T10:03:09.611896337Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 12
[2025-09-12T10:03:09.611900685Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm PING mtu_probe=None
[2025-09-12T10:03:09.611907047Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm PADDING len=1308
[2025-09-12T10:03:09.611918148Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 1352 bytes
[2025-09-12T10:03:09.611922606Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.611928878Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx pkt Short dcid= key_phase=false len=5 pn=17 
[2025-09-12T10:03:09.611931643Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf tx frm ACK delay=5 blocks=[1..1] ecn_counts=None
[2025-09-12T10:03:09.611937754Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf timer=27.024713ms latest_rtt=33.348009ms srtt=33.276147ms min_rtt=31.518735ms rttvar=1.739304ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4575 app_limited=true congestion_recovery_start_time=None Rate { delivered: 11952, delivered_time: Instant { tv_sec: 370, tv_nsec: 172944919 }, first_sent_time: Instant { tv_sec: 370, tv_nsec: 139596910 }, end_of_app_limited: 16, last_sent_packet: 17, largest_acked: 12, rate_sample: RateSample { bandwidth: 1.93 Mbps, is_app_limited: true, interval: 33.348009ms, delivered: 1350, prior_delivered: 10602, prior_time: Some(Instant { tv_sec: 370, tv_nsec: 139596910 }), send_elapsed: 0ns, ack_elapsed: 33.348009ms, rtt: 33.348009ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 507120, last_update: Instant { tv_sec: 370, tv_nsec: 172985505 }, next_time: Instant { tv_sec: 370, tv_nsec: 172985505 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T10:03:09.612009929Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf written 23 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46725, at: Instant { tv_sec: 370, tv_nsec: 172985505 } })
[2025-09-12T10:03:09.612018615Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.612024866Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.612029966Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.612033232Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.612458344Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.612462762Z TRACE quiche_server] got packet Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false
[2025-09-12T10:03:09.612468202Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false len=22 pn=2 
[2025-09-12T10:03:09.612473883Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=3 blocks=[12..14] ecn_counts=None
[2025-09-12T10:03:09.612477440Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 13
[2025-09-12T10:03:09.612479874Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 14
[2025-09-12T10:03:09.612489883Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 43 bytes
[2025-09-12T10:03:09.612493760Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.612496705Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.612498920Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.614011708Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.614017859Z TRACE quiche_server] got packet Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false
[2025-09-12T10:03:09.614021977Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false len=22 pn=3 
[2025-09-12T10:03:09.614026275Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=2 blocks=[12..16] ecn_counts=None
[2025-09-12T10:03:09.614029120Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 15
[2025-09-12T10:03:09.614031415Z TRACE quiche::recovery::congestion::recovery] 11ea6f2c536309f3650906f28ad9ffae6fa648cf packet newly acked 16
[2025-09-12T10:03:09.614040722Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 43 bytes
[2025-09-12T10:03:09.614044379Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.614047144Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.614049328Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.614199257Z TRACE quiche_server] got 54 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.614207503Z TRACE quiche_server] got packet Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false
[2025-09-12T10:03:09.614211710Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx pkt Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false len=33 pn=4 
[2025-09-12T10:03:09.614216068Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm ACK delay=18 blocks=[12..16] ecn_counts=None
[2025-09-12T10:03:09.614219575Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf rx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65, 21]
[2025-09-12T10:03:09.614226077Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 54 bytes
[2025-09-12T10:03:09.614229533Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.614231788Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.614233982Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.642517279Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:46725 to [::]:443
[2025-09-12T10:03:09.642531806Z TRACE quiche_server] got packet Short dcid=11ea6f2c536309f3650906f28ad9ffae6fa648cf key_phase=false
[2025-09-12T10:03:09.642538970Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf processed 55 bytes
[2025-09-12T10:03:09.642544540Z TRACE quiche_server] recv() would block
[2025-09-12T10:03:09.642547756Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.642550772Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.735695375Z TRACE quiche_server] timed out
[2025-09-12T10:03:09.735709802Z TRACE quiche] 11ea6f2c536309f3650906f28ad9ffae6fa648cf draining timeout expired
[2025-09-12T10:03:09.735737163Z TRACE quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf done writing
[2025-09-12T10:03:09.735740980Z TRACE quiche_server] Collecting garbage
[2025-09-12T10:03:09.735745288Z INFO  quiche_server] 11ea6f2c536309f3650906f28ad9ffae6fa648cf connection collected recv=19 sent=18 lost=0 retrans=0 sent_bytes=16602 recv_bytes=3831 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:46725 validation_state=Validated active=true recv=19 sent=18 lost=0 retrans=0 rtt=33.61925ms min_rtt=Some(31.518735ms) rttvar=1.625153ms cwnd=13500 sent_bytes=16602 recv_bytes=3831 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=241418]