[2025-04-30T10:16:53.825136041Z INFO  quiche_server] listening on [::]:443
[2025-04-30T10:16:53.825157501Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T10:16:53.825163332Z TRACE quiche_server] GSO detected: false
[2025-04-30T10:16:54.654058567Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:51020 to [::]:443
[2025-04-30T10:16:54.654092992Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:16:54.654100656Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:16:54.654203328Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:51020 to [::]:443
[2025-04-30T10:16:54.654212996Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:16:54.654218547Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:16:54.654250156Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:51020 to [::]:443
[2025-04-30T10:16:54.654256778Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:16:54.654261968Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:16:54.654289009Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:54.922007415Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:54.922028064Z TRACE quiche_server] got packet Initial version=1 dcid=f50a7070a662dca0a7c175e15e1888164be0 scid=d57e6f0236068aff890d5bece93dfc494d token=
[2025-04-30T10:16:54.922037351Z DEBUG quiche_server] New connection: dcid=f50a7070a662dca0a7c175e15e1888164be0 scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2
[2025-04-30T10:16:54.922207169Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Initial version=1 dcid=f50a7070a662dca0a7c175e15e1888164be0 scid=d57e6f0236068aff890d5bece93dfc494d token= len=1153 pn=1416047475 
[2025-04-30T10:16:54.922220214Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm CRYPTO off=0 len=263
[2025-04-30T10:16:54.922245250Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T10:16:54.922249248Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T10:16:54.922330350Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 write message lvl=Initial len=90
[2025-04-30T10:16:54.922355687Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 set write secret lvl=Handshake
[2025-04-30T10:16:54.922443662Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 write message lvl=Handshake len=9950
[2025-04-30T10:16:54.922447770Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 set write secret lvl=OneRTT
[2025-04-30T10:16:54.922454312Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 set read secret lvl=Handshake
[2025-04-30T10:16:54.922471093Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm PADDING len=866
[2025-04-30T10:16:54.922491061Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 1200 bytes
[2025-04-30T10:16:54.922506410Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:54.922518602Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Initial version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=106 pn=0 
[2025-04-30T10:16:54.922521979Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm ACK delay=40 blocks=[1416047475..1416047475] ecn_counts=None
[2025-04-30T10:16:54.922526487Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=0 len=90
[2025-04-30T10:16:54.922535444Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=998.972679ms 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: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, 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: 505, tv_nsec: 147662636 }, next_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, 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:16:54.922563997Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=967 pn=1 
[2025-04-30T10:16:54.922566923Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=0 len=963
[2025-04-30T10:16:54.922572543Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=998.93588ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1200 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, 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: 505, tv_nsec: 147662636 }, next_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, 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:16:54.922620944Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 505, tv_nsec: 147662636 } })
[2025-04-30T10:16:54.922629951Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:54.922636583Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:54.922650459Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=2 
[2025-04-30T10:16:54.922654457Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=963 len=1132
[2025-04-30T10:16:54.922661630Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=998.846773ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, 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: 505, tv_nsec: 147794152 }, next_time: Instant { tv_sec: 505, tv_nsec: 147794152 }, 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:16:54.922701865Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 505, tv_nsec: 147794152 } })
[2025-04-30T10:16:54.922709550Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:54.922714960Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:54.922727954Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=3 
[2025-04-30T10:16:54.922732733Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=2095 len=1132
[2025-04-30T10:16:54.922739876Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=998.768507ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3600 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 505, tv_nsec: 147872459 }, next_time: Instant { tv_sec: 505, tv_nsec: 147872459 }, 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:16:54.922772909Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 505, tv_nsec: 147872459 } })
[2025-04-30T10:16:54.922780623Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:54.922786233Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:54.922791513Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:54.922794960Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:55.922879534Z TRACE quiche_server] timed out
[2025-04-30T10:16:55.922907145Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 loss detection timeout expired
[2025-04-30T10:16:55.922914719Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=997.592842ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3600 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 505, tv_nsec: 147872459 }, next_time: Instant { tv_sec: 505, tv_nsec: 147872459 }, 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:16:55.922945597Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:55.922963571Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689082583Z TRACE quiche_server] got 69 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.689105086Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.689120905Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=21 pn=1416047481 
[2025-04-30T10:16:56.689133469Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm PING mtu_probe=None
[2025-04-30T10:16:56.689159547Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 dropped epoch 0 state
[2025-04-30T10:16:56.689163545Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 69 bytes
[2025-04-30T10:16:56.689170227Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689200394Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=4 
[2025-04-30T10:16:56.689204552Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm ACK delay=9 blocks=[1416047481..1416047481] ecn_counts=None
[2025-04-30T10:16:56.689210443Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=3227 len=1120
[2025-04-30T10:16:56.689222596Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=1.997950117s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4630 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 3, 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: 506, tv_nsec: 914327346 }, next_time: Instant { tv_sec: 506, tv_nsec: 914327346 }, 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:16:56.689285774Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 914327346 } })
[2025-04-30T10:16:56.689297456Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689304719Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689321361Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=5 
[2025-04-30T10:16:56.689326560Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=4347 len=1132
[2025-04-30T10:16:56.689339675Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=1.997968802s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5830 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 4, 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: 506, tv_nsec: 914463010 }, next_time: Instant { tv_sec: 506, tv_nsec: 914463010 }, 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:16:56.689394558Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 914463010 } })
[2025-04-30T10:16:56.689404436Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689411439Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689428110Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=6 
[2025-04-30T10:16:56.689433460Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=5479 len=1132
[2025-04-30T10:16:56.689441946Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=1.997973481s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7030 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, 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: 506, tv_nsec: 914569720 }, next_time: Instant { tv_sec: 506, tv_nsec: 914569720 }, 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:16:56.689482663Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 914569720 } })
[2025-04-30T10:16:56.689491409Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689498873Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689515033Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=7 
[2025-04-30T10:16:56.689520093Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=6611 len=1132
[2025-04-30T10:16:56.689528418Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=1.997974573s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8230 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 6, last_sent_packet: 7, 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: 506, tv_nsec: 914657344 }, next_time: Instant { tv_sec: 506, tv_nsec: 914657344 }, 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:16:56.689590244Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 914657344 } })
[2025-04-30T10:16:56.689599471Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689605873Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689622444Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1137 pn=8 
[2025-04-30T10:16:56.689628175Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=7743 len=1132
[2025-04-30T10:16:56.689636551Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=1.99797353s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9430 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 7, last_sent_packet: 8, 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: 506, tv_nsec: 914764474 }, next_time: Instant { tv_sec: 506, tv_nsec: 914764474 }, 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:16:56.689677127Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 914764474 } })
[2025-04-30T10:16:56.689686304Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689693277Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689710128Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Handshake version=1 dcid=d57e6f0236068aff890d5bece93dfc494d scid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 len=1080 pn=9 
[2025-04-30T10:16:56.689714947Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=8875 len=1075
[2025-04-30T10:16:56.689723583Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=1.9979736s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10573 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, first_sent_time: Instant { tv_sec: 505, tv_nsec: 147662636 }, end_of_app_limited: 8, last_sent_packet: 9, 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: 506, tv_nsec: 914851537 }, next_time: Instant { tv_sec: 506, tv_nsec: 914851537 }, 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:16:56.689770882Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 1143 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 914851537 } })
[2025-04-30T10:16:56.689779939Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.689786952Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.689793765Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.689798193Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.720948964Z TRACE quiche_server] got 70 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.720961087Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.720970425Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=22 pn=1416047482 
[2025-04-30T10:16:56.720978640Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=0 blocks=[1..4] ecn_counts=None
[2025-04-30T10:16:56.720983880Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 1
[2025-04-30T10:16:56.720987577Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 2
[2025-04-30T10:16:56.720990322Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 3
[2025-04-30T10:16:56.720993007Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 4
[2025-04-30T10:16:56.721010940Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 70 bytes
[2025-04-30T10:16:56.721016581Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.721022221Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.721025237Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.721784228Z TRACE quiche_server] got 70 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.721789248Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.721795629Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=22 pn=1416047483 
[2025-04-30T10:16:56.721801781Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=0 blocks=[1..5] ecn_counts=None
[2025-04-30T10:16:56.721805608Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 5
[2025-04-30T10:16:56.721817120Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 70 bytes
[2025-04-30T10:16:56.721821328Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.721825165Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.721827930Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.722727835Z TRACE quiche_server] got 70 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.722733776Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.722738715Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=22 pn=1416047484 
[2025-04-30T10:16:56.722743263Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=0 blocks=[1..6] ecn_counts=None
[2025-04-30T10:16:56.722746129Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 6
[2025-04-30T10:16:56.722760696Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 70 bytes
[2025-04-30T10:16:56.722764273Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.722767609Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.722769883Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.723704293Z TRACE quiche_server] got 70 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.723710003Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.723714882Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=22 pn=1416047485 
[2025-04-30T10:16:56.723719391Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=0 blocks=[1..7] ecn_counts=None
[2025-04-30T10:16:56.723722276Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 7
[2025-04-30T10:16:56.723750168Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 70 bytes
[2025-04-30T10:16:56.723753886Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.723757141Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.723759426Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.724688275Z TRACE quiche_server] got 70 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.724694066Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.724699195Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=22 pn=1416047486 
[2025-04-30T10:16:56.724704105Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=0 blocks=[1..8] ecn_counts=None
[2025-04-30T10:16:56.724706990Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 8
[2025-04-30T10:16:56.724715516Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 70 bytes
[2025-04-30T10:16:56.724718902Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.724721798Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.724724052Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.727262634Z TRACE quiche_server] got 429 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.727269377Z TRACE quiche_server] got packet Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d
[2025-04-30T10:16:56.727275378Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Handshake version=1 dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 scid=d57e6f0236068aff890d5bece93dfc494d len=61 pn=1416047487 
[2025-04-30T10:16:56.727281259Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=0 blocks=[1..9] ecn_counts=None
[2025-04-30T10:16:56.727284766Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 9
[2025-04-30T10:16:56.727288613Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm CRYPTO off=0 len=36
[2025-04-30T10:16:56.727304292Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 set read secret lvl=OneRTT
[2025-04-30T10:16:56.727342003Z TRACE quiche::tls] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 write message lvl=OneRTT len=396
[2025-04-30T10:16:56.727350719Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 dropped epoch 1 state
[2025-04-30T10:16:56.727354927Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 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(d57e6f0236068aff890d5bece93dfc494d), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T10:16:56.727382920Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false len=299 pn=1416047475 
[2025-04-30T10:16:56.727390423Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[1f, dd, 2b, 67, b8, cb, e9, 31, 15, b8, 0e, ad, 0f, e0, bf, 1f, 7f] reset_token=[8f, f0, 1f, c4, e2, b8, 98, 6a, 8b, b4, c1, 70, 42, cc, fb, 4c]
[2025-04-30T10:16:56.727398970Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[91, c1, bd, c3, 67, 7e, 32, 06, 63, 57, e0, 35, 59, 49, d1, ed, 63] reset_token=[26, fc, eb, bf, 16, ac, d6, 38, 1d, 00, 5d, 8b, 95, 7b, 66, f8]
[2025-04-30T10:16:56.727405582Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[de, 51, fc, 27, 6c, e1, f1, 53, dc, c6, 50, c0, bb, 1d, 1a, 9a, 9f] reset_token=[8b, 93, d3, 64, c5, 93, 09, 91, 1a, 7e, 63, 9f, 60, 05, 93, 20]
[2025-04-30T10:16:56.727411814Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[7c, 5b, 27, df, aa, 00, 61, 3c, b9, 03, c4, cd, b2, c6, 0f, 42, 8a] reset_token=[ea, e0, 6d, de, 3f, 5c, 7c, 31, c3, 4f, be, 87, d4, e8, fb, cf]
[2025-04-30T10:16:56.727419057Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[dc, ec, 56, 88, be, db, 60, bc, 0e, 51, 67, dd, c0, 2f, f1, ae, c5] reset_token=[8a, 8b, 80, 17, 63, f7, 4f, 0d, 32, f0, d5, ef, bd, 40, 46, 0b]
[2025-04-30T10:16:56.727425429Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[53, ab, 81, 94, 28, 83, 96, aa, eb, ea, 07, 8c, d8, 94, c7, cd, 6a] reset_token=[b8, ed, 1d, 0b, 08, 18, 5a, f2, 56, fd, 06, 0d, 0b, 74, b9, 3c]
[2025-04-30T10:16:56.727432182Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[8c, 7e, f6, e6, 00, 5c, ac, 88, d2, d6, cd, a2, 28, 40, 48, 33, 4c] reset_token=[42, dd, 4e, 42, a2, 47, 78, 9f, 98, 86, 0a, ba, c1, c7, 4e, dd]
[2025-04-30T10:16:56.727437402Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T10:16:56.727449184Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 429 bytes
[2025-04-30T10:16:56.727453311Z DEBUG quiche_apps::common] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 response stream 0 is writable with capacity Ok(13500)
[2025-04-30T10:16:56.727460495Z TRACE quiche_apps::common] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 received 17 bytes
[2025-04-30T10:16:56.727463591Z TRACE quiche_apps::common] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 stream 0 has 17 bytes (fin? true)
[2025-04-30T10:16:56.727468950Z INFO  quiche_apps::common] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 got GET request for "/www/cifjvqvmkt" on stream 0
[2025-04-30T10:16:56.727493296Z INFO  quiche_apps::common] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 sending response of size 5120 on stream 0
[2025-04-30T10:16:56.727501882Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.727509917Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1303
[2025-04-30T10:16:56.727523513Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Short dcid=d57e6f0236068aff890d5bece93dfc494d key_phase=false len=1315 pn=10 
[2025-04-30T10:16:56.727527280Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm ACK delay=15 blocks=[1416047475..1416047475] ecn_counts=None
[2025-04-30T10:16:56.727531277Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[95, 61, a7, 04, c8, 1c, 3e, e3, 40, 89, ed, e7, 71, 1c, fd, da, bb, ee, aa, 17] reset_token=[7f, 36, 49, 6f, 20, 79, 99, 36, d8, 8e, 22, 23, 17, bb, e7, ff]
[2025-04-30T10:16:56.727537810Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[b7, 7c, 14, 21, 48, f5, 85, 4c, 91, d5, 1c, 87, f3, 6c, c8, bb, 8d, 9b, 6c, ca] reset_token=[0e, 1f, 5b, a6, 5c, e3, e1, d3, b5, 53, 45, b0, b7, 62, c8, 3d]
[2025-04-30T10:16:56.727544031Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c4, 95, 54, ef, e1, 3e, ee, 1b, fc, c7, 02, 24, aa, aa, 02, 2c, 8a, fa, ce, 91] reset_token=[3a, e4, 0f, 6a, 1c, e6, a7, 62, e9, e5, f4, 55, 8d, ac, 9d, 19]
[2025-04-30T10:16:56.727550223Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[17, d7, bd, 29, 0c, d9, a5, f1, 72, 79, 79, c2, 5c, da, de, 4f, d4, 9d, a1, 2c] reset_token=[3d, 86, 53, a8, e4, 2f, 1a, b7, 1f, 99, ac, 3a, 99, bb, f2, 35]
[2025-04-30T10:16:56.727556304Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[83, 4e, cc, 3f, 21, 75, 4a, 32, fa, c0, 10, d6, 8f, 17, 85, fc, 45, 9f, 87, 36] reset_token=[f6, da, b6, 96, 91, 7c, a3, 69, d9, 9e, 22, a2, 44, e0, 13, 07]
[2025-04-30T10:16:56.727562345Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[7b, b7, 31, 10, f1, 81, 12, 3e, a7, eb, f3, 3c, f9, 42, 5e, ec, 31, 35, bd, 9a] reset_token=[a6, 7c, ee, bc, 2c, e1, 34, b9, e8, 6d, be, 33, ed, 14, 6d, 58]
[2025-04-30T10:16:56.727568316Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm HANDSHAKE_DONE
[2025-04-30T10:16:56.727571142Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm CRYPTO off=0 len=396
[2025-04-30T10:16:56.727574138Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm STREAM id=0 off=0 len=657 fin=false
[2025-04-30T10:16:56.727587923Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=82.299513ms latest_rtt=37.577002ms srtt=33.287834ms min_rtt=31.795428ms rttvar=6.023854ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10573, delivered_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, first_sent_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 9, rate_sample: RateSample { delivery_rate: 5878, is_app_limited: true, interval: 1.798460138s, delivered: 10573, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 505, tv_nsec: 147662636 }), send_elapsed: 0ns, ack_elapsed: 1.798460138s, rtt: 1.798460138s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506941, last_update: Instant { tv_sec: 506, tv_nsec: 952658600 }, next_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, 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:16:56.727606107Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1315
[2025-04-30T10:16:56.727614333Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Short dcid=d57e6f0236068aff890d5bece93dfc494d key_phase=false len=1315 pn=11 
[2025-04-30T10:16:56.727617539Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm STREAM id=0 off=657 len=1309 fin=false
[2025-04-30T10:16:56.727623880Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=82.362801ms latest_rtt=37.577002ms srtt=33.287834ms min_rtt=31.795428ms rttvar=6.023854ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10573, delivered_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, first_sent_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, end_of_app_limited: 10, last_sent_packet: 11, largest_acked: 9, rate_sample: RateSample { delivery_rate: 5878, is_app_limited: true, interval: 1.798460138s, delivered: 10573, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 505, tv_nsec: 147662636 }), send_elapsed: 0ns, ack_elapsed: 1.798460138s, rtt: 1.798460138s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506941, last_update: Instant { tv_sec: 506, tv_nsec: 952658600 }, next_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, 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:16:56.727637156Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1315
[2025-04-30T10:16:56.727640812Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Short dcid=d57e6f0236068aff890d5bece93dfc494d key_phase=false len=1315 pn=12 
[2025-04-30T10:16:56.727643748Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm STREAM id=0 off=1966 len=1309 fin=false
[2025-04-30T10:16:56.727648998Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=82.369434ms latest_rtt=37.577002ms srtt=33.287834ms min_rtt=31.795428ms rttvar=6.023854ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10573, delivered_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, first_sent_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, end_of_app_limited: 11, last_sent_packet: 12, largest_acked: 9, rate_sample: RateSample { delivery_rate: 5878, is_app_limited: true, interval: 1.798460138s, delivered: 10573, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 505, tv_nsec: 147662636 }), send_elapsed: 0ns, ack_elapsed: 1.798460138s, rtt: 1.798460138s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506941, last_update: Instant { tv_sec: 506, tv_nsec: 952658600 }, next_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, 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:16:56.727660820Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1315
[2025-04-30T10:16:56.727664456Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Short dcid=d57e6f0236068aff890d5bece93dfc494d key_phase=false len=1315 pn=13 
[2025-04-30T10:16:56.727667392Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm STREAM id=0 off=3275 len=1309 fin=false
[2025-04-30T10:16:56.727672492Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=82.369916ms latest_rtt=37.577002ms srtt=33.287834ms min_rtt=31.795428ms rttvar=6.023854ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10573, delivered_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, first_sent_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, end_of_app_limited: 12, last_sent_packet: 13, largest_acked: 9, rate_sample: RateSample { delivery_rate: 5878, is_app_limited: true, interval: 1.798460138s, delivered: 10573, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 505, tv_nsec: 147662636 }), send_elapsed: 0ns, ack_elapsed: 1.798460138s, rtt: 1.798460138s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506941, last_update: Instant { tv_sec: 506, tv_nsec: 952658600 }, next_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, 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:16:56.727687209Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1315
[2025-04-30T10:16:56.727690826Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Short dcid=d57e6f0236068aff890d5bece93dfc494d key_phase=false len=542 pn=14 
[2025-04-30T10:16:56.727693751Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm STREAM id=0 off=4584 len=536 fin=true
[2025-04-30T10:16:56.727699242Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=82.369534ms latest_rtt=37.577002ms srtt=33.287834ms min_rtt=31.795428ms rttvar=6.023854ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5977 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10573, delivered_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, first_sent_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, end_of_app_limited: 13, last_sent_packet: 14, largest_acked: 9, rate_sample: RateSample { delivery_rate: 5878, is_app_limited: true, interval: 1.798460138s, delivered: 10573, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 505, tv_nsec: 147662636 }), send_elapsed: 0ns, ack_elapsed: 1.798460138s, rtt: 1.798460138s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506941, last_update: Instant { tv_sec: 506, tv_nsec: 952658600 }, next_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, 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:16:56.727835667Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 5977 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 952658600 } })
[2025-04-30T10:16:56.727868429Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.727881172Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.727887524Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.727891091Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.728351854Z TRACE quiche_server] got 1342 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.728356182Z TRACE quiche_server] got packet Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false
[2025-04-30T10:16:56.728361872Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false len=1321 pn=1416047476 
[2025-04-30T10:16:56.728367433Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm PING mtu_probe=None
[2025-04-30T10:16:56.728378463Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm PADDING len=1300
[2025-04-30T10:16:56.728384965Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 1342 bytes
[2025-04-30T10:16:56.728388853Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.728394033Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=7523 out_len=1350 left=1303
[2025-04-30T10:16:56.728397158Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx pkt Short dcid=d57e6f0236068aff890d5bece93dfc494d key_phase=false len=12 pn=15 
[2025-04-30T10:16:56.728399613Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 tx frm ACK delay=4 blocks=[1416047475..1416047476] ecn_counts=None
[2025-04-30T10:16:56.728406085Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 timer=81.662621ms latest_rtt=37.577002ms srtt=33.287834ms min_rtt=31.795428ms rttvar=6.023854ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5977 app_limited=true congestion_recovery_start_time=None Rate { delivered: 10573, delivered_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, first_sent_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, end_of_app_limited: 13, last_sent_packet: 15, largest_acked: 9, rate_sample: RateSample { delivery_rate: 5878, is_app_limited: true, interval: 1.798460138s, delivered: 10573, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 505, tv_nsec: 147662636 }), send_elapsed: 0ns, ack_elapsed: 1.798460138s, rtt: 1.798460138s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 506941, last_update: Instant { tv_sec: 506, tv_nsec: 952658600 }, next_time: Instant { tv_sec: 506, tv_nsec: 952658600 }, 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:16:56.728442954Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 written 47 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:44945, at: Instant { tv_sec: 506, tv_nsec: 952658600 } })
[2025-04-30T10:16:56.728450578Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.728456129Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.728460818Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.728464084Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.760464633Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.760482566Z TRACE quiche_server] got packet Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false
[2025-04-30T10:16:56.760492575Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false len=22 pn=1416047477 
[2025-04-30T10:16:56.760502624Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=6 blocks=[10..11] ecn_counts=None
[2025-04-30T10:16:56.760509486Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 10
[2025-04-30T10:16:56.760515428Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 11
[2025-04-30T10:16:56.760551936Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 43 bytes
[2025-04-30T10:16:56.760557837Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.760561133Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.760563648Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.762774675Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.762789513Z TRACE quiche_server] got packet Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false
[2025-04-30T10:16:56.762806024Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false len=22 pn=1416047478 
[2025-04-30T10:16:56.762814940Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm ACK delay=5 blocks=[10..13] ecn_counts=None
[2025-04-30T10:16:56.762820711Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 12
[2025-04-30T10:16:56.762824558Z TRACE quiche::recovery::congestion::recovery] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 packet newly acked 13
[2025-04-30T10:16:56.762842332Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 43 bytes
[2025-04-30T10:16:56.762861457Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.762869192Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.762872638Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.763139415Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:44945 to [::]:443
[2025-04-30T10:16:56.763148142Z TRACE quiche_server] got packet Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false
[2025-04-30T10:16:56.763156206Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx pkt Short dcid=5ecf7e71c8c861fd06df78454adbe399cee6a7e2 key_phase=false len=21 pn=1416047479 
[2025-04-30T10:16:56.763164432Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-04-30T10:16:56.763175473Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 processed 42 bytes
[2025-04-30T10:16:56.763186433Z TRACE quiche_server] recv() would block
[2025-04-30T10:16:56.763189629Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.763193216Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.911374187Z TRACE quiche_server] timed out
[2025-04-30T10:16:56.911400716Z TRACE quiche] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 draining timeout expired
[2025-04-30T10:16:56.911438006Z TRACE quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 done writing
[2025-04-30T10:16:56.911443817Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:16:56.911449227Z INFO  quiche_server] 5ecf7e71c8c861fd06df78454adbe399cee6a7e2 connection collected recv=13 sent=16 lost=0 retrans=0 sent_bytes=16767 recv_bytes=3518 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:44945 validation_state=Validated active=true recv=13 sent=16 lost=0 retrans=0 rtt=33.496087ms min_rtt=Some(31.795428ms) rttvar=3.957949ms cwnd=13500 sent_bytes=16767 recv_bytes=3518 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=163705]