[2025-04-30T19:38:03.980539568Z INFO  quiche_server] listening on [::]:443
[2025-04-30T19:38:03.980561099Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T19:38:03.980567451Z TRACE quiche_server] GSO detected: false
[2025-04-30T19:38:04.777640087Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:37404 to [::]:443
[2025-04-30T19:38:04.777664352Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T19:38:04.777670935Z WARN  quiche_server] Doing version negotiation
[2025-04-30T19:38:04.777747167Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:37404 to [::]:443
[2025-04-30T19:38:04.777752207Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T19:38:04.777755292Z WARN  quiche_server] Doing version negotiation
[2025-04-30T19:38:04.777781772Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:37404 to [::]:443
[2025-04-30T19:38:04.777787733Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T19:38:04.777792432Z WARN  quiche_server] Doing version negotiation
[2025-04-30T19:38:04.777813702Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:08.761850041Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:08.761883153Z TRACE quiche_server] got packet Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token=
[2025-04-30T19:38:08.761894314Z DEBUG quiche_server] New connection: dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=228865e8f7e57470b5126f924b3ad049ca25ff27
[2025-04-30T19:38:08.762142057Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token= len=1162 pn=0 
[2025-04-30T19:38:08.762157887Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm CRYPTO off=0 len=286
[2025-04-30T19:38:08.762189115Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T19:38:08.762194124Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T19:38:08.762304972Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 write message lvl=Initial len=90
[2025-04-30T19:38:08.762342151Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 set write secret lvl=Handshake
[2025-04-30T19:38:08.762429355Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 write message lvl=Handshake len=725
[2025-04-30T19:38:08.762433262Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 set write secret lvl=OneRTT
[2025-04-30T19:38:08.762443281Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 set read secret lvl=Handshake
[2025-04-30T19:38:08.762467696Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm PADDING len=855
[2025-04-30T19:38:08.762492352Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 1200 bytes
[2025-04-30T19:38:08.762548457Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:08.762576209Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Initial version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=99 pn=0 
[2025-04-30T19:38:08.762581018Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=56 blocks=[0..0] ecn_counts=None
[2025-04-30T19:38:08.762586749Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm CRYPTO off=0 len=90
[2025-04-30T19:38:08.762599002Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=998.960285ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=154 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, 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: 275, tv_nsec: 880059414 }, next_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, 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-30T19:38:08.762640890Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Handshake version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=729 pn=1 
[2025-04-30T19:38:08.762644807Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm CRYPTO off=0 len=725
[2025-04-30T19:38:08.762652372Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=998.907376ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=937 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, 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: 275, tv_nsec: 880059414 }, next_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, 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-30T19:38:08.762713747Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 275, tv_nsec: 880059414 } })
[2025-04-30T19:38:08.762721501Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:08.762727552Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:08.762732402Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:08.762735497Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.057369265Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:09.057394653Z TRACE quiche_server] got packet Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token=
[2025-04-30T19:38:09.057408950Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token= len=1162 pn=1 
[2025-04-30T19:38:09.057420682Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm CRYPTO off=0 len=286
[2025-04-30T19:38:09.057433465Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm PADDING len=855
[2025-04-30T19:38:09.057451399Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 1200 bytes
[2025-04-30T19:38:09.057457360Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.057470755Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Initial version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=5 pn=2 
[2025-04-30T19:38:09.057476125Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=7 blocks=[0..1] ecn_counts=None
[2025-04-30T19:38:09.057490202Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=704.069296ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=937 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, 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: 276, tv_nsec: 174959411 }, next_time: Instant { tv_sec: 276, tv_nsec: 174959411 }, 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-30T19:38:09.057586101Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 276, tv_nsec: 174959411 } })
[2025-04-30T19:38:09.057593946Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.057599336Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.057604025Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:09.057608483Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.058273978Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:09.058284728Z TRACE quiche_server] got packet Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token=
[2025-04-30T19:38:09.058293715Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token= len=1162 pn=2 
[2025-04-30T19:38:09.058302081Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm CRYPTO off=0 len=286
[2025-04-30T19:38:09.058311108Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm PADDING len=855
[2025-04-30T19:38:09.058323571Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 1200 bytes
[2025-04-30T19:38:09.058328620Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.058338329Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Initial version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=5 pn=3 
[2025-04-30T19:38:09.058341825Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=5 blocks=[0..2] ecn_counts=None
[2025-04-30T19:38:09.058350752Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=703.208926ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=937 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, end_of_app_limited: 1, 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: 276, tv_nsec: 175830581 }, next_time: Instant { tv_sec: 276, tv_nsec: 175830581 }, 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-30T19:38:09.058405544Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 276, tv_nsec: 175830581 } })
[2025-04-30T19:38:09.058412548Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.058417547Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.058421775Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:09.058424620Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.658196405Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:09.658228064Z TRACE quiche_server] got packet Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token=
[2025-04-30T19:38:09.658245286Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token= len=1162 pn=3 
[2025-04-30T19:38:09.658260665Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm CRYPTO off=0 len=286
[2025-04-30T19:38:09.658278128Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm PADDING len=855
[2025-04-30T19:38:09.658301612Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 1200 bytes
[2025-04-30T19:38:09.658309747Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.658324194Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Initial version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=5 pn=4 
[2025-04-30T19:38:09.658329624Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=9 blocks=[0..3] ecn_counts=None
[2025-04-30T19:38:09.658343560Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=103.215516ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=937 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, end_of_app_limited: 1, last_sent_packet: 4, 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: 276, tv_nsec: 775813411 }, next_time: Instant { tv_sec: 276, tv_nsec: 775813411 }, 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-30T19:38:09.658406057Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 276, tv_nsec: 775813411 } })
[2025-04-30T19:38:09.658415264Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.658422638Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.658428359Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:09.658432817Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.659111467Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:09.659123630Z TRACE quiche_server] got packet Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token=
[2025-04-30T19:38:09.659131284Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Initial version=1 dcid=e2f86e2cabb9f909a755e1818fd2bd2e1773b5ae scid=f6f54349223290fd token= len=1162 pn=4 
[2025-04-30T19:38:09.659138898Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm CRYPTO off=0 len=286
[2025-04-30T19:38:09.659156802Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm PADDING len=855
[2025-04-30T19:38:09.659166159Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 1200 bytes
[2025-04-30T19:38:09.659170047Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.659177280Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Initial version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=5 pn=5 
[2025-04-30T19:38:09.659180005Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=5 blocks=[0..4] ecn_counts=None
[2025-04-30T19:38:09.659187629Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=102.372219ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=937 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, end_of_app_limited: 1, last_sent_packet: 5, 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: 276, tv_nsec: 776671426 }, next_time: Instant { tv_sec: 276, tv_nsec: 776671426 }, 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-30T19:38:09.659224008Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 276, tv_nsec: 776671426 } })
[2025-04-30T19:38:09.659229087Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.659232884Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.659236260Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:09.659238515Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.762392839Z TRACE quiche_server] timed out
[2025-04-30T19:38:09.762407075Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 loss detection timeout expired
[2025-04-30T19:38:09.762413678Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=998.145719ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=937 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, end_of_app_limited: 1, last_sent_packet: 5, 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: 276, tv_nsec: 776671426 }, next_time: Instant { tv_sec: 276, tv_nsec: 776671426 }, 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-30T19:38:09.762443664Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Initial version=1 dcid=f6f54349223290fd scid=228865e8f7e57470b5126f924b3ad049ca25ff27 len=100 pn=6 
[2025-04-30T19:38:09.762448423Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=12913 blocks=[0..4] ecn_counts=None
[2025-04-30T19:38:09.762461758Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm CRYPTO off=0 len=90
[2025-04-30T19:38:09.762473941Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=998.085717ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1092 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, first_sent_time: Instant { tv_sec: 275, tv_nsec: 880059414 }, end_of_app_limited: 5, last_sent_packet: 6, 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: 276, tv_nsec: 879929113 }, next_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, 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-30T19:38:09.762546957Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 276, tv_nsec: 879929113 } })
[2025-04-30T19:38:09.762555102Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:09.762560983Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:09.762565812Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:09.762568828Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:10.265629383Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:10.265656243Z TRACE quiche_server] got packet Initial version=1 dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 scid=f6f54349223290fd token=
[2025-04-30T19:38:10.265674327Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Initial version=1 dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 scid=f6f54349223290fd token= len=22 pn=5 
[2025-04-30T19:38:10.265693253Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm ACK delay=50 blocks=[0..0] ecn_counts=None
[2025-04-30T19:38:10.265704013Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 packet newly acked 0
[2025-04-30T19:38:10.265752263Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Handshake version=1 dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 scid=f6f54349223290fd len=1103 pn=0 
[2025-04-30T19:38:10.265766941Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm ACK delay=50 blocks=[1..1] ecn_counts=None
[2025-04-30T19:38:10.265773172Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 packet newly acked 1
[2025-04-30T19:38:10.265781167Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm CRYPTO off=0 len=52
[2025-04-30T19:38:10.265809791Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 set read secret lvl=OneRTT
[2025-04-30T19:38:10.265857049Z TRACE quiche::tls] 228865e8f7e57470b5126f924b3ad049ca25ff27 write message lvl=OneRTT len=428
[2025-04-30T19:38:10.265869142Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 dropped epoch 1 state
[2025-04-30T19:38:10.265874492Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 connection established: proto=Ok("hq-interop") cipher=Some(AES256_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: 1472, initial_max_data: 4611686018427387903, initial_max_stream_data_bidi_local: 1250000, initial_max_stream_data_bidi_remote: 1250000, initial_max_stream_data_uni: 1250000, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 5, initial_source_connection_id: Some(f6f54349223290fd), retry_source_connection_id: None, max_datagram_frame_size: Some(65535), unknown_params: None }
[2025-04-30T19:38:10.265901963Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm PADDING len=1026
[2025-04-30T19:38:10.265922021Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 dropped epoch 0 state
[2025-04-30T19:38:10.265925868Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 1200 bytes
[2025-04-30T19:38:10.265946336Z TRACE quiche_server] got 234 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:10.265950965Z TRACE quiche_server] got packet Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false
[2025-04-30T19:38:10.265957637Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false len=213 pn=0 
[2025-04-30T19:38:10.265965943Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[a4, 05, 33, 03, 3f, 75, fe, b3] reset_token=[4b, e4, f4, b9, 59, 87, 61, b5, b3, 0e, 46, 40, 2e, a2, 6c, f9]
[2025-04-30T19:38:10.265975881Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[af, 70, 76, de, c6, 40, c3, b9] reset_token=[08, 48, c0, 8a, 2c, 66, 86, bb, 09, 8f, 23, d4, 1c, 7c, 1a, 83]
[2025-04-30T19:38:10.265982364Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[9c, fa, cc, aa, f2, 81, cb, e4] reset_token=[77, 28, 19, bb, f1, 43, 37, c1, af, a1, 69, 72, de, 48, 1d, 6b]
[2025-04-30T19:38:10.265988866Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[7f, 00, d3, c8, ce, cb, 98, 70] reset_token=[f0, d6, d6, a5, c9, ee, db, 81, 88, 51, 0c, ac, f2, 11, 5d, 12]
[2025-04-30T19:38:10.265998163Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[ce, 29, 11, e3, 02, d2, f3, d8] reset_token=[4e, eb, 40, ba, dc, 62, b1, 08, 78, 74, bf, b8, 02, bf, 2a, ff]
[2025-04-30T19:38:10.266004645Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[91, a4, 78, 5a, e0, 63, 23, 95] reset_token=[21, 4d, 6b, bc, cf, 4a, e6, 16, 8c, a9, 4f, d7, 78, 92, 97, 20]
[2025-04-30T19:38:10.266011067Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[20, fe, 4e, 63, b7, 84, 2c, f9] reset_token=[0a, 7d, c1, 08, db, 84, 15, aa, 3b, eb, 94, a1, e7, f8, 02, 30]
[2025-04-30T19:38:10.266051593Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 234 bytes
[2025-04-30T19:38:10.266058847Z TRACE quiche_server] got 58 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:10.266063044Z TRACE quiche_server] got packet Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false
[2025-04-30T19:38:10.266068354Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false len=37 pn=1 
[2025-04-30T19:38:10.266074196Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T19:38:10.266082721Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 58 bytes
[2025-04-30T19:38:10.266086328Z DEBUG quiche_apps::common] 228865e8f7e57470b5126f924b3ad049ca25ff27 response stream 0 is writable with capacity Ok(13500)
[2025-04-30T19:38:10.266094333Z TRACE quiche_apps::common] 228865e8f7e57470b5126f924b3ad049ca25ff27 received 17 bytes
[2025-04-30T19:38:10.266097749Z TRACE quiche_apps::common] 228865e8f7e57470b5126f924b3ad049ca25ff27 stream 0 has 17 bytes (fin? true)
[2025-04-30T19:38:10.266107307Z INFO  quiche_apps::common] 228865e8f7e57470b5126f924b3ad049ca25ff27 got GET request for "/www/phxjlcaqsr" on stream 0
[2025-04-30T19:38:10.266145128Z INFO  quiche_apps::common] 228865e8f7e57470b5126f924b3ad049ca25ff27 sending response of size 1024 on stream 0
[2025-04-30T19:38:10.266154335Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:10.266164494Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T19:38:10.266176016Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Short dcid=f6f54349223290fd key_phase=false len=1324 pn=7 
[2025-04-30T19:38:10.266179713Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm ACK delay=11 blocks=[0..1] ecn_counts=None
[2025-04-30T19:38:10.266183911Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[0c, 79, ac, 09, d6, 3b, fe, c7, 4e, c3, d3, 88, 1a, 72, 35, e2, ef, 0d, a8, c7] reset_token=[54, 2e, d3, 0b, 88, 34, 74, 7d, 51, f4, 82, bc, 12, cc, c4, 29]
[2025-04-30T19:38:10.266192136Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[3b, da, 33, 1e, d4, 98, d4, 55, 7c, 4e, 0c, f1, 87, 1f, 0c, 03, a4, 4e, 09, 25] reset_token=[fc, 99, d1, 92, a6, 57, 7d, bb, 83, 08, ee, dd, 96, b7, 8f, e9]
[2025-04-30T19:38:10.266199640Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[92, ab, 66, 25, 7a, ca, d3, 8f, 2e, 5b, 44, b5, c9, fa, ae, 6f, 51, 54, a5, 75] reset_token=[c4, f5, 61, cb, fb, ba, 10, 76, aa, 6a, 15, 24, e3, ba, 22, fe]
[2025-04-30T19:38:10.266206703Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[87, bd, be, 6f, 70, 74, 7b, 06, 32, e0, 3f, c8, ac, 1e, 50, 5d, a8, d4, f1, 6d] reset_token=[f2, 21, e9, e3, ce, 16, b2, 7c, f2, cb, e5, 02, 6d, 4e, a4, ca]
[2025-04-30T19:38:10.266213797Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm HANDSHAKE_DONE
[2025-04-30T19:38:10.266216782Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm CRYPTO off=0 len=428
[2025-04-30T19:38:10.266219928Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm STREAM id=0 off=0 len=721 fin=false
[2025-04-30T19:38:10.266235106Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=3.782784574s latest_rtt=1.503190291s srtt=1.503118468s min_rtt=1.503108208s rttvar=563.686098ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 937, delivered_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, first_sent_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 623, is_app_limited: true, interval: 1.503108208s, delivered: 937, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 275, tv_nsec: 880059414 }), send_elapsed: 0ns, ack_elapsed: 1.503108208s, rtt: 1.503108208s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11226, last_update: Instant { tv_sec: 276, tv_nsec: 879929113 }, next_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, 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-30T19:38:10.266257588Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324
[2025-04-30T19:38:10.266262207Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx pkt Short dcid=f6f54349223290fd key_phase=false len=309 pn=8 
[2025-04-30T19:38:10.266270633Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 tx frm STREAM id=0 off=721 len=303 fin=true
[2025-04-30T19:38:10.266277356Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 timer=3.782840598s latest_rtt=1.503190291s srtt=1.503118468s min_rtt=1.503108208s rttvar=563.686098ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1685 app_limited=true congestion_recovery_start_time=None Rate { delivered: 937, delivered_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, first_sent_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 623, is_app_limited: true, interval: 1.503108208s, delivered: 937, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 275, tv_nsec: 880059414 }), send_elapsed: 0ns, ack_elapsed: 1.503108208s, rtt: 1.503108208s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11226, last_update: Instant { tv_sec: 276, tv_nsec: 879929113 }, next_time: Instant { tv_sec: 276, tv_nsec: 879929113 }, 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-30T19:38:10.266358788Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 written 1685 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:43640, at: Instant { tv_sec: 276, tv_nsec: 879929113 } })
[2025-04-30T19:38:10.266366643Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:10.266373105Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:10.266377142Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:10.266382222Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:11.768177408Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:11.768215600Z TRACE quiche_server] got packet Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false
[2025-04-30T19:38:11.768234926Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false len=22 pn=2 
[2025-04-30T19:38:11.768252288Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm ACK delay=11 blocks=[7..7] ecn_counts=None
[2025-04-30T19:38:11.768262577Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 packet newly acked 7
[2025-04-30T19:38:11.768294167Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 43 bytes
[2025-04-30T19:38:11.768304436Z TRACE quiche_server] got 46 bytes from [::ffff:193.167.0.100]:43640 to [::]:443
[2025-04-30T19:38:11.768309075Z TRACE quiche_server] got packet Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false
[2025-04-30T19:38:11.768314665Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx pkt Short dcid=228865e8f7e57470b5126f924b3ad049ca25ff27 key_phase=false len=25 pn=3 
[2025-04-30T19:38:11.768320035Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm ACK delay=15 blocks=[7..8] ecn_counts=None
[2025-04-30T19:38:11.768323672Z TRACE quiche::recovery::congestion::recovery] 228865e8f7e57470b5126f924b3ad049ca25ff27 packet newly acked 8
[2025-04-30T19:38:11.768328100Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 rx frm APPLICATION_CLOSE err=0 reason=[]
[2025-04-30T19:38:11.768340493Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 processed 46 bytes
[2025-04-30T19:38:11.768345823Z TRACE quiche_server] recv() would block
[2025-04-30T19:38:11.768349210Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:11.768352396Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:22.897521357Z TRACE quiche_server] timed out
[2025-04-30T19:38:22.897564337Z TRACE quiche] 228865e8f7e57470b5126f924b3ad049ca25ff27 draining timeout expired
[2025-04-30T19:38:22.897600405Z TRACE quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 done writing
[2025-04-30T19:38:22.897603600Z TRACE quiche_server] Collecting garbage
[2025-04-30T19:38:22.897607077Z INFO  quiche_server] 228865e8f7e57470b5126f924b3ad049ca25ff27 connection collected recv=11 sent=9 lost=0 retrans=1 sent_bytes=3017 recv_bytes=7581 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:43640 validation_state=Validated active=true recv=11 sent=9 lost=0 retrans=1 rtt=1.620920447s min_rtt=Some(1.503108208s) rttvar=521.265222ms cwnd=13500 sent_bytes=3017 recv_bytes=7581 lost_bytes=0 stream_retrans_bytes=90 pmtu=1350 delivery_rate=840]