[2025-04-30T10:15:06.076054142Z INFO  quiche_server] listening on [::]:443
[2025-04-30T10:15:06.076080662Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T10:15:06.076087886Z TRACE quiche_server] GSO detected: false
[2025-04-30T10:15:06.878075112Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:52688 to [::]:443
[2025-04-30T10:15:06.878111160Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:15:06.878118794Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:15:06.878219352Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:52688 to [::]:443
[2025-04-30T10:15:06.878228289Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:15:06.878234080Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:15:06.878266861Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:52688 to [::]:443
[2025-04-30T10:15:06.878273854Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:15:06.878279034Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:15:06.878311976Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.173655382Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:53756 to [::]:443
[2025-04-30T10:15:07.173684707Z TRACE quiche_server] got packet Initial version=1 dcid=cb2aecae63b3f0b53a1474f77c9c7670e47d scid=f8d923ef9cb52ca43baefe1d235542c852 token=
[2025-04-30T10:15:07.173694695Z DEBUG quiche_server] New connection: dcid=cb2aecae63b3f0b53a1474f77c9c7670e47d scid=949318089f2253e6958754bd8b8ea71ab62c2b45
[2025-04-30T10:15:07.173962146Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Initial version=1 dcid=cb2aecae63b3f0b53a1474f77c9c7670e47d scid=f8d923ef9cb52ca43baefe1d235542c852 token= len=1153 pn=1694514420 
[2025-04-30T10:15:07.173978286Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm CRYPTO off=0 len=263
[2025-04-30T10:15:07.174006519Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T10:15:07.174011288Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T10:15:07.174111285Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 write message lvl=Initial len=90
[2025-04-30T10:15:07.174144518Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 set write secret lvl=Handshake
[2025-04-30T10:15:07.174219488Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 write message lvl=Handshake len=706
[2025-04-30T10:15:07.174223095Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 set write secret lvl=OneRTT
[2025-04-30T10:15:07.174230659Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 set read secret lvl=Handshake
[2025-04-30T10:15:07.174251598Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm PADDING len=866
[2025-04-30T10:15:07.174274671Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 processed 1200 bytes
[2025-04-30T10:15:07.174294649Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.174309036Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Initial version=1 dcid=f8d923ef9cb52ca43baefe1d235542c852 scid=949318089f2253e6958754bd8b8ea71ab62c2b45 len=106 pn=0 
[2025-04-30T10:15:07.174313033Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm ACK delay=45 blocks=[1694514420..1694514420] ecn_counts=None
[2025-04-30T10:15:07.174318714Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm CRYPTO off=0 len=90
[2025-04-30T10:15:07.174329444Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=998.967129ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=170 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 397, tv_nsec: 399451457 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 399451457 }, 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: 397, tv_nsec: 399451457 }, next_time: Instant { tv_sec: 397, tv_nsec: 399451457 }, 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-30T10:15:07.174362185Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Handshake version=1 dcid=f8d923ef9cb52ca43baefe1d235542c852 scid=949318089f2253e6958754bd8b8ea71ab62c2b45 len=710 pn=1 
[2025-04-30T10:15:07.174365742Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm CRYPTO off=0 len=706
[2025-04-30T10:15:07.174372745Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=998.924379ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=943 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 397, tv_nsec: 399451457 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 399451457 }, 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: 397, tv_nsec: 399451457 }, next_time: Instant { tv_sec: 397, tv_nsec: 399451457 }, 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-30T10:15:07.174437095Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:53756, at: Instant { tv_sec: 397, tv_nsec: 399451457 } })
[2025-04-30T10:15:07.174448797Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.174457323Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.174464226Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.174468845Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.208766779Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:53756 to [::]:443
[2025-04-30T10:15:07.208790253Z TRACE quiche_server] got packet Initial version=1 dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 scid=f8d923ef9cb52ca43baefe1d235542c852 token=
[2025-04-30T10:15:07.208804800Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Initial version=1 dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 scid=f8d923ef9cb52ca43baefe1d235542c852 token= len=22 pn=1694514421 
[2025-04-30T10:15:07.208817384Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm ACK delay=0 blocks=[0..0] ecn_counts=None
[2025-04-30T10:15:07.208824798Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 packet newly acked 0
[2025-04-30T10:15:07.208873709Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Handshake version=1 dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 scid=f8d923ef9cb52ca43baefe1d235542c852 len=64 pn=1694514420 
[2025-04-30T10:15:07.208887846Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm ACK delay=0 blocks=[1..1] ecn_counts=None
[2025-04-30T10:15:07.208891543Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 packet newly acked 1
[2025-04-30T10:15:07.208904747Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm CRYPTO off=0 len=36
[2025-04-30T10:15:07.208925386Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 set read secret lvl=OneRTT
[2025-04-30T10:15:07.208963968Z TRACE quiche::tls] 949318089f2253e6958754bd8b8ea71ab62c2b45 write message lvl=OneRTT len=396
[2025-04-30T10:15:07.208974528Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 dropped epoch 1 state
[2025-04-30T10:15:07.208979167Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 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: 25165824, initial_max_stream_data_bidi_local: 16777216, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 16777216, initial_max_streams_bidi: 0, initial_max_streams_uni: 0, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 7, initial_source_connection_id: Some(f8d923ef9cb52ca43baefe1d235542c852), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T10:15:07.209003993Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 dropped epoch 0 state
[2025-04-30T10:15:07.209008091Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false len=996 pn=1694514420 
[2025-04-30T10:15:07.209016326Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[8b, 81, 5e, ae, f0, 2d, 1a, b4, c7, 87, 00, 00, 66, f5, c2, 38, 00] reset_token=[93, 14, 1c, 97, 1f, cb, a4, c0, 04, 92, 6a, ac, d6, 81, f8, f0]
[2025-04-30T10:15:07.209025383Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[1a, 3f, cd, aa, f6, 80, 13, 4f, 9d, 7f, c3, a7, bb, d2, 1a, 4f, a5] reset_token=[1e, b4, c6, 02, 11, 02, 8e, af, 86, c4, ef, 40, 76, e0, 5d, 7d]
[2025-04-30T10:15:07.209032186Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[d9, e8, 59, 14, 98, 96, 66, 64, 29, 30, a8, 5c, 4f, 03, 8f, 70, 25] reset_token=[9c, 7d, 4e, 01, d2, 65, 2f, 6d, 78, e1, 5f, 43, 56, 2c, e4, c8]
[2025-04-30T10:15:07.209039319Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[96, 9c, fe, 4e, 04, b8, d6, 0b, 0e, 11, 92, ea, 3e, d3, 54, 9f, ab] reset_token=[39, 74, 6e, fd, e8, 94, 19, eb, 89, 11, 95, a8, 05, fd, 56, a9]
[2025-04-30T10:15:07.209046232Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[44, 52, 31, 08, 54, 81, a1, db, bd, 24, 30, d8, c5, ce, fb, 4a, 85] reset_token=[6a, d0, 9b, f3, 07, 80, a2, c1, 66, b6, a2, 44, f6, 5e, ce, 1b]
[2025-04-30T10:15:07.209052684Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[17, 05, 7a, 62, a1, 9c, 2c, 92, 47, bd, 32, 1d, ea, 34, 20, 1b, 69] reset_token=[65, d1, c1, 85, 78, b4, a5, 99, 53, 44, 52, 1c, 32, 89, e5, 4c]
[2025-04-30T10:15:07.209059136Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[9c, 4d, df, eb, 31, 65, 1d, 13, a1, 60, 3f, 60, d0, b0, 63, a8, 2f] reset_token=[1a, 88, 02, 0c, 7e, cc, 57, 8f, e8, e0, 78, e1, 33, 40, b3, 16]
[2025-04-30T10:15:07.209064486Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T10:15:07.209072221Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm PADDING len=697
[2025-04-30T10:15:07.209083132Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 processed 1200 bytes
[2025-04-30T10:15:07.209087921Z DEBUG quiche_apps::common] 949318089f2253e6958754bd8b8ea71ab62c2b45 response stream 0 is writable with capacity Ok(13500)
[2025-04-30T10:15:07.209100404Z TRACE quiche_apps::common] 949318089f2253e6958754bd8b8ea71ab62c2b45 received 17 bytes
[2025-04-30T10:15:07.209103630Z TRACE quiche_apps::common] 949318089f2253e6958754bd8b8ea71ab62c2b45 stream 0 has 17 bytes (fin? true)
[2025-04-30T10:15:07.209109321Z INFO  quiche_apps::common] 949318089f2253e6958754bd8b8ea71ab62c2b45 got GET request for "/www/bgcrcexwhd" on stream 0
[2025-04-30T10:15:07.209139166Z INFO  quiche_apps::common] 949318089f2253e6958754bd8b8ea71ab62c2b45 sending response of size 5120 on stream 0
[2025-04-30T10:15:07.209149506Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.209158893Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1303
[2025-04-30T10:15:07.209169674Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Short dcid=f8d923ef9cb52ca43baefe1d235542c852 key_phase=false len=1315 pn=2 
[2025-04-30T10:15:07.209173160Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm ACK delay=18 blocks=[1694514420..1694514420] ecn_counts=None
[2025-04-30T10:15:07.209177378Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[60, 40, c2, 85, 3c, 5d, 21, 1a, 17, e3, c2, b6, 68, f8, f9, b0, 48, fa, bd, 5a] reset_token=[f7, f9, 9a, da, 52, 81, ab, a8, 3a, 0d, fb, bf, dc, d7, 4e, e7]
[2025-04-30T10:15:07.209184501Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[4b, 77, 18, 0d, f1, 77, 50, f6, b9, ad, 5a, bf, a9, 10, 03, a1, bb, 99, e6, 45] reset_token=[7a, 9e, 1e, 3c, d7, 6b, 91, 0b, 9c, 84, a5, 1d, c3, 32, 20, c3]
[2025-04-30T10:15:07.209191154Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c6, 51, 29, 11, 5b, 04, 6d, 05, 69, 30, 29, 8a, e6, fc, 7d, 9c, b5, c9, 85, b4] reset_token=[0d, 6b, e9, 43, 00, 7b, fd, 88, e1, 32, cd, 4b, 2e, ad, 9d, e1]
[2025-04-30T10:15:07.209197996Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[24, 25, ec, b7, 26, 8a, 78, 57, d0, b7, 31, f9, ad, 8e, 19, 59, 7a, 04, 70, a9] reset_token=[4a, c8, f8, 50, 86, 39, 0b, b5, 0a, 15, b2, d2, 55, 93, fe, fd]
[2025-04-30T10:15:07.209204539Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[1c, e5, 13, f9, 7b, 4a, 73, 86, a1, 66, d9, 78, 3c, ae, 55, ad, de, b9, 3b, 3e] reset_token=[b7, f7, cb, 63, e0, 5b, 12, 85, ce, 89, 78, 9f, 61, b4, d2, 7e]
[2025-04-30T10:15:07.209210881Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[f4, 23, 23, 66, 38, 9d, 37, 13, b3, 41, 1d, 6d, 25, 4a, 60, bf, 3f, b4, 93, 20] reset_token=[27, ff, 49, d7, af, fc, ed, 78, 67, f1, 7f, 6b, 81, c5, 22, 0c]
[2025-04-30T10:15:07.209217263Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm HANDSHAKE_DONE
[2025-04-30T10:15:07.209220098Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm CRYPTO off=0 len=396
[2025-04-30T10:15:07.209223033Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm STREAM id=0 off=0 len=657 fin=false
[2025-04-30T10:15:07.209237921Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=111.251811ms latest_rtt=34.574712ms srtt=34.511672ms min_rtt=34.502667ms rttvar=12.95651ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 943, delivered_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27331, is_app_limited: true, interval: 34.502667ms, delivered: 943, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 399451457 }), send_elapsed: 0ns, ack_elapsed: 34.502667ms, rtt: 34.502667ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488965, last_update: Instant { tv_sec: 397, tv_nsec: 434306474 }, next_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, 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-30T10:15:07.209262577Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1315
[2025-04-30T10:15:07.209266896Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Short dcid=f8d923ef9cb52ca43baefe1d235542c852 key_phase=false len=1315 pn=3 
[2025-04-30T10:15:07.209270051Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm STREAM id=0 off=657 len=1309 fin=false
[2025-04-30T10:15:07.209276313Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=111.321492ms latest_rtt=34.574712ms srtt=34.511672ms min_rtt=34.502667ms rttvar=12.95651ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 943, delivered_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27331, is_app_limited: true, interval: 34.502667ms, delivered: 943, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 399451457 }), send_elapsed: 0ns, ack_elapsed: 34.502667ms, rtt: 34.502667ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488965, last_update: Instant { tv_sec: 397, tv_nsec: 434306474 }, next_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, 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-30T10:15:07.209310647Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1315
[2025-04-30T10:15:07.209314885Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Short dcid=f8d923ef9cb52ca43baefe1d235542c852 key_phase=false len=1315 pn=4 
[2025-04-30T10:15:07.209317941Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm STREAM id=0 off=1966 len=1309 fin=false
[2025-04-30T10:15:07.209324373Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=111.321832ms latest_rtt=34.574712ms srtt=34.511672ms min_rtt=34.502667ms rttvar=12.95651ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 943, delivered_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27331, is_app_limited: true, interval: 34.502667ms, delivered: 943, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 399451457 }), send_elapsed: 0ns, ack_elapsed: 34.502667ms, rtt: 34.502667ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488965, last_update: Instant { tv_sec: 397, tv_nsec: 434306474 }, next_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, 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-30T10:15:07.209342537Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1315
[2025-04-30T10:15:07.209347657Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Short dcid=f8d923ef9cb52ca43baefe1d235542c852 key_phase=false len=1315 pn=5 
[2025-04-30T10:15:07.209350622Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm STREAM id=0 off=3275 len=1309 fin=false
[2025-04-30T10:15:07.209356063Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=111.321532ms latest_rtt=34.574712ms srtt=34.511672ms min_rtt=34.502667ms rttvar=12.95651ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 943, delivered_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27331, is_app_limited: true, interval: 34.502667ms, delivered: 943, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 399451457 }), send_elapsed: 0ns, ack_elapsed: 34.502667ms, rtt: 34.502667ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488965, last_update: Instant { tv_sec: 397, tv_nsec: 434306474 }, next_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, 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-30T10:15:07.209368175Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1315
[2025-04-30T10:15:07.209371722Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Short dcid=f8d923ef9cb52ca43baefe1d235542c852 key_phase=false len=542 pn=6 
[2025-04-30T10:15:07.209374687Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm STREAM id=0 off=4584 len=536 fin=true
[2025-04-30T10:15:07.209380548Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=111.323616ms latest_rtt=34.574712ms srtt=34.511672ms min_rtt=34.502667ms rttvar=12.95651ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5977 app_limited=true congestion_recovery_start_time=None Rate { delivered: 943, delivered_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27331, is_app_limited: true, interval: 34.502667ms, delivered: 943, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 399451457 }), send_elapsed: 0ns, ack_elapsed: 34.502667ms, rtt: 34.502667ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488965, last_update: Instant { tv_sec: 397, tv_nsec: 434306474 }, next_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, 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-30T10:15:07.209524668Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 written 5977 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:53756, at: Instant { tv_sec: 397, tv_nsec: 434306474 } })
[2025-04-30T10:15:07.209537743Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.209570163Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.209577176Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.209580252Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.209827686Z TRACE quiche_server] got 1342 bytes from [::ffff:193.167.0.100]:53756 to [::]:443
[2025-04-30T10:15:07.209834538Z TRACE quiche_server] got packet Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false
[2025-04-30T10:15:07.209841431Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false len=1321 pn=1694514421 
[2025-04-30T10:15:07.209864955Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm PING mtu_probe=None
[2025-04-30T10:15:07.209875845Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm PADDING len=1300
[2025-04-30T10:15:07.209883350Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 processed 1342 bytes
[2025-04-30T10:15:07.209888059Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.209893679Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=7523 out_len=1350 left=1303
[2025-04-30T10:15:07.209897095Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx pkt Short dcid=f8d923ef9cb52ca43baefe1d235542c852 key_phase=false len=12 pn=7 
[2025-04-30T10:15:07.209899660Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 tx frm ACK delay=6 blocks=[1694514420..1694514421] ecn_counts=None
[2025-04-30T10:15:07.209906803Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 timer=110.797271ms latest_rtt=34.574712ms srtt=34.511672ms min_rtt=34.502667ms rttvar=12.95651ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5977 app_limited=true congestion_recovery_start_time=None Rate { delivered: 943, delivered_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, end_of_app_limited: 5, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27331, is_app_limited: true, interval: 34.502667ms, delivered: 943, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 399451457 }), send_elapsed: 0ns, ack_elapsed: 34.502667ms, rtt: 34.502667ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488965, last_update: Instant { tv_sec: 397, tv_nsec: 434306474 }, next_time: Instant { tv_sec: 397, tv_nsec: 434306474 }, 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-30T10:15:07.209943873Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 written 47 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:53756, at: Instant { tv_sec: 397, tv_nsec: 434306474 } })
[2025-04-30T10:15:07.209948982Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.209954603Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.209959081Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.209962498Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.242223909Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:53756 to [::]:443
[2025-04-30T10:15:07.242251861Z TRACE quiche_server] got packet Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false
[2025-04-30T10:15:07.242264115Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false len=22 pn=1694514422 
[2025-04-30T10:15:07.242275225Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm ACK delay=5 blocks=[2..3] ecn_counts=None
[2025-04-30T10:15:07.242281677Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 packet newly acked 2
[2025-04-30T10:15:07.242295683Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 packet newly acked 3
[2025-04-30T10:15:07.242319438Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 processed 43 bytes
[2025-04-30T10:15:07.242326361Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.242330379Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.242333144Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.244297497Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:53756 to [::]:443
[2025-04-30T10:15:07.244311253Z TRACE quiche_server] got packet Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false
[2025-04-30T10:15:07.244318456Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false len=22 pn=1694514423 
[2025-04-30T10:15:07.244325119Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm ACK delay=5 blocks=[2..5] ecn_counts=None
[2025-04-30T10:15:07.244329086Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 packet newly acked 4
[2025-04-30T10:15:07.244331791Z TRACE quiche::recovery::congestion::recovery] 949318089f2253e6958754bd8b8ea71ab62c2b45 packet newly acked 5
[2025-04-30T10:15:07.244344264Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 processed 43 bytes
[2025-04-30T10:15:07.244348743Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.244351909Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.244354333Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.244834221Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:53756 to [::]:443
[2025-04-30T10:15:07.244838219Z TRACE quiche_server] got packet Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false
[2025-04-30T10:15:07.244842297Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx pkt Short dcid=949318089f2253e6958754bd8b8ea71ab62c2b45 key_phase=false len=21 pn=1694514424 
[2025-04-30T10:15:07.244866793Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-04-30T10:15:07.244881330Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 processed 42 bytes
[2025-04-30T10:15:07.244885518Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.244887962Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.244890246Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.321592770Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.321617306Z TRACE quiche_server] got packet Initial version=1 dcid=5473b23ec9fafc132b71cd33628c35de9e9a scid=7941d1a4c15830f5407eb53c1f090d9dbb token=
[2025-04-30T10:15:07.321626684Z DEBUG quiche_server] New connection: dcid=5473b23ec9fafc132b71cd33628c35de9e9a scid=691db4f897ff7807fa0afebd82006c956e24416a
[2025-04-30T10:15:07.321784379Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Initial version=1 dcid=5473b23ec9fafc132b71cd33628c35de9e9a scid=7941d1a4c15830f5407eb53c1f090d9dbb token= len=1153 pn=925011599 
[2025-04-30T10:15:07.321806090Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm CRYPTO off=0 len=486
[2025-04-30T10:15:07.321838891Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T10:15:07.321843740Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T10:15:07.321995895Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a write message lvl=Initial len=96
[2025-04-30T10:15:07.322024158Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a set write secret lvl=Handshake
[2025-04-30T10:15:07.322056388Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a write message lvl=Handshake len=158
[2025-04-30T10:15:07.322072108Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a set write secret lvl=OneRTT
[2025-04-30T10:15:07.322079912Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a set read secret lvl=Handshake
[2025-04-30T10:15:07.322095321Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm PADDING len=643
[2025-04-30T10:15:07.322115319Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 1200 bytes
[2025-04-30T10:15:07.322134104Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.322137641Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.322151206Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Initial version=1 dcid=7941d1a4c15830f5407eb53c1f090d9dbb scid=691db4f897ff7807fa0afebd82006c956e24416a len=108 pn=0 
[2025-04-30T10:15:07.322155103Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm ACK delay=48 blocks=[925011599..925011599] ecn_counts=None
[2025-04-30T10:15:07.322160163Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm CRYPTO off=0 len=96
[2025-04-30T10:15:07.322170823Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=998.968561ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=172 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 397, tv_nsec: 547294358 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 547294358 }, 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: 397, tv_nsec: 547294358 }, next_time: Instant { tv_sec: 397, tv_nsec: 547294358 }, 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-30T10:15:07.322195238Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Handshake version=1 dcid=7941d1a4c15830f5407eb53c1f090d9dbb scid=691db4f897ff7807fa0afebd82006c956e24416a len=162 pn=1 
[2025-04-30T10:15:07.322198615Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm CRYPTO off=0 len=158
[2025-04-30T10:15:07.322204956Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=998.935049ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=397 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 397, tv_nsec: 547294358 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 547294358 }, 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: 397, tv_nsec: 547294358 }, next_time: Instant { tv_sec: 397, tv_nsec: 547294358 }, 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-30T10:15:07.322262855Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46210, at: Instant { tv_sec: 397, tv_nsec: 547294358 } })
[2025-04-30T10:15:07.322278113Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.322282572Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.322289084Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.322292631Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.322298151Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.322301768Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.322304703Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.356441888Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.356462306Z TRACE quiche_server] got packet Initial version=1 dcid=691db4f897ff7807fa0afebd82006c956e24416a scid=7941d1a4c15830f5407eb53c1f090d9dbb token=
[2025-04-30T10:15:07.356475190Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Initial version=1 dcid=691db4f897ff7807fa0afebd82006c956e24416a scid=7941d1a4c15830f5407eb53c1f090d9dbb token= len=22 pn=925011600 
[2025-04-30T10:15:07.356486782Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm ACK delay=0 blocks=[0..0] ecn_counts=None
[2025-04-30T10:15:07.356493955Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 0
[2025-04-30T10:15:07.356518391Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Handshake version=1 dcid=691db4f897ff7807fa0afebd82006c956e24416a scid=7941d1a4c15830f5407eb53c1f090d9dbb len=64 pn=925011599 
[2025-04-30T10:15:07.356525324Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm ACK delay=0 blocks=[1..1] ecn_counts=None
[2025-04-30T10:15:07.356528741Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 1
[2025-04-30T10:15:07.356532698Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm CRYPTO off=0 len=36
[2025-04-30T10:15:07.356549580Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a set read secret lvl=OneRTT
[2025-04-30T10:15:07.356583694Z TRACE quiche::tls] 691db4f897ff7807fa0afebd82006c956e24416a write message lvl=OneRTT len=396
[2025-04-30T10:15:07.356593842Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a dropped epoch 1 state
[2025-04-30T10:15:07.356598241Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=None resumed=true TransportParams { original_destination_connection_id: None, max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 25165824, initial_max_stream_data_bidi_local: 16777216, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 16777216, initial_max_streams_bidi: 0, initial_max_streams_uni: 0, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 7, initial_source_connection_id: Some(7941d1a4c15830f5407eb53c1f090d9dbb), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T10:15:07.356620282Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a dropped epoch 0 state
[2025-04-30T10:15:07.356624099Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=996 pn=925011599 
[2025-04-30T10:15:07.356632224Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[a4, 4e, 6e, 9f, 01, 07, 58, 5d, 7e, 34, 71, bf, 4b, 17, 00, ad, 1a] reset_token=[e3, 91, 7e, f0, cd, aa, dc, 8c, 49, 11, aa, fe, 9e, df, e5, 05]
[2025-04-30T10:15:07.356641973Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[b4, 28, 3f, 32, ad, cd, b9, 07, 1b, 36, 33, 21, ec, 7d, 15, ed, 0b] reset_token=[50, 09, 0b, 91, f9, b7, b9, 2b, e8, a4, 9d, 22, 89, f5, d0, a8]
[2025-04-30T10:15:07.356649256Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[3b, 48, c2, 45, 66, cd, 2e, 41, 21, fd, d5, 6f, d5, 8b, 66, b8, 06] reset_token=[74, 7b, 16, 54, 47, b8, ec, d9, 4b, f6, 37, e4, d3, 1d, 92, 68]
[2025-04-30T10:15:07.356664515Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[80, fd, 09, 65, 0b, 0c, 27, c0, a6, cd, dd, 2c, 0d, 42, 02, 4d, 61] reset_token=[64, 6b, 50, ca, 3f, e0, 51, 28, e5, ab, 7d, 56, 90, 9d, ec, bc]
[2025-04-30T10:15:07.356672440Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[f8, c2, d2, 50, 13, 77, 43, ab, 5f, ba, 7e, cb, f1, 22, e2, 53, 81] reset_token=[7e, db, 66, 50, 16, 07, b2, 0c, cf, 7f, 0d, be, 09, 56, 98, d1]
[2025-04-30T10:15:07.356679753Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[9a, 29, 11, 54, 07, b0, d8, 58, a5, 22, ec, 97, 83, 40, 58, ef, 5d] reset_token=[d6, 1e, 22, 0c, 2f, 2f, 43, 02, df, 17, a8, de, 26, e4, 68, 2a]
[2025-04-30T10:15:07.356686877Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[a1, 1f, 39, 01, 7c, 76, b0, f1, 1d, 75, 96, ff, ab, ed, b5, 48, cd] reset_token=[7e, dd, 8f, aa, c5, f7, ee, 35, 9f, f2, 63, 69, b6, ba, 68, 5f]
[2025-04-30T10:15:07.356692407Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T10:15:07.356699821Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm PADDING len=697
[2025-04-30T10:15:07.356710892Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 1200 bytes
[2025-04-30T10:15:07.356715761Z DEBUG quiche_apps::common] 691db4f897ff7807fa0afebd82006c956e24416a response stream 0 is writable with capacity Ok(13500)
[2025-04-30T10:15:07.356723124Z TRACE quiche_apps::common] 691db4f897ff7807fa0afebd82006c956e24416a received 17 bytes
[2025-04-30T10:15:07.356726290Z TRACE quiche_apps::common] 691db4f897ff7807fa0afebd82006c956e24416a stream 0 has 17 bytes (fin? true)
[2025-04-30T10:15:07.356731691Z INFO  quiche_apps::common] 691db4f897ff7807fa0afebd82006c956e24416a got GET request for "/www/manyxawwjd" on stream 0
[2025-04-30T10:15:07.356766145Z INFO  quiche_apps::common] 691db4f897ff7807fa0afebd82006c956e24416a sending response of size 10240 on stream 0
[2025-04-30T10:15:07.356776775Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.356780282Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.356789038Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T10:15:07.356799197Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=2 
[2025-04-30T10:15:07.356802844Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm ACK delay=20 blocks=[925011599..925011599] ecn_counts=None
[2025-04-30T10:15:07.356806691Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[28, 59, 10, a1, 84, f0, 16, 7d, 4b, 3c, c7, 87, 4d, f7, 17, 62, 46, 44, a1, c5] reset_token=[ad, 96, 8b, 8a, c4, e7, 4c, 9a, 53, 6a, 63, ea, c0, e5, cb, 76]
[2025-04-30T10:15:07.356814055Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[43, c8, 3f, d0, 5e, a5, ed, 25, e3, 55, 67, 76, 17, 49, ad, 4b, cf, e2, 70, 13] reset_token=[70, e5, 57, bb, d1, 1c, e7, 1e, 20, fc, 82, fb, 15, da, d6, e3]
[2025-04-30T10:15:07.356821028Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[4b, a0, 6b, 87, de, fc, 54, f5, 39, 90, ca, e3, 79, 14, af, 13, 1f, 63, 6e, b9] reset_token=[89, 64, aa, d3, 0e, d0, a1, fd, 1c, 78, af, 3a, cd, ee, 61, e5]
[2025-04-30T10:15:07.356832990Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[08, f7, c7, cc, d0, 5a, 31, 82, 2b, ba, a9, 44, 25, 4a, 4b, ff, 2e, 83, 9e, fb] reset_token=[6f, 68, e3, b7, 45, 27, e7, 6d, 3a, 78, 36, d6, a8, a3, cc, 36]
[2025-04-30T10:15:07.356840094Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[be, 43, 49, 6d, e8, 46, 52, 63, db, 0a, 7a, a2, 3f, 6c, 8d, d9, 3f, 3a, 7d, 46] reset_token=[bc, f7, 80, 60, 81, 2d, b6, 69, 66, c1, 90, 7a, 82, 9e, a8, c0]
[2025-04-30T10:15:07.356871212Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[8e, 68, b4, 1a, 5a, 7e, 10, 52, 40, a2, fd, 99, 33, 58, 4e, 54, 9d, 43, 08, 24] reset_token=[ae, 44, fc, 81, 73, 5a, 32, ba, f9, 61, 15, 96, 65, 9e, 20, 2e]
[2025-04-30T10:15:07.356879007Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm HANDSHAKE_DONE
[2025-04-30T10:15:07.356881962Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm CRYPTO off=0 len=396
[2025-04-30T10:15:07.356884898Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=0 len=661 fin=false
[2025-04-30T10:15:07.356900026Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.762583ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.356920384Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1315
[2025-04-30T10:15:07.356924902Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=3 
[2025-04-30T10:15:07.356927988Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=661 len=1309 fin=false
[2025-04-30T10:15:07.356934350Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.863351ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.356973433Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1315
[2025-04-30T10:15:07.356977761Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=4 
[2025-04-30T10:15:07.356980797Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=1970 len=1309 fin=false
[2025-04-30T10:15:07.356987219Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.864123ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357001045Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1315
[2025-04-30T10:15:07.357004742Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=5 
[2025-04-30T10:15:07.357007667Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=3279 len=1309 fin=false
[2025-04-30T10:15:07.357013118Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.866277ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357026372Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1315
[2025-04-30T10:15:07.357033396Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=6 
[2025-04-30T10:15:07.357036421Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=4588 len=1309 fin=false
[2025-04-30T10:15:07.357042192Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.8626ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357055677Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=6750 out_len=1350 left=1315
[2025-04-30T10:15:07.357059274Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=7 
[2025-04-30T10:15:07.357062210Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=5897 len=1309 fin=false
[2025-04-30T10:15:07.357067469Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.866608ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357080594Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5400 out_len=1350 left=1315
[2025-04-30T10:15:07.357084160Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=8 
[2025-04-30T10:15:07.357087066Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=7206 len=1309 fin=false
[2025-04-30T10:15:07.357092336Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.866768ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357108867Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4050 out_len=1350 left=1315
[2025-04-30T10:15:07.357112473Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=1315 pn=9 
[2025-04-30T10:15:07.357115379Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=8515 len=1309 fin=false
[2025-04-30T10:15:07.357120659Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.866667ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357133864Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1315
[2025-04-30T10:15:07.357137330Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=422 pn=10 
[2025-04-30T10:15:07.357140276Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm STREAM id=0 off=9824 len=416 fin=true
[2025-04-30T10:15:07.357145726Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.866648ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11257 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357387899Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a written 11257 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46210, at: Instant { tv_sec: 397, tv_nsec: 581936919 } })
[2025-04-30T10:15:07.357399310Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357403008Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357409630Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.357413277Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.357417585Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.357421121Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357424257Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357433364Z TRACE quiche_server] got 1342 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.357438935Z TRACE quiche_server] got packet Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false
[2025-04-30T10:15:07.357447431Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=1321 pn=925011600 
[2025-04-30T10:15:07.357456477Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm PING mtu_probe=None
[2025-04-30T10:15:07.357463781Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm PADDING len=1300
[2025-04-30T10:15:07.357470444Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 1342 bytes
[2025-04-30T10:15:07.357474471Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.357476775Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.357482045Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2243 out_len=1350 left=1307
[2025-04-30T10:15:07.357485221Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx pkt Short dcid=7941d1a4c15830f5407eb53c1f090d9dbb key_phase=false len=8 pn=11 
[2025-04-30T10:15:07.357487686Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a tx frm ACK delay=4 blocks=[925011599..925011600] ecn_counts=None
[2025-04-30T10:15:07.357494408Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a timer=110.517875ms latest_rtt=34.377214ms srtt=34.337177ms min_rtt=34.331459ms rttvar=12.885734ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11257 app_limited=true congestion_recovery_start_time=None Rate { delivered: 397, delivered_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, first_sent_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, end_of_app_limited: 3, last_sent_packet: 11, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11563, is_app_limited: true, interval: 34.331459ms, delivered: 397, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 397, tv_nsec: 547294358 }), send_elapsed: 0ns, ack_elapsed: 34.331459ms, rtt: 34.331459ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491449, last_update: Instant { tv_sec: 397, tv_nsec: 581936919 }, next_time: Instant { tv_sec: 397, tv_nsec: 581936919 }, 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-30T10:15:07.357534343Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a written 43 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46210, at: Instant { tv_sec: 397, tv_nsec: 581936919 } })
[2025-04-30T10:15:07.357539513Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357543540Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357549161Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.357553058Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.357556956Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.357560502Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.357564119Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.389966844Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.389992562Z TRACE quiche_server] got packet Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false
[2025-04-30T10:15:07.390004635Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=22 pn=925011601 
[2025-04-30T10:15:07.390015856Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm ACK delay=5 blocks=[2..3] ecn_counts=None
[2025-04-30T10:15:07.390022158Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 2
[2025-04-30T10:15:07.390026526Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 3
[2025-04-30T10:15:07.390050651Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 43 bytes
[2025-04-30T10:15:07.390057975Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.390060790Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.390064537Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.390066862Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.390069186Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.392028434Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.392036639Z TRACE quiche_server] got packet Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false
[2025-04-30T10:15:07.392041398Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=22 pn=925011602 
[2025-04-30T10:15:07.392046377Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm ACK delay=5 blocks=[2..5] ecn_counts=None
[2025-04-30T10:15:07.392049603Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 4
[2025-04-30T10:15:07.392052128Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 5
[2025-04-30T10:15:07.392060985Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 43 bytes
[2025-04-30T10:15:07.392064572Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.392066906Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.392069441Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.392071785Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.392073799Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.394235306Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.394245956Z TRACE quiche_server] got packet Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false
[2025-04-30T10:15:07.394252989Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=22 pn=925011603 
[2025-04-30T10:15:07.394269550Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm ACK delay=4 blocks=[2..7] ecn_counts=None
[2025-04-30T10:15:07.394274740Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 6
[2025-04-30T10:15:07.394278837Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 7
[2025-04-30T10:15:07.394297412Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 43 bytes
[2025-04-30T10:15:07.394303463Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.394307501Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.394311057Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.394313322Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.394315466Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.396483472Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.396498871Z TRACE quiche_server] got packet Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false
[2025-04-30T10:15:07.396519239Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=22 pn=925011604 
[2025-04-30T10:15:07.396527344Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm ACK delay=4 blocks=[2..9] ecn_counts=None
[2025-04-30T10:15:07.396531221Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 8
[2025-04-30T10:15:07.396533856Z TRACE quiche::recovery::congestion::recovery] 691db4f897ff7807fa0afebd82006c956e24416a packet newly acked 9
[2025-04-30T10:15:07.396546009Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 43 bytes
[2025-04-30T10:15:07.396550968Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.396553463Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.396557581Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.396561308Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.396564654Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.396947809Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:46210 to [::]:443
[2025-04-30T10:15:07.396960683Z TRACE quiche_server] got packet Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false
[2025-04-30T10:15:07.396969029Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx pkt Short dcid=691db4f897ff7807fa0afebd82006c956e24416a key_phase=false len=21 pn=925011605 
[2025-04-30T10:15:07.396976713Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-04-30T10:15:07.396985630Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a processed 42 bytes
[2025-04-30T10:15:07.396990018Z TRACE quiche_server] recv() would block
[2025-04-30T10:15:07.396993986Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.396998174Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.397001600Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.397004836Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.442076010Z TRACE quiche_server] timed out
[2025-04-30T10:15:07.442095446Z TRACE quiche] 949318089f2253e6958754bd8b8ea71ab62c2b45 draining timeout expired
[2025-04-30T10:15:07.442129500Z TRACE quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 done writing
[2025-04-30T10:15:07.442132736Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.442135341Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.442138838Z INFO  quiche_server] 949318089f2253e6958754bd8b8ea71ab62c2b45 connection collected recv=8 sent=8 lost=0 retrans=0 sent_bytes=6967 recv_bytes=3870 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:53756 validation_state=Validated active=true recv=8 sent=8 lost=0 retrans=0 rtt=34.434816ms min_rtt=Some(33.108547ms) rttvar=7.748194ms cwnd=13500 sent_bytes=6967 recv_bytes=3870 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=163099]
[2025-04-30T10:15:07.442175687Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.577346317Z TRACE quiche_server] timed out
[2025-04-30T10:15:07.577387504Z TRACE quiche] 691db4f897ff7807fa0afebd82006c956e24416a draining timeout expired
[2025-04-30T10:15:07.577443849Z TRACE quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a done writing
[2025-04-30T10:15:07.577449580Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:15:07.577455391Z INFO  quiche_server] 691db4f897ff7807fa0afebd82006c956e24416a connection collected recv=10 sent=12 lost=0 retrans=0 sent_bytes=11697 recv_bytes=3956 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:46210 validation_state=Validated active=true recv=10 sent=12 lost=0 retrans=0 rtt=35.337545ms min_rtt=Some(33.218853ms) rttvar=6.169285ms cwnd=13500 sent_bytes=11697 recv_bytes=3956 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=325116]