[2025-04-30T18:24:34.780922887Z INFO  quiche_server] listening on [::]:443
[2025-04-30T18:24:34.780948174Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T18:24:34.780955007Z TRACE quiche_server] GSO detected: false
[2025-04-30T18:24:35.625171306Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:39479 to [::]:443
[2025-04-30T18:24:35.625205561Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T18:24:35.625212904Z WARN  quiche_server] Doing version negotiation
[2025-04-30T18:24:35.625312591Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:39479 to [::]:443
[2025-04-30T18:24:35.625320886Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T18:24:35.625325375Z WARN  quiche_server] Doing version negotiation
[2025-04-30T18:24:35.625355060Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:39479 to [::]:443
[2025-04-30T18:24:35.625360661Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T18:24:35.625364418Z WARN  quiche_server] Doing version negotiation
[2025-04-30T18:24:35.625390556Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:36.561833930Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:36.561870378Z TRACE quiche_server] got packet Initial version=1 dcid=b904b5471867ac90326ffe1cf7ca5b5d scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea token=
[2025-04-30T18:24:36.561881829Z DEBUG quiche_server] New connection: dcid=b904b5471867ac90326ffe1cf7ca5b5d scid=861f46a8c100123b5fd85159e042a0d535e63fee
[2025-04-30T18:24:36.562177482Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Initial version=1 dcid=b904b5471867ac90326ffe1cf7ca5b5d scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea token= len=287 pn=0 
[2025-04-30T18:24:36.562195957Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm CRYPTO off=0 len=266
[2025-04-30T18:24:36.562225312Z TRACE quiche::tls] checking peer ALPN Ok("h3") against Ok("h3")
[2025-04-30T18:24:36.562328064Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee write message lvl=Initial len=90
[2025-04-30T18:24:36.562362979Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee set write secret lvl=Handshake
[2025-04-30T18:24:36.562445434Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee write message lvl=Handshake len=698
[2025-04-30T18:24:36.562449301Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee set write secret lvl=OneRTT
[2025-04-30T18:24:36.562457276Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee set read secret lvl=Handshake
[2025-04-30T18:24:36.562496128Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee dropped invalid packet
[2025-04-30T18:24:36.562499956Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 1200 bytes
[2025-04-30T18:24:36.562521686Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:36.562536514Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Initial version=1 dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea scid=861f46a8c100123b5fd85159e042a0d535e63fee len=99 pn=0 
[2025-04-30T18:24:36.562540571Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm ACK delay=47 blocks=[0..0] ecn_counts=None
[2025-04-30T18:24:36.562545932Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm CRYPTO off=0 len=90
[2025-04-30T18:24:36.562556391Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=998.967359ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=166 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, first_sent_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, 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: 228, tv_nsec: 712548483 }, next_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, 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-04-30T18:24:36.562592419Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Handshake version=1 dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea scid=861f46a8c100123b5fd85159e042a0d535e63fee len=702 pn=1 
[2025-04-30T18:24:36.562596035Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm CRYPTO off=0 len=698
[2025-04-30T18:24:36.562602848Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=998.921273ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=934 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, first_sent_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, 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: 228, tv_nsec: 712548483 }, next_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, 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-04-30T18:24:36.562665145Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 228, tv_nsec: 712548483 } })
[2025-04-30T18:24:36.562672959Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:36.562679652Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:36.562684010Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:36.562686725Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:37.557021204Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:37.557055818Z TRACE quiche_server] got packet Initial version=1 dcid=b904b5471867ac90326ffe1cf7ca5b5d scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea token=
[2025-04-30T18:24:37.557071988Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Initial version=1 dcid=b904b5471867ac90326ffe1cf7ca5b5d scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea token= len=287 pn=1 
[2025-04-30T18:24:37.557085444Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm CRYPTO off=0 len=266
[2025-04-30T18:24:37.557115179Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee dropped invalid packet
[2025-04-30T18:24:37.557118996Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 1200 bytes
[2025-04-30T18:24:37.557125318Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:37.557138523Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Initial version=1 dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea scid=861f46a8c100123b5fd85159e042a0d535e63fee len=5 pn=2 
[2025-04-30T18:24:37.557142430Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm ACK delay=8 blocks=[0..1] ecn_counts=None
[2025-04-30T18:24:37.557155445Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=4.368165ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=934 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, first_sent_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, 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: 229, tv_nsec: 707152105 }, next_time: Instant { tv_sec: 229, tv_nsec: 707152105 }, 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-04-30T18:24:37.557237989Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 707152105 } })
[2025-04-30T18:24:37.557245593Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:37.557251544Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:37.557255632Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:37.557258477Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:37.562353909Z TRACE quiche_server] timed out
[2025-04-30T18:24:37.562368747Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee loss detection timeout expired
[2025-04-30T18:24:37.562374938Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=998.148852ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=934 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, first_sent_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, 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: 229, tv_nsec: 707152105 }, next_time: Instant { tv_sec: 229, tv_nsec: 707152105 }, 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-04-30T18:24:37.562404233Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Initial version=1 dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea scid=861f46a8c100123b5fd85159e042a0d535e63fee len=100 pn=3 
[2025-04-30T18:24:37.562408551Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm ACK delay=666 blocks=[0..1] ecn_counts=None
[2025-04-30T18:24:37.562413050Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm CRYPTO off=0 len=90
[2025-04-30T18:24:37.562424732Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=998.099359ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1101 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, first_sent_time: Instant { tv_sec: 228, tv_nsec: 712548483 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, 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: 229, tv_nsec: 712414269 }, next_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, 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-04-30T18:24:37.562483622Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 712414269 } })
[2025-04-30T18:24:37.562491005Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:37.562496506Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:37.562500824Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:37.562503639Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:38.066427033Z TRACE quiche_server] got 1350 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:38.066468380Z TRACE quiche_server] got packet Initial version=1 dcid=861f46a8c100123b5fd85159e042a0d535e63fee scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea token=
[2025-04-30T18:24:38.066490482Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Initial version=1 dcid=861f46a8c100123b5fd85159e042a0d535e63fee scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea token= len=23 pn=2 
[2025-04-30T18:24:38.066509417Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm ACK delay=92 blocks=[0..0] ecn_counts=None
[2025-04-30T18:24:38.066519947Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee packet newly acked 0
[2025-04-30T18:24:38.066549793Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Handshake version=1 dcid=861f46a8c100123b5fd85159e042a0d535e63fee scid=1ea90276a44bfddaa590c69327bab428ab7ee1ea len=63 pn=3 
[2025-04-30T18:24:38.066556796Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm ACK delay=69 blocks=[1..1] ecn_counts=None
[2025-04-30T18:24:38.066560303Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee packet newly acked 1
[2025-04-30T18:24:38.066564480Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm CRYPTO off=0 len=36
[2025-04-30T18:24:38.066584838Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee set read secret lvl=OneRTT
[2025-04-30T18:24:38.066624282Z TRACE quiche::tls] 861f46a8c100123b5fd85159e042a0d535e63fee write message lvl=OneRTT len=396
[2025-04-30T18:24:38.066635583Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee dropped epoch 1 state
[2025-04-30T18:24:38.066640052Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee connection established: proto=Ok("h3") 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: 1350, initial_max_data: 10000000, initial_max_stream_data_bidi_local: 1000000, initial_max_stream_data_bidi_remote: 1000000, initial_max_stream_data_uni: 1000000, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: true, active_conn_id_limit: 8, initial_source_connection_id: Some(1ea90276a44bfddaa590c69327bab428ab7ee1ea), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T18:24:38.066663957Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee dropped epoch 0 state
[2025-04-30T18:24:38.066667744Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=1144 pn=4 
[2025-04-30T18:24:38.066691498Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[be, 8f, d8, c5, 74, f1, ea, 5f, 42, 2e, 31, dd, 31, ca, 79, 0e, ac, 3b, a5, b4] reset_token=[c6, 7e, 02, dd, c6, a2, 8d, 91, 23, ff, f4, ca, fb, 7b, 6f, 05]
[2025-04-30T18:24:38.066701817Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[0a, d6, 43, d4, 73, 14, 3b, ff, 7d, 7c, e8, db, 89, 23, 55, de, dc, 70, a7, a5] reset_token=[ed, 88, a4, 31, fe, 50, 62, d2, e3, 74, 6e, f4, 2c, 79, 61, 3d]
[2025-04-30T18:24:38.066709211Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c0, 70, c1, d0, 7f, ef, 9e, 88, 49, 5d, 76, fd, 6b, 10, bd, 45, c8, 49, 5a, 11] reset_token=[5e, 6a, 28, da, f9, b6, 1f, 8a, e3, 3c, 83, 7e, 7a, 90, 4e, ba]
[2025-04-30T18:24:38.066716455Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[b3, dc, 4e, 7c, 12, 5f, 85, 0c, 0f, 21, 3e, 52, 30, ba, e0, b9, 8f, 72, dd, 95] reset_token=[a2, 46, 56, 03, bc, 8c, 00, e5, 6e, 35, dc, 72, cc, 85, 7f, 3c]
[2025-04-30T18:24:38.066724379Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[1f, 81, 70, da, ef, 09, 46, 88, 23, e9, b4, 50, 1d, b1, 17, be, ef, 1d, 14, 9e] reset_token=[8d, f1, 7a, 98, 3a, 41, e8, 0b, d3, 99, 69, 1b, dd, ed, 63, 61]
[2025-04-30T18:24:38.066731693Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[c3, 61, 5b, c9, d6, 06, 3c, 7d, e8, 7e, 5c, 40, 46, bf, d5, 06, 9a, e7, 41, ef] reset_token=[6e, 5e, 81, d8, 16, 04, 23, db, bd, 5a, a1, fa, 4e, c4, aa, 60]
[2025-04-30T18:24:38.066739017Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[76, 7e, 96, 93, 19, 35, 9b, 65, 89, 23, 79, 50, a2, 38, cd, 0a, 1c, bb, 6a, 71] reset_token=[df, 04, 14, d8, 52, 40, 2d, e2, f3, 91, 27, f2, db, b2, e6, 43]
[2025-04-30T18:24:38.066744798Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm STREAM id=2 off=0 len=19 fin=false
[2025-04-30T18:24:38.066752772Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm PADDING len=823
[2025-04-30T18:24:38.066764785Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 1350 bytes
[2025-04-30T18:24:38.066788249Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm SETTINGS stream=3 len=18
[2025-04-30T18:24:38.066831249Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee open GREASE stream 15
[2025-04-30T18:24:38.066837531Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee stream id 2 is readable
[2025-04-30T18:24:38.066843743Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 2
[2025-04-30T18:24:38.066848512Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee open peer's control stream 2
[2025-04-30T18:24:38.066852750Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 2
[2025-04-30T18:24:38.066856617Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 2
[2025-04-30T18:24:38.066860955Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 16 bytes on stream 2
[2025-04-30T18:24:38.066864501Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm SETTINGS max_field_section=None, qpack_max_table=None, qpack_blocked=None raw=Some([(4324058093750082, 1648593731607909352)]), additional_settings=Some([(4324058093750082, 1648593731607909352)]) stream=2 payload_len=16
[2025-04-30T18:24:38.066877977Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:38.066882235Z TRACE quiche_server] got packet Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false
[2025-04-30T18:24:38.066888276Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=23 pn=5 
[2025-04-30T18:24:38.066897894Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm STREAM id=6 off=0 len=1 fin=false
[2025-04-30T18:24:38.066904416Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 44 bytes
[2025-04-30T18:24:38.066907773Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee stream id 6 is readable
[2025-04-30T18:24:38.066911990Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 6
[2025-04-30T18:24:38.066919434Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:38.066923091Z TRACE quiche_server] got packet Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false
[2025-04-30T18:24:38.066927700Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=23 pn=6 
[2025-04-30T18:24:38.066932779Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm STREAM id=10 off=0 len=1 fin=false
[2025-04-30T18:24:38.066938210Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 44 bytes
[2025-04-30T18:24:38.066941295Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee stream id 10 is readable
[2025-04-30T18:24:38.066945273Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 10
[2025-04-30T18:24:38.066951745Z TRACE quiche_server] got 111 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:38.066955241Z TRACE quiche_server] got packet Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false
[2025-04-30T18:24:38.066959720Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=90 pn=7 
[2025-04-30T18:24:38.066964559Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm STREAM id=0 off=0 len=68 fin=true
[2025-04-30T18:24:38.066971081Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 111 bytes
[2025-04-30T18:24:38.066974397Z DEBUG quiche_apps::common] 861f46a8c100123b5fd85159e042a0d535e63fee response stream 0 is writable with capacity Ok(13500)
[2025-04-30T18:24:38.067014472Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee stream id 0 is readable
[2025-04-30T18:24:38.067022417Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 0
[2025-04-30T18:24:38.067026505Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 7 bytes on stream 0
[2025-04-30T18:24:38.067030342Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 0
[2025-04-30T18:24:38.067033618Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm UNKNOWN raw_type=2954911185191718562 stream=0 payload_len=0
[2025-04-30T18:24:38.067039769Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 0
[2025-04-30T18:24:38.067043607Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 7 bytes on stream 0
[2025-04-30T18:24:38.067047223Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 0
[2025-04-30T18:24:38.067051311Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 18 bytes on stream 0
[2025-04-30T18:24:38.067054367Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm UNKNOWN raw_type=1013021912966381351 stream=0 payload_len=18
[2025-04-30T18:24:38.067059196Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 0
[2025-04-30T18:24:38.067063003Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 0
[2025-04-30T18:24:38.067067011Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 30 bytes on stream 0
[2025-04-30T18:24:38.067070006Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm HEADERS stream=0 payload_len=30
[2025-04-30T18:24:38.067078422Z TRACE quiche::h3::qpack::decoder] Header count=0 base=0
[2025-04-30T18:24:38.067081648Z TRACE quiche::h3::qpack::decoder] Indexed index=17 static=true
[2025-04-30T18:24:38.067084784Z TRACE quiche::h3::qpack::decoder] Indexed index=23 static=true
[2025-04-30T18:24:38.067089713Z TRACE quiche::h3::qpack::decoder] Literal name_idx=0 static=true value=[115, 101, 114, 118, 101, 114, 52]
[2025-04-30T18:24:38.067094712Z TRACE quiche::h3::qpack::decoder] Literal name_idx=1 static=true value=[47, 110, 98, 98, 109, 109, 110, 98, 107, 107, 101]
[2025-04-30T18:24:38.067098940Z TRACE quiche::h3::qpack::decoder] Literal name_idx=95 static=true value=[113, 117, 105, 99, 104, 101]
[2025-04-30T18:24:38.067107977Z INFO  quiche_apps::common] 861f46a8c100123b5fd85159e042a0d535e63fee got request [(":method", "GET"), (":scheme", "https"), (":authority", "server4"), (":path", "/nbbmmnbkke"), ("user-agent", "quiche")] on stream id 0
[2025-04-30T18:24:38.067167709Z INFO  quiche_apps::common] 861f46a8c100123b5fd85159e042a0d535e63fee prioritizing response on stream 0 as Priority { urgency: 3, incremental: false }
[2025-04-30T18:24:38.067177738Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm GREASE stream=0 len=0
[2025-04-30T18:24:38.067185302Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm GREASE stream=0 len=18
[2025-04-30T18:24:38.067193357Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm HEADERS stream=0 len=16 fin=false
[2025-04-30T18:24:38.067201382Z DEBUG quiche_apps::common] 861f46a8c100123b5fd85159e042a0d535e63fee response stream 0 is writable with capacity Ok(13446)
[2025-04-30T18:24:38.067207503Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm DATA stream=0 len=1024 fin=true
[2025-04-30T18:24:38.067215979Z TRACE quiche_server] got 69 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:38.067219966Z TRACE quiche_server] got packet Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false
[2025-04-30T18:24:38.067225888Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=48 pn=8 
[2025-04-30T18:24:38.067232159Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm STREAM id=14 off=0 len=26 fin=true
[2025-04-30T18:24:38.067239754Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 69 bytes
[2025-04-30T18:24:38.067243090Z TRACE quiche::h3] 861f46a8c100123b5fd85159e042a0d535e63fee stream id 14 is readable
[2025-04-30T18:24:38.067247458Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 1 bytes on stream 14
[2025-04-30T18:24:38.067251425Z TRACE quiche::h3::stream] 861f46a8c100123b5fd85159e042a0d535e63fee read 7 bytes on stream 14
[2025-04-30T18:24:38.067258128Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:38.067267355Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T18:24:38.067278546Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Short dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea key_phase=false len=710 pn=4 
[2025-04-30T18:24:38.067282514Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm ACK delay=5 blocks=[4..8] ecn_counts=None
[2025-04-30T18:24:38.067286461Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[24, f7, 07, 0e, f0, 27, 62, 0f, 49, 18, 32, dc, 3b, f0, 08, 25, 3b, e3, 3f, 62] reset_token=[ea, 2d, e5, 7c, 91, 81, 05, e9, ac, d4, 53, 8d, de, 38, 7f, 7e]
[2025-04-30T18:24:38.067294777Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[28, 30, 48, e7, e5, ce, 07, f8, e3, 8f, be, 38, 71, 9c, ae, 5e, c4, 8b, c5, 3c] reset_token=[d6, e5, 93, 84, 81, b2, 96, 7b, f8, 29, 3b, c4, 06, 1d, 5e, 74]
[2025-04-30T18:24:38.067301950Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[aa, 66, 98, 61, a2, 7f, ed, 8b, 98, f6, c4, 34, 44, ff, 21, 6a, 54, d5, 6d, 20] reset_token=[87, c6, ce, a9, 64, 8f, d2, b9, 41, 4b, 58, c3, cb, df, 48, e9]
[2025-04-30T18:24:38.067314313Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[92, db, b8, 0f, b8, 6b, 58, 5b, d3, 2f, 60, 97, 55, bf, e4, c0, c4, 0e, 6c, 32] reset_token=[e9, ef, 36, 5a, d0, 7d, d4, 8d, 8b, 16, 90, 18, e2, f8, 3a, ab]
[2025-04-30T18:24:38.067321467Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[b9, 04, b5, 34, 16, 29, 68, ea, d6, 66, 01, fa, 64, eb, 20, 00, 03, 87, 9f, 0b] reset_token=[71, fb, 08, 95, 46, 50, 1e, 6e, 3f, 9a, 60, 62, 1b, 0d, 0a, 2f]
[2025-04-30T18:24:38.067328870Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[27, df, 72, 42, ae, ba, ff, e1, 83, e7, bb, b7, 13, 5c, 96, 3a, 36, 84, 7f, 84] reset_token=[68, f8, e7, 6d, 3b, b3, 9e, 29, 11, 30, ad, c0, 76, bf, d5, 90]
[2025-04-30T18:24:38.067335773Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[be, 10, 1f, cd, db, f4, 27, 56, 56, fe, cb, 78, 5a, 0b, 92, 10, e6, 53, f8, 81] reset_token=[87, 29, 45, d0, d9, dc, d1, f6, 3f, ae, fc, 1b, 00, 5a, eb, 40]
[2025-04-30T18:24:38.067342806Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm HANDSHAKE_DONE
[2025-04-30T18:24:38.067345722Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm CRYPTO off=0 len=396
[2025-04-30T18:24:38.067348807Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm STREAM id=3 off=0 len=19 fin=false
[2025-04-30T18:24:38.067376559Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=3.784857953s latest_rtt=1.504024369s srtt=1.503969307s min_rtt=1.503961442s rttvar=564.001271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=748 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, first_sent_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 621, is_app_limited: true, interval: 1.503961442s, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 228, tv_nsec: 712548483 }), send_elapsed: 0ns, ack_elapsed: 1.503961442s, rtt: 1.503961442s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11220, last_update: Instant { tv_sec: 229, tv_nsec: 712414269 }, next_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, 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-04-30T18:24:38.067446771Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 748 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 712414269 } })
[2025-04-30T18:24:38.067453614Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:38.067459905Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:38.067466548Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12752 out_len=1350 left=1312
[2025-04-30T18:24:38.067471307Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Short dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea key_phase=false len=6 pn=5 
[2025-04-30T18:24:38.067474523Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm STREAM id=7 off=0 len=1 fin=false
[2025-04-30T18:24:38.067481916Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=3.784954534s latest_rtt=1.504024369s srtt=1.503969307s min_rtt=1.503961442s rttvar=564.001271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=792 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, first_sent_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 621, is_app_limited: true, interval: 1.503961442s, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 228, tv_nsec: 712548483 }), send_elapsed: 0ns, ack_elapsed: 1.503961442s, rtt: 1.503961442s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11220, last_update: Instant { tv_sec: 229, tv_nsec: 712414269 }, next_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, 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-04-30T18:24:38.067551677Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 44 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 712414269 } })
[2025-04-30T18:24:38.067560293Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:38.067565964Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:38.067573808Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12708 out_len=1350 left=1312
[2025-04-30T18:24:38.067579750Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Short dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea key_phase=false len=6 pn=6 
[2025-04-30T18:24:38.067584118Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm STREAM id=11 off=0 len=1 fin=false
[2025-04-30T18:24:38.067594217Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=3.784948713s latest_rtt=1.504024369s srtt=1.503969307s min_rtt=1.503961442s rttvar=564.001271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=836 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, first_sent_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 621, is_app_limited: true, interval: 1.503961442s, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 228, tv_nsec: 712548483 }), send_elapsed: 0ns, ack_elapsed: 1.503961442s, rtt: 1.503961442s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11220, last_update: Instant { tv_sec: 229, tv_nsec: 712414269 }, next_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, 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-04-30T18:24:38.067629823Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 44 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 712414269 } })
[2025-04-30T18:24:38.067634452Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:38.067638329Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:38.067646364Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12664 out_len=1350 left=1312
[2025-04-30T18:24:38.067652836Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Short dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea key_phase=false len=1086 pn=7 
[2025-04-30T18:24:38.067663907Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm STREAM id=0 off=0 len=1081 fin=true
[2025-04-30T18:24:38.067674968Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=3.784940348s latest_rtt=1.504024369s srtt=1.503969307s min_rtt=1.503961442s rttvar=564.001271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1960 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, first_sent_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 621, is_app_limited: true, interval: 1.503961442s, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 228, tv_nsec: 712548483 }), send_elapsed: 0ns, ack_elapsed: 1.503961442s, rtt: 1.503961442s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11220, last_update: Instant { tv_sec: 229, tv_nsec: 712414269 }, next_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, 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-04-30T18:24:38.067718138Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 1124 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 712414269 } })
[2025-04-30T18:24:38.067722917Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:38.067729319Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:38.067737204Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee pmtud probe status false hs_con=true hs_sent=true cwnd_avail=11540 out_len=1350 left=1312
[2025-04-30T18:24:38.067743265Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx pkt Short dcid=1ea90276a44bfddaa590c69327bab428ab7ee1ea key_phase=false len=31 pn=8 
[2025-04-30T18:24:38.067747884Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee tx frm STREAM id=15 off=0 len=26 fin=true
[2025-04-30T18:24:38.067758193Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee timer=3.784948152s latest_rtt=1.504024369s srtt=1.503969307s min_rtt=1.503961442s rttvar=564.001271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2029 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, first_sent_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 621, is_app_limited: true, interval: 1.503961442s, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 228, tv_nsec: 712548483 }), send_elapsed: 0ns, ack_elapsed: 1.503961442s, rtt: 1.503961442s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11220, last_update: Instant { tv_sec: 229, tv_nsec: 712414269 }, next_time: Instant { tv_sec: 229, tv_nsec: 712414269 }, 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-04-30T18:24:38.067796034Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee written 69 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49231, at: Instant { tv_sec: 229, tv_nsec: 712414269 } })
[2025-04-30T18:24:38.067800823Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:38.067805382Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:38.067815921Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:38.067819719Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:39.569264481Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:39.569298063Z TRACE quiche_server] got packet Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false
[2025-04-30T18:24:39.569312651Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=22 pn=9 
[2025-04-30T18:24:39.569326025Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm ACK delay=10 blocks=[4..6] ecn_counts=None
[2025-04-30T18:24:39.569333490Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee packet newly acked 4
[2025-04-30T18:24:39.569338739Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee packet newly acked 5
[2025-04-30T18:24:39.569342406Z TRACE quiche::recovery::congestion::recovery] 861f46a8c100123b5fd85159e042a0d535e63fee packet newly acked 6
[2025-04-30T18:24:39.569370579Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 43 bytes
[2025-04-30T18:24:39.569379756Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:39.569384004Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:39.569386659Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:39.569778642Z TRACE quiche_server] got 49 bytes from [::ffff:193.167.0.100]:49231 to [::]:443
[2025-04-30T18:24:39.569786547Z TRACE quiche_server] got packet Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false
[2025-04-30T18:24:39.569792097Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx pkt Short dcid=861f46a8c100123b5fd85159e042a0d535e63fee key_phase=false len=28 pn=10 
[2025-04-30T18:24:39.569798129Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee rx frm APPLICATION_CLOSE err=100 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-04-30T18:24:39.569806715Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee processed 49 bytes
[2025-04-30T18:24:39.569811213Z TRACE quiche_server] recv() would block
[2025-04-30T18:24:39.569813598Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:39.569815812Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:50.857081922Z TRACE quiche_server] timed out
[2025-04-30T18:24:50.857123740Z TRACE quiche] 861f46a8c100123b5fd85159e042a0d535e63fee draining timeout expired
[2025-04-30T18:24:50.857168514Z TRACE quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee done writing
[2025-04-30T18:24:50.857174034Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:24:50.857179174Z INFO  quiche_server] 861f46a8c100123b5fd85159e042a0d535e63fee connection collected recv=11 sent=9 lost=0 retrans=1 sent_bytes=3202 recv_bytes=2376 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:49231 validation_state=Validated active=true recv=11 sent=9 lost=0 retrans=1 rtt=1.566828013s min_rtt=Some(1.503961442s) rttvar=548.718368ms cwnd=13500 sent_bytes=3202 recv_bytes=2376 lost_bytes=0 stream_retrans_bytes=90 pmtu=1350 delivery_rate=416]