[2025-12-13T13:12:09.217444352Z INFO  quiche_server] listening on [::]:443
[2025-12-13T13:12:09.217470090Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-12-13T13:12:09.217477023Z TRACE quiche_server] GSO detected: false
[2025-12-13T13:12:09.557659742Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:52619 to [::]:443
[2025-12-13T13:12:09.557702882Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-12-13T13:12:09.557713251Z WARN  quiche_server] Doing version negotiation
[2025-12-13T13:12:09.557800464Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:11.985974328Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:11.986003923Z TRACE quiche_server] got packet Initial version=1 dcid=f1991f20c6f5dac2 scid=816af5bd67930005 token=
[2025-12-13T13:12:11.986025183Z DEBUG quiche_server] New connection: dcid=f1991f20c6f5dac2 scid=1eea7b26ff67499a9323ee014c51c2e2720ba615
[2025-12-13T13:12:11.986248860Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Initial version=1 dcid=f1991f20c6f5dac2 scid=816af5bd67930005 token= len=1174 pn=0 
[2025-12-13T13:12:11.986264960Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm CRYPTO off=0 len=257
[2025-12-13T13:12:11.986293273Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-12-13T13:12:11.986298272Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-12-13T13:12:11.986413467Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 write message lvl=Initial len=123
[2025-12-13T13:12:11.986450546Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 set write secret lvl=Handshake
[2025-12-13T13:12:11.986517752Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 write message lvl=Handshake len=694
[2025-12-13T13:12:11.986521839Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 set write secret lvl=OneRTT
[2025-12-13T13:12:11.986529984Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 set read secret lvl=Handshake
[2025-12-13T13:12:11.986552196Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm PADDING len=896
[2025-12-13T13:12:11.986572955Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 1200 bytes
[2025-12-13T13:12:11.986584196Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:11.986599464Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx pkt Initial version=1 dcid=816af5bd67930005 scid=1eea7b26ff67499a9323ee014c51c2e2720ba615 len=132 pn=0 
[2025-12-13T13:12:11.986604093Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm ACK delay=46 blocks=[0..0] ecn_counts=None
[2025-12-13T13:12:11.986609974Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm CRYPTO off=0 len=123
[2025-12-13T13:12:11.986620844Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=998.965867ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=187 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, first_sent_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 262, tv_nsec: 27838717 }, next_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, 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-13T13:12:11.986657182Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx pkt Handshake version=1 dcid=816af5bd67930005 scid=1eea7b26ff67499a9323ee014c51c2e2720ba615 len=698 pn=1 
[2025-12-13T13:12:11.986661710Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm CRYPTO off=0 len=694
[2025-12-13T13:12:11.986669144Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=998.918067ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=939 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, first_sent_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, 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: 262, tv_nsec: 27838717 }, next_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, 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-13T13:12:11.986728004Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47291, at: Instant { tv_sec: 262, tv_nsec: 27838717 } })
[2025-12-13T13:12:11.986734676Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:11.986739655Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:11.986743743Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:11.986746548Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:12.986795683Z TRACE quiche_server] timed out
[2025-12-13T13:12:12.986824557Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 loss detection timeout expired
[2025-12-13T13:12:12.986832903Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=997.753277ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=939 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, first_sent_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, 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: 262, tv_nsec: 27838717 }, next_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, 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-13T13:12:12.986885731Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx pkt Initial version=1 dcid=816af5bd67930005 scid=1eea7b26ff67499a9323ee014c51c2e2720ba615 len=135 pn=2 
[2025-12-13T13:12:12.986891441Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm ACK delay=125081 blocks=[0..0] ecn_counts=None
[2025-12-13T13:12:12.986897994Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm CRYPTO off=0 len=123
[2025-12-13T13:12:12.986917811Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=997.669371ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1129 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, first_sent_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, 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: 263, tv_nsec: 28110176 }, next_time: Instant { tv_sec: 263, tv_nsec: 28110176 }, 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-13T13:12:12.987001797Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47291, at: Instant { tv_sec: 263, tv_nsec: 28110176 } })
[2025-12-13T13:12:12.987011095Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:12.987018008Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:12.987023197Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:12.987026764Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:12.993417028Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:12.993433809Z TRACE quiche_server] got packet Initial version=1 dcid=f1991f20c6f5dac2 scid=816af5bd67930005 token=
[2025-12-13T13:12:12.993445010Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Initial version=1 dcid=f1991f20c6f5dac2 scid=816af5bd67930005 token= len=1174 pn=1 
[2025-12-13T13:12:12.993455650Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm CRYPTO off=0 len=257
[2025-12-13T13:12:12.993466831Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm PADDING len=896
[2025-12-13T13:12:12.993480887Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 1200 bytes
[2025-12-13T13:12:12.993486878Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:12.993497798Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx pkt Initial version=1 dcid=816af5bd67930005 scid=1eea7b26ff67499a9323ee014c51c2e2720ba615 len=5 pn=3 
[2025-12-13T13:12:12.993502197Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm ACK delay=6 blocks=[0..1] ecn_counts=None
[2025-12-13T13:12:12.993511985Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=991.075056ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1129 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, first_sent_time: Instant { tv_sec: 262, tv_nsec: 27838717 }, end_of_app_limited: 1, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 263, tv_nsec: 34740989 }, next_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, 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-13T13:12:12.993556989Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47291, at: Instant { tv_sec: 263, tv_nsec: 34740989 } })
[2025-12-13T13:12:12.993570364Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:12.993575704Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:12.993580623Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:12.993584049Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:13.518032606Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:13.518060278Z TRACE quiche_server] got packet Initial version=1 dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 scid=816af5bd67930005 token=
[2025-12-13T13:12:13.518075126Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Initial version=1 dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 scid=816af5bd67930005 token= len=1162 pn=2 
[2025-12-13T13:12:13.518089422Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm ACK delay=0 blocks=[0..0] ecn_counts=None
[2025-12-13T13:12:13.518097457Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 packet newly acked 0
[2025-12-13T13:12:13.518108728Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm PADDING len=1140
[2025-12-13T13:12:13.518133605Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 1200 bytes
[2025-12-13T13:12:13.518140848Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:13.518152840Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:13.518156868Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:13.541999180Z TRACE quiche_server] got 92 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:13.542016182Z TRACE quiche_server] got packet Handshake version=1 dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 scid=816af5bd67930005
[2025-12-13T13:12:13.542025760Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Handshake version=1 dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 scid=816af5bd67930005 len=56 pn=0 
[2025-12-13T13:12:13.542034436Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm CRYPTO off=0 len=36
[2025-12-13T13:12:13.542052179Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 set read secret lvl=OneRTT
[2025-12-13T13:12:13.542092264Z TRACE quiche::tls] 1eea7b26ff67499a9323ee014c51c2e2720ba615 write message lvl=OneRTT len=396
[2025-12-13T13:12:13.542102863Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 dropped epoch 1 state
[2025-12-13T13:12:13.542108244Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("P-256") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 60000, stateless_reset_token: None, max_udp_payload_size: 1500, initial_max_data: 2500000, initial_max_stream_data_bidi_local: 250000, initial_max_stream_data_bidi_remote: 250000, initial_max_stream_data_uni: 250000, initial_max_streams_bidi: 3, 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(816af5bd67930005), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-12-13T13:12:13.542135364Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 dropped epoch 0 state
[2025-12-13T13:12:13.542139492Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 92 bytes
[2025-12-13T13:12:13.542154920Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:13.542169027Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx pkt Short dcid=816af5bd67930005 key_phase=false len=441 pn=4 
[2025-12-13T13:12:13.542173666Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[69, 23, 44, f1, c6, b5, 43, af, 6a, dd, a2, f5, 25, 5f, 00, 02, 6e, 78, 26, 60] reset_token=[1a, ae, 97, b8, 3b, 46, eb, 7e, b9, c7, 59, 73, 2c, a3, 21, 4c]
[2025-12-13T13:12:13.542190928Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm HANDSHAKE_DONE
[2025-12-13T13:12:13.542194665Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm CRYPTO off=0 len=396
[2025-12-13T13:12:13.542207449Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=4.619402365s latest_rtt=1.531484147s srtt=1.531484147s min_rtt=1.531484147s rttvar=765.742073ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=467 app_limited=true congestion_recovery_start_time=None Rate { delivered: 187, delivered_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, first_sent_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.98 Kbps, is_app_limited: true, interval: 1.531484147s, delivered: 187, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 262, tv_nsec: 27838717 }), send_elapsed: 0ns, ack_elapsed: 1.531484147s, rtt: 1.531484147s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11018, last_update: Instant { tv_sec: 263, tv_nsec: 34740989 }, next_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, 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-13T13:12:13.542273642Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 written 467 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47291, at: Instant { tv_sec: 263, tv_nsec: 34740989 } })
[2025-12-13T13:12:13.542281266Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:13.542286496Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:13.542290734Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:13.542294100Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:13.545240683Z TRACE quiche_server] got 58 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:13.545254278Z TRACE quiche_server] got packet Handshake version=1 dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 scid=816af5bd67930005
[2025-12-13T13:12:13.545264136Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 dropped invalid packet
[2025-12-13T13:12:13.545268364Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 58 bytes
[2025-12-13T13:12:13.545274245Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:13.545279214Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:13.545282921Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:13.551771723Z TRACE quiche_server] got 65 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:13.551790868Z TRACE quiche_server] got packet Short dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 key_phase=false
[2025-12-13T13:12:13.551800456Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Short dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 key_phase=false len=44 pn=0 
[2025-12-13T13:12:13.551808852Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm STREAM id=0 off=0 len=23 fin=true
[2025-12-13T13:12:13.551820934Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 65 bytes
[2025-12-13T13:12:13.551825192Z DEBUG quiche_apps::common] 1eea7b26ff67499a9323ee014c51c2e2720ba615 response stream 0 is writable with capacity Ok(13033)
[2025-12-13T13:12:13.551836373Z TRACE quiche_apps::common] 1eea7b26ff67499a9323ee014c51c2e2720ba615 received 23 bytes
[2025-12-13T13:12:13.551840371Z TRACE quiche_apps::common] 1eea7b26ff67499a9323ee014c51c2e2720ba615 stream 0 has 23 bytes (fin? true)
[2025-12-13T13:12:13.551846522Z INFO  quiche_apps::common] 1eea7b26ff67499a9323ee014c51c2e2720ba615 got GET request for "/www/hard-fast-cleric" on stream 0
[2025-12-13T13:12:13.551890424Z INFO  quiche_apps::common] 1eea7b26ff67499a9323ee014c51c2e2720ba615 sending response of size 1024 on stream 0
[2025-12-13T13:12:13.551899651Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:13.551910241Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx pkt Short dcid=816af5bd67930005 key_phase=false len=1034 pn=5 
[2025-12-13T13:12:13.551914659Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm ACK delay=13 blocks=[0..0] ecn_counts=None
[2025-12-13T13:12:13.551919388Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 tx frm STREAM id=0 off=0 len=1024 fin=true
[2025-12-13T13:12:13.551929457Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 timer=4.619425378s latest_rtt=1.531484147s srtt=1.531484147s min_rtt=1.531484147s rttvar=765.742073ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1527 app_limited=true congestion_recovery_start_time=None Rate { delivered: 187, delivered_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, first_sent_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.98 Kbps, is_app_limited: true, interval: 1.531484147s, delivered: 187, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 262, tv_nsec: 27838717 }), send_elapsed: 0ns, ack_elapsed: 1.531484147s, rtt: 1.531484147s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11018, last_update: Instant { tv_sec: 263, tv_nsec: 34740989 }, next_time: Instant { tv_sec: 263, tv_nsec: 34740989 }, 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-13T13:12:13.551978198Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 written 1060 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47291, at: Instant { tv_sec: 263, tv_nsec: 34740989 } })
[2025-12-13T13:12:13.551985501Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:13.551990711Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:13.551994809Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:13.551998235Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:15.055175038Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:15.055206156Z TRACE quiche_server] got packet Short dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 key_phase=false
[2025-12-13T13:12:15.055221415Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Short dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 key_phase=false len=23 pn=1 
[2025-12-13T13:12:15.055237174Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm ACK delay=875 blocks=[4..5] ecn_counts=None
[2025-12-13T13:12:15.055252743Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 packet newly acked 4
[2025-12-13T13:12:15.055258534Z TRACE quiche::recovery::congestion::recovery] 1eea7b26ff67499a9323ee014c51c2e2720ba615 packet newly acked 5
[2025-12-13T13:12:15.055289251Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 44 bytes
[2025-12-13T13:12:15.055299491Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:15.055307165Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:15.055312515Z TRACE quiche_server] Collecting garbage
[2025-12-13T13:12:15.064045470Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:47291 to [::]:443
[2025-12-13T13:12:15.064062962Z TRACE quiche_server] got packet Short dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 key_phase=false
[2025-12-13T13:12:15.064073602Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx pkt Short dcid=1eea7b26ff67499a9323ee014c51c2e2720ba615 key_phase=false len=21 pn=2 
[2025-12-13T13:12:15.064104380Z TRACE quiche] 1eea7b26ff67499a9323ee014c51c2e2720ba615 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-12-13T13:12:15.064116863Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 processed 42 bytes
[2025-12-13T13:12:15.064123125Z TRACE quiche_server] recv() would block
[2025-12-13T13:12:15.064127072Z TRACE quiche_server] 1eea7b26ff67499a9323ee014c51c2e2720ba615 done writing
[2025-12-13T13:12:15.064130869Z TRACE quiche_server] Collecting garbage