[2025-04-30T10:14:03.777359001Z INFO  quiche_server] listening on [::]:443
[2025-04-30T10:14:03.777381813Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T10:14:03.777388796Z TRACE quiche_server] GSO detected: false
[2025-04-30T10:14:04.541999608Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:38981 to [::]:443
[2025-04-30T10:14:04.542030085Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:14:04.542038291Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:14:04.542125564Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:38981 to [::]:443
[2025-04-30T10:14:04.542131706Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:14:04.542135523Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:14:04.542170959Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:38981 to [::]:443
[2025-04-30T10:14:04.542188041Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T10:14:04.542192119Z WARN  quiche_server] Doing version negotiation
[2025-04-30T10:14:04.542215142Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:05.606135475Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:46163 to [::]:443
[2025-04-30T10:14:05.606160431Z TRACE quiche_server] got packet Initial version=1 dcid=d90ed2f17821e3040d829e3295214c370f51 scid=8ab4ed1bb87636538016b17e5441c3831a token=
[2025-04-30T10:14:05.606171161Z DEBUG quiche_server] New connection: dcid=d90ed2f17821e3040d829e3295214c370f51 scid=a4b352f73f48e9b64497a549e27d418c7e12e95c
[2025-04-30T10:14:05.606396763Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Initial version=1 dcid=d90ed2f17821e3040d829e3295214c370f51 scid=8ab4ed1bb87636538016b17e5441c3831a token= len=1153 pn=841349228 
[2025-04-30T10:14:05.606411441Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm CRYPTO off=0 len=263
[2025-04-30T10:14:05.606439974Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T10:14:05.606444843Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T10:14:05.606543688Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c write message lvl=Initial len=90
[2025-04-30T10:14:05.606574506Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c set write secret lvl=Handshake
[2025-04-30T10:14:05.606648514Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c write message lvl=Handshake len=706
[2025-04-30T10:14:05.606652101Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c set write secret lvl=OneRTT
[2025-04-30T10:14:05.606659765Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c set read secret lvl=Handshake
[2025-04-30T10:14:05.606680364Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm PADDING len=866
[2025-04-30T10:14:05.606703387Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c processed 1200 bytes
[2025-04-30T10:14:05.606722062Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:05.606735737Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Initial version=1 dcid=8ab4ed1bb87636538016b17e5441c3831a scid=a4b352f73f48e9b64497a549e27d418c7e12e95c len=102 pn=0 
[2025-04-30T10:14:05.606739695Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm ACK delay=44 blocks=[841349228..841349228] ecn_counts=None
[2025-04-30T10:14:05.606744674Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm CRYPTO off=0 len=90
[2025-04-30T10:14:05.606755074Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=998.968902ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=166 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, first_sent_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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: 335, tv_nsec: 831878789 }, next_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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:14:05.606787544Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Handshake version=1 dcid=8ab4ed1bb87636538016b17e5441c3831a scid=a4b352f73f48e9b64497a549e27d418c7e12e95c len=710 pn=1 
[2025-04-30T10:14:05.606791071Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm CRYPTO off=0 len=706
[2025-04-30T10:14:05.606797563Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=998.926953ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=939 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, first_sent_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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: 335, tv_nsec: 831878789 }, next_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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:14:05.606896809Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46163, at: Instant { tv_sec: 335, tv_nsec: 831878789 } })
[2025-04-30T10:14:05.606907228Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:05.606913079Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:05.606918309Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:05.606921244Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:05.900992959Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:46163 to [::]:443
[2025-04-30T10:14:05.901013026Z TRACE quiche_server] got packet Initial version=1 dcid=d90ed2f17821e3040d829e3295214c370f51 scid=8ab4ed1bb87636538016b17e5441c3831a token=
[2025-04-30T10:14:05.901026822Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Initial version=1 dcid=d90ed2f17821e3040d829e3295214c370f51 scid=8ab4ed1bb87636538016b17e5441c3831a token= len=1153 pn=841349229 
[2025-04-30T10:14:05.901038805Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm CRYPTO off=0 len=263
[2025-04-30T10:14:05.901055025Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm PADDING len=866
[2025-04-30T10:14:05.901075934Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c processed 1200 bytes
[2025-04-30T10:14:05.901081675Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:05.901093427Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Initial version=1 dcid=8ab4ed1bb87636538016b17e5441c3831a scid=a4b352f73f48e9b64497a549e27d418c7e12e95c len=8 pn=2 
[2025-04-30T10:14:05.901097304Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm ACK delay=8 blocks=[841349228..841349229] ecn_counts=None
[2025-04-30T10:14:05.901115969Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=704.608177ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=939 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, first_sent_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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: 336, tv_nsec: 126238352 }, next_time: Instant { tv_sec: 336, tv_nsec: 126238352 }, 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:14:05.901179978Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46163, at: Instant { tv_sec: 336, tv_nsec: 126238352 } })
[2025-04-30T10:14:05.901190248Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:05.901197651Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:05.901204564Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:05.901208843Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:06.502060147Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:46163 to [::]:443
[2025-04-30T10:14:06.502094421Z TRACE quiche_server] got packet Initial version=1 dcid=d90ed2f17821e3040d829e3295214c370f51 scid=8ab4ed1bb87636538016b17e5441c3831a token=
[2025-04-30T10:14:06.502110121Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Initial version=1 dcid=d90ed2f17821e3040d829e3295214c370f51 scid=8ab4ed1bb87636538016b17e5441c3831a token= len=1153 pn=841349230 
[2025-04-30T10:14:06.502124097Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm CRYPTO off=0 len=263
[2025-04-30T10:14:06.502149003Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm PADDING len=866
[2025-04-30T10:14:06.502171556Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c processed 1200 bytes
[2025-04-30T10:14:06.502177717Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:06.502190451Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Initial version=1 dcid=8ab4ed1bb87636538016b17e5441c3831a scid=a4b352f73f48e9b64497a549e27d418c7e12e95c len=8 pn=3 
[2025-04-30T10:14:06.502194208Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm ACK delay=10 blocks=[841349228..841349230] ecn_counts=None
[2025-04-30T10:14:06.502206811Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=103.517314ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=939 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, first_sent_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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: 336, tv_nsec: 727334475 }, next_time: Instant { tv_sec: 336, tv_nsec: 727334475 }, 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:14:06.502300226Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46163, at: Instant { tv_sec: 336, tv_nsec: 727334475 } })
[2025-04-30T10:14:06.502311438Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:06.502318861Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:06.502325434Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:06.502330202Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:06.606493169Z TRACE quiche_server] timed out
[2025-04-30T10:14:06.606515862Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c loss detection timeout expired
[2025-04-30T10:14:06.606523416Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=998.200329ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=939 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, first_sent_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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: 336, tv_nsec: 727334475 }, next_time: Instant { tv_sec: 336, tv_nsec: 727334475 }, 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:14:06.606571005Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Initial version=1 dcid=8ab4ed1bb87636538016b17e5441c3831a scid=a4b352f73f48e9b64497a549e27d418c7e12e95c len=103 pn=4 
[2025-04-30T10:14:06.606575503Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm ACK delay=13057 blocks=[841349228..841349230] ecn_counts=None
[2025-04-30T10:14:06.606580994Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm CRYPTO off=0 len=90
[2025-04-30T10:14:06.606599478Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=998.124948ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1106 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, first_sent_time: Instant { tv_sec: 335, tv_nsec: 831878789 }, 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: 336, tv_nsec: 831699550 }, next_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, 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:14:06.606699586Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46163, at: Instant { tv_sec: 336, tv_nsec: 831699550 } })
[2025-04-30T10:14:06.606721497Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:06.606732407Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:06.606738789Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:06.606743237Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:07.111474784Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:46163 to [::]:443
[2025-04-30T10:14:07.111508717Z TRACE quiche_server] got packet Initial version=1 dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c scid=8ab4ed1bb87636538016b17e5441c3831a token=
[2025-04-30T10:14:07.111524567Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Initial version=1 dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c scid=8ab4ed1bb87636538016b17e5441c3831a token= len=22 pn=841349231 
[2025-04-30T10:14:07.111537722Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm ACK delay=0 blocks=[0..0] ecn_counts=None
[2025-04-30T10:14:07.111545296Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c packet newly acked 0
[2025-04-30T10:14:07.111573249Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Handshake version=1 dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c scid=8ab4ed1bb87636538016b17e5441c3831a len=64 pn=841349228 
[2025-04-30T10:14:07.111580131Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm ACK delay=0 blocks=[1..1] ecn_counts=None
[2025-04-30T10:14:07.111583888Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c packet newly acked 1
[2025-04-30T10:14:07.111588076Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm CRYPTO off=0 len=36
[2025-04-30T10:14:07.111607974Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c set read secret lvl=OneRTT
[2025-04-30T10:14:07.111655532Z TRACE quiche::tls] a4b352f73f48e9b64497a549e27d418c7e12e95c write message lvl=OneRTT len=396
[2025-04-30T10:14:07.111666172Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c dropped epoch 1 state
[2025-04-30T10:14:07.111671142Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c 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(8ab4ed1bb87636538016b17e5441c3831a), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T10:14:07.111695187Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c dropped epoch 0 state
[2025-04-30T10:14:07.111698934Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Short dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c key_phase=false len=996 pn=841349228 
[2025-04-30T10:14:07.111707450Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[39, 94, 14, 6d, 04, 0c, 6e, eb, 50, ab, 0b, 3a, d8, 26, 05, 32, 9a] reset_token=[70, 2b, a7, b1, 1e, 73, 57, db, 06, 4f, 33, fa, 5d, d2, bc, 2e]
[2025-04-30T10:14:07.111717218Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[ef, db, 86, 8a, f6, 36, 5c, 41, fc, fd, ea, 2f, 45, e9, af, 8d, ca] reset_token=[0c, bc, 5e, 75, d3, f3, 31, e1, db, 96, 20, 86, a7, 0c, 79, 1a]
[2025-04-30T10:14:07.111724592Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[49, 40, 8f, 7b, 52, fb, 7b, e8, 3a, 90, 54, c6, a7, 39, fc, eb, 9c] reset_token=[19, 26, 1a, 71, 32, 41, 22, bf, 66, 26, b1, 69, 52, ed, 01, 49]
[2025-04-30T10:14:07.111746994Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[17, 5d, 0f, 2a, ff, fd, 1b, 72, 67, 6c, db, 4f, b6, 61, 9c, de, 67] reset_token=[be, 32, 9e, a1, 65, 34, 30, 23, 02, b4, a1, 0a, 3e, f4, 7f, 30]
[2025-04-30T10:14:07.111754959Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[46, 29, ab, 31, 77, cb, 9a, 6a, a1, 04, 14, 7b, 6c, 98, 05, 05, da] reset_token=[77, 67, 28, 11, 62, a9, ee, 7e, 5b, 0e, c6, 9d, 7c, 87, a4, 78]
[2025-04-30T10:14:07.111762743Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[22, 06, e9, 4d, d2, 12, a2, 67, 09, 44, bc, a4, 6c, b7, 29, 04, e4] reset_token=[1e, 4b, ed, 05, 20, 47, a8, 6d, fc, 09, 22, 96, af, 18, de, 3c]
[2025-04-30T10:14:07.111769887Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[4c, 41, c1, ed, 22, fa, e5, 8d, 74, b3, ec, d3, cf, 83, 18, a0, 0b] reset_token=[72, 71, 56, e6, fc, 75, 6d, 25, c8, db, eb, 09, d3, 23, 80, 6e]
[2025-04-30T10:14:07.111775688Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T10:14:07.111783292Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm PADDING len=697
[2025-04-30T10:14:07.111795565Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c processed 1200 bytes
[2025-04-30T10:14:07.111800594Z DEBUG quiche_apps::common] a4b352f73f48e9b64497a549e27d418c7e12e95c response stream 0 is writable with capacity Ok(13500)
[2025-04-30T10:14:07.111808399Z TRACE quiche_apps::common] a4b352f73f48e9b64497a549e27d418c7e12e95c received 17 bytes
[2025-04-30T10:14:07.111811495Z TRACE quiche_apps::common] a4b352f73f48e9b64497a549e27d418c7e12e95c stream 0 has 17 bytes (fin? true)
[2025-04-30T10:14:07.111816935Z INFO  quiche_apps::common] a4b352f73f48e9b64497a549e27d418c7e12e95c got GET request for "/www/btafcumebc" on stream 0
[2025-04-30T10:14:07.111886776Z INFO  quiche_apps::common] a4b352f73f48e9b64497a549e27d418c7e12e95c sending response of size 1024 on stream 0
[2025-04-30T10:14:07.111923865Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:07.111934635Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T10:14:07.111945626Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Short dcid=8ab4ed1bb87636538016b17e5441c3831a key_phase=false len=1315 pn=5 
[2025-04-30T10:14:07.111949233Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm ACK delay=29 blocks=[841349228..841349228] ecn_counts=None
[2025-04-30T10:14:07.111952879Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[6b, 3d, c7, b7, 28, 93, 80, 94, 59, 45, e2, 7b, 9d, 9b, 81, 58, 34, a9, c8, 8c] reset_token=[f3, 89, 89, 8e, 86, f5, 54, 64, 49, 67, 85, 34, de, 41, 10, 03]
[2025-04-30T10:14:07.111959301Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[ff, 72, c9, 30, 10, 99, cb, e4, 0f, 7a, 73, 2a, a0, 6e, 46, 3d, ec, 0c, 77, 52] reset_token=[6c, 82, 37, 3b, e7, 22, d6, 42, 05, 5e, c5, ee, dc, 52, 8e, 20]
[2025-04-30T10:14:07.111965132Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[f5, d5, 59, 6d, ba, b3, 08, b7, 03, 62, 52, 31, 9a, c5, b5, 09, 5d, e9, 61, 9c] reset_token=[cb, 16, d9, b6, 96, 74, 94, f9, da, ae, 03, 39, b7, 7f, 04, 29]
[2025-04-30T10:14:07.111971094Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[17, b4, 37, 0a, 41, d0, 39, ee, b4, d5, ef, 53, c4, a3, 6a, fc, 68, 70, 60, c6] reset_token=[d7, d4, e4, 40, 58, 83, fd, 5f, 80, 3c, 45, e6, 24, 6a, 0c, f6]
[2025-04-30T10:14:07.111977045Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[0e, 0e, 50, d0, 08, 70, 19, 41, 61, cf, 0d, d7, 5a, 18, 79, 57, 1b, 67, 38, a6] reset_token=[f7, 1b, 44, 0a, 71, 8b, a9, 36, 92, d2, 3d, 05, 74, 22, 5e, 0c]
[2025-04-30T10:14:07.111986062Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[02, da, bd, fc, 4d, 5e, 7e, 24, a9, 0e, 83, f9, 93, d0, d0, ce, cf, 93, cd, 41] reset_token=[e8, c1, 78, 27, 94, 6f, 54, c6, cb, 7a, 41, 80, 63, 53, 17, c0]
[2025-04-30T10:14:07.111991822Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm HANDSHAKE_DONE
[2025-04-30T10:14:07.111994077Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm CRYPTO off=0 len=396
[2025-04-30T10:14:07.111996521Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm STREAM id=0 off=0 len=661 fin=false
[2025-04-30T10:14:07.112010447Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=3.786964114s latest_rtt=1.50484749s srtt=1.504802474s min_rtt=1.504796044s rttvar=564.311377ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 939, delivered_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, first_sent_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 624, is_app_limited: true, interval: 1.504796044s, delivered: 939, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 335, tv_nsec: 831878789 }), send_elapsed: 0ns, ack_elapsed: 1.504796044s, rtt: 1.504796044s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11214, last_update: Instant { tv_sec: 336, tv_nsec: 831699550 }, next_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, 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:14:07.112029493Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1315
[2025-04-30T10:14:07.112032819Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Short dcid=8ab4ed1bb87636538016b17e5441c3831a key_phase=false len=369 pn=6 
[2025-04-30T10:14:07.112035283Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm STREAM id=0 off=661 len=363 fin=true
[2025-04-30T10:14:07.112040433Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=3.787034827s latest_rtt=1.50484749s srtt=1.504802474s min_rtt=1.504796044s rttvar=564.311377ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1754 app_limited=true congestion_recovery_start_time=None Rate { delivered: 939, delivered_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, first_sent_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 624, is_app_limited: true, interval: 1.504796044s, delivered: 939, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 335, tv_nsec: 831878789 }), send_elapsed: 0ns, ack_elapsed: 1.504796044s, rtt: 1.504796044s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11214, last_update: Instant { tv_sec: 336, tv_nsec: 831699550 }, next_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, 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:14:07.112121014Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c written 1754 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46163, at: Instant { tv_sec: 336, tv_nsec: 831699550 } })
[2025-04-30T10:14:07.112135992Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:07.112143025Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:07.112147373Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:07.112150009Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:07.112442626Z TRACE quiche_server] got 1342 bytes from [::ffff:193.167.0.100]:46163 to [::]:443
[2025-04-30T10:14:07.112451463Z TRACE quiche_server] got packet Short dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c key_phase=false
[2025-04-30T10:14:07.112458125Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Short dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c key_phase=false len=1321 pn=841349229 
[2025-04-30T10:14:07.112464387Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm PING mtu_probe=None
[2025-04-30T10:14:07.112470729Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm PADDING len=1300
[2025-04-30T10:14:07.112477792Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c processed 1342 bytes
[2025-04-30T10:14:07.112486799Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:07.112498551Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c pmtud probe status false hs_con=true hs_sent=true cwnd_avail=11746 out_len=1350 left=1307
[2025-04-30T10:14:07.112502128Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx pkt Short dcid=8ab4ed1bb87636538016b17e5441c3831a key_phase=false len=8 pn=7 
[2025-04-30T10:14:07.112504642Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c tx frm ACK delay=5 blocks=[841349228..841349229] ecn_counts=None
[2025-04-30T10:14:07.112511656Z TRACE quiche::recovery::congestion::recovery] a4b352f73f48e9b64497a549e27d418c7e12e95c timer=3.786563494s latest_rtt=1.50484749s srtt=1.504802474s min_rtt=1.504796044s rttvar=564.311377ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1754 app_limited=true congestion_recovery_start_time=None Rate { delivered: 939, delivered_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, first_sent_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, end_of_app_limited: 5, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 624, is_app_limited: true, interval: 1.504796044s, delivered: 939, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 335, tv_nsec: 831878789 }), send_elapsed: 0ns, ack_elapsed: 1.504796044s, rtt: 1.504796044s } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 11214, last_update: Instant { tv_sec: 336, tv_nsec: 831699550 }, next_time: Instant { tv_sec: 336, tv_nsec: 831699550 }, 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:14:07.112555869Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c written 43 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:46163, at: Instant { tv_sec: 336, tv_nsec: 831699550 } })
[2025-04-30T10:14:07.112563933Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:07.112570195Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:07.112574834Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:07.112578360Z TRACE quiche_server] Collecting garbage
[2025-04-30T10:14:08.614517749Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:46163 to [::]:443
[2025-04-30T10:14:08.614555991Z TRACE quiche_server] got packet Short dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c key_phase=false
[2025-04-30T10:14:08.614572502Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx pkt Short dcid=a4b352f73f48e9b64497a549e27d418c7e12e95c key_phase=false len=21 pn=841349230 
[2025-04-30T10:14:08.614599683Z TRACE quiche] a4b352f73f48e9b64497a549e27d418c7e12e95c rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-04-30T10:14:08.614617356Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c processed 42 bytes
[2025-04-30T10:14:08.614624649Z TRACE quiche_server] recv() would block
[2025-04-30T10:14:08.614627826Z TRACE quiche_server] a4b352f73f48e9b64497a549e27d418c7e12e95c done writing
[2025-04-30T10:14:08.614630911Z TRACE quiche_server] Collecting garbage