[2025-04-30T18:35:52.406260258Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T18:35:52.406647032Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:60413 with scid 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f
[2025-04-30T18:35:52.406691205Z TRACE quiche::tls] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f write message lvl=Initial len=266
[2025-04-30T18:35:52.406716733Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Initial version=1 dcid=e764280971cccd57058b2a599b9fb9aa scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=270 pn=0 
[2025-04-30T18:35:52.406721842Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm CRYPTO off=0 len=266
[2025-04-30T18:35:52.406737732Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=998.918448ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=333 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 413, tv_nsec: 876089622 }, first_sent_time: Instant { tv_sec: 413, tv_nsec: 876089622 }, 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: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 413, tv_nsec: 876089622 }, next_time: Instant { tv_sec: 413, tv_nsec: 876089622 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.406812141Z TRACE quiche_apps::client] written 1200
[2025-04-30T18:35:52.445159820Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:52.445200456Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Initial version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb token= len=119 pn=0 
[2025-04-30T18:35:52.445217778Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm ACK delay=2 blocks=[0..0] ecn_counts=None
[2025-04-30T18:35:52.445225302Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet newly acked 0
[2025-04-30T18:35:52.445232496Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=0 len=90
[2025-04-30T18:35:52.445360876Z TRACE quiche::tls] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f set write secret lvl=Handshake
[2025-04-30T18:35:52.445376085Z TRACE quiche::tls] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f set read secret lvl=Handshake
[2025-04-30T18:35:52.445417092Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1024 pn=1 
[2025-04-30T18:35:52.445424535Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=0 len=999
[2025-04-30T18:35:52.445441517Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm PADDING len=1
[2025-04-30T18:35:52.445450283Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:52.445455814Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:52.445459110Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:52.445480700Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Initial version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=1 
[2025-04-30T18:35:52.445484398Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=35 blocks=[0..0] ecn_counts=None
[2025-04-30T18:35:52.445494717Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=115.305895ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, first_sent_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 437901, last_update: Instant { tv_sec: 413, tv_nsec: 914873317 }, next_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.445529241Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=2 
[2025-04-30T18:35:52.445532718Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=14 blocks=[1..1] ecn_counts=None
[2025-04-30T18:35:52.445539490Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=115.261291ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, first_sent_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 437901, last_update: Instant { tv_sec: 413, tv_nsec: 914873317 }, next_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.445553727Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f dropped epoch 0 state
[2025-04-30T18:35:52.445619731Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:52.445627455Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:52.446088729Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:52.446093858Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1182 pn=2 
[2025-04-30T18:35:52.446100350Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=999 len=1157
[2025-04-30T18:35:52.446111752Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:52.446115288Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:52.446117653Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:52.446125778Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=3 
[2025-04-30T18:35:52.446133202Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=4 blocks=[1..2] ecn_counts=None
[2025-04-30T18:35:52.446139534Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=114.93958ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, first_sent_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, end_of_app_limited: 1, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 437901, last_update: Instant { tv_sec: 413, tv_nsec: 914873317 }, next_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.446173678Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:52.446178567Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:52.447005124Z TRACE quiche_apps::client] got 1132 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:52.447012828Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1094 pn=3 
[2025-04-30T18:35:52.447019170Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=2156 len=1069
[2025-04-30T18:35:52.447029129Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1132 bytes
[2025-04-30T18:35:52.447032685Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:52.447035080Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:52.447042584Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=4 
[2025-04-30T18:35:52.447045099Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=3 blocks=[1..3] ecn_counts=None
[2025-04-30T18:35:52.447050819Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=114.028294ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, first_sent_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, end_of_app_limited: 1, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 437901, last_update: Instant { tv_sec: 413, tv_nsec: 914873317 }, next_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.447083210Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:52.447092628Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:52.561261271Z TRACE quiche_apps::client] timed out
[2025-04-30T18:35:52.561294583Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f loss detection timeout expired
[2025-04-30T18:35:52.561301035Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=231.207415ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, first_sent_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, end_of_app_limited: 1, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 437901, last_update: Instant { tv_sec: 413, tv_nsec: 914873317 }, next_time: Instant { tv_sec: 413, tv_nsec: 914873347 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.561326814Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:52.561365276Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=7 pn=5 
[2025-04-30T18:35:52.561369915Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=14293 blocks=[1..3] ecn_counts=None
[2025-04-30T18:35:52.561375585Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm PING mtu_probe=None
[2025-04-30T18:35:52.561394481Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=231.159876ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=62 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 62, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 30771027 }, next_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, max_datagram_size: 1350, last_packet_size: Some(62), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.561491452Z TRACE quiche_apps::client] written 62 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:52.561499136Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:52.793770086Z TRACE quiche_apps::client] timed out
[2025-04-30T18:35:52.793801895Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f loss detection timeout expired
[2025-04-30T18:35:52.793808107Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=229.96176ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=62 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 62, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 30771027 }, next_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, max_datagram_size: 1350, last_packet_size: Some(62), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.793850316Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:52.793885672Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=9 pn=6 
[2025-04-30T18:35:52.793889600Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=43358 blocks=[1..3] ecn_counts=None
[2025-04-30T18:35:52.793895010Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm PING mtu_probe=None
[2025-04-30T18:35:52.793913975Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=462.379945ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=126 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 64, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 263293928 }, next_time: Instant { tv_sec: 414, tv_nsec: 263293928 }, max_datagram_size: 1350, last_packet_size: Some(64), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.793997742Z TRACE quiche_apps::client] written 64 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:52.794009925Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=9 pn=7 
[2025-04-30T18:35:52.794012780Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=43374 blocks=[1..3] ecn_counts=None
[2025-04-30T18:35:52.794015696Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm PING mtu_probe=None
[2025-04-30T18:35:52.794021697Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=462.41481ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=190 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 128, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 263293928 }, next_time: Instant { tv_sec: 414, tv_nsec: 263293928 }, max_datagram_size: 1350, last_packet_size: Some(64), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:52.794065439Z TRACE quiche_apps::client] written 64 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:52.794072873Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.257593449Z TRACE quiche_apps::client] timed out
[2025-04-30T18:35:53.257615731Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f loss detection timeout expired
[2025-04-30T18:35:53.257622103Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=461.246336ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=190 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 128, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 263293928 }, next_time: Instant { tv_sec: 414, tv_nsec: 263293928 }, max_datagram_size: 1350, last_packet_size: Some(64), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:53.257646789Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.257683788Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=9 pn=8 
[2025-04-30T18:35:53.257688637Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=101333 blocks=[1..3] ecn_counts=None
[2025-04-30T18:35:53.257694829Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm PING mtu_probe=None
[2025-04-30T18:35:53.257715638Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=924.80844ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=254 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 64, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 727091122 }, next_time: Instant { tv_sec: 414, tv_nsec: 727091122 }, max_datagram_size: 1350, last_packet_size: Some(64), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:53.257820364Z TRACE quiche_apps::client] written 64 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.257833439Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=9 pn=9 
[2025-04-30T18:35:53.257837025Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=101352 blocks=[1..3] ecn_counts=None
[2025-04-30T18:35:53.257840602Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm PING mtu_probe=None
[2025-04-30T18:35:53.257847735Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=924.844438ms latest_rtt=38.536091ms srtt=38.536091ms min_rtt=38.536091ms rttvar=19.268045ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=318 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 30771027 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { delivery_rate: 8641, is_app_limited: true, interval: 38.536091ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 413, tv_nsec: 876089622 }), send_elapsed: 0ns, ack_elapsed: 38.536091ms, rtt: 38.536091ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 128, rate: 437901, last_update: Instant { tv_sec: 414, tv_nsec: 727091122 }, next_time: Instant { tv_sec: 414, tv_nsec: 727091122 }, max_datagram_size: 1350, last_packet_size: Some(64), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:35:53.257880877Z TRACE quiche_apps::client] written 64 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.257889884Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.289626969Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.289653729Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1182 pn=4 
[2025-04-30T18:35:53.289669369Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm ACK delay=0 blocks=[8..9] ecn_counts=None
[2025-04-30T18:35:53.289676201Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet newly acked 8
[2025-04-30T18:35:53.289679988Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet newly acked 9
[2025-04-30T18:35:53.289689376Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet 5 lost on epoch 1
[2025-04-30T18:35:53.289693514Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet 6 lost on epoch 1
[2025-04-30T18:35:53.289696930Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet 7 lost on epoch 1
[2025-04-30T18:35:53.289712239Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=3225 len=1152
[2025-04-30T18:35:53.289739590Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.289745301Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.289748657Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.289760509Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=10 
[2025-04-30T18:35:53.289771901Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=13 blocks=[4..4] ecn_counts=None
[2025-04-30T18:35:53.289781969Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 759081080 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 727091122 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 727091122 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 727091122 }, max_datagram_size: 1350, last_packet_size: None, iv: 408.711µs, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.289834528Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.289841561Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.290552642Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.290562570Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1182 pn=5 
[2025-04-30T18:35:53.290593148Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=4377 len=1157
[2025-04-30T18:35:53.290639364Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.290644574Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.290648752Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.290660554Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=11 
[2025-04-30T18:35:53.290663990Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=12 blocks=[4..5] ecn_counts=None
[2025-04-30T18:35:53.290674129Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 759081080 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 9, last_sent_packet: 11, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.290715456Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.290720356Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.291540140Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.291548125Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1182 pn=6 
[2025-04-30T18:35:53.291555078Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=5534 len=1157
[2025-04-30T18:35:53.291566860Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.291589092Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.291591636Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.291600603Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=12 
[2025-04-30T18:35:53.291603338Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=6 blocks=[4..6] ecn_counts=None
[2025-04-30T18:35:53.291610452Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 759081080 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 9, last_sent_packet: 12, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.291644916Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.291649465Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.292536175Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.292543779Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1182 pn=7 
[2025-04-30T18:35:53.292550491Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=6691 len=1157
[2025-04-30T18:35:53.292563035Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.292566692Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.292588142Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.292597229Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=13 
[2025-04-30T18:35:53.292599914Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=6 blocks=[4..7] ecn_counts=None
[2025-04-30T18:35:53.292606957Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 759081080 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 9, last_sent_packet: 13, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.292646331Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.292651280Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.293535315Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.293543160Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1182 pn=8 
[2025-04-30T18:35:53.293549792Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=7848 len=1157
[2025-04-30T18:35:53.293560993Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.293564509Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.293566894Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.293594095Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=5 pn=14 
[2025-04-30T18:35:53.293596910Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=6 blocks=[4..8] ecn_counts=None
[2025-04-30T18:35:53.293603793Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 759081080 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 9, last_sent_packet: 14, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.293637366Z TRACE quiche_apps::client] written 60 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.293646964Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.294399335Z TRACE quiche_apps::client] got 1043 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.294407520Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Handshake version=1 dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f scid=a8e1b9b1375401f3cb len=1005 pn=9 
[2025-04-30T18:35:53.294414163Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=9005 len=980
[2025-04-30T18:35:53.294944485Z TRACE quiche::tls] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f write message lvl=Handshake len=52
[2025-04-30T18:35:53.294950978Z TRACE quiche::tls] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f set write secret lvl=OneRTT
[2025-04-30T18:35:53.294961427Z TRACE quiche::tls] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f set read secret lvl=OneRTT
[2025-04-30T18:35:53.294977287Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f connection established: proto=Ok("hq-interop") cipher=Some(AES256_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=false TransportParams { original_destination_connection_id: Some(e764280971cccd57058b2a599b9fb9aa), max_idle_timeout: 30000, stateless_reset_token: Some(175698914027033912580603827526426286560), max_udp_payload_size: 1472, initial_max_data: 16777216, initial_max_stream_data_bidi_local: 65536, initial_max_stream_data_bidi_remote: 65536, initial_max_stream_data_uni: 65536, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 8, max_ack_delay: 26, disable_active_migration: false, active_conn_id_limit: 4, initial_source_connection_id: Some(a8e1b9b1375401f3cb), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T18:35:53.294999679Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1043 bytes
[2025-04-30T18:35:53.295003917Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.295006432Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.295014717Z DEBUG quiche_apps::common] sending HTTP request "GET /qqoxvvckge\r\n"
[2025-04-30T18:35:53.295081522Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Handshake version=1 dcid=a8e1b9b1375401f3cb scid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f len=62 pn=15 
[2025-04-30T18:35:53.295085339Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=84 blocks=[4..9] ecn_counts=None
[2025-04-30T18:35:53.295088685Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm CRYPTO off=0 len=52
[2025-04-30T18:35:53.295096480Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=102.045154ms latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=117 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 14, last_sent_packet: 15, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.295110596Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10694 out_len=1233 left=1206
[2025-04-30T18:35:53.295122799Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=142 pn=16 
[2025-04-30T18:35:53.295125404Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[ce, a6, c6, b2, d0, fb, b1, d4, f2, 35, 19, 9d, e6, f7, cf, 8c, bf, f1, e0, 14] reset_token=[6f, ee, 27, 8d, a9, e9, 16, 8d, cf, bc, d9, 85, 4f, e2, b6, 35]
[2025-04-30T18:35:53.295132127Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[8c, cd, a8, 9a, 18, fb, 5f, 8a, 07, 8d, c5, 1a, 36, f5, c1, 9f, e0, 84, 0b, 2b] reset_token=[b8, 4c, 26, c8, da, 17, 21, ca, 16, 06, 88, ee, ac, 20, 12, 1c]
[2025-04-30T18:35:53.295137777Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[7e, 2e, 71, 20, 8b, ca, c7, 1a, 90, 5e, 92, 5b, df, a1, 7d, ff, b8, 61, 5d, e3] reset_token=[2e, e8, e2, 1c, 74, 08, 09, 4d, db, e2, bc, 43, 35, 4d, 1d, ba]
[2025-04-30T18:35:53.295143067Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T18:35:53.295150271Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=101.991484ms latest_rtt=31.989958ms srtt=37.717823ms min_rtt=31.989958ms rttvar=16.087566ms cwnd=9450 ssthresh=9450 bytes_in_flight=286 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 461, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 15, last_sent_packet: 16, largest_acked: 9, rate_sample: RateSample { delivery_rate: 175, is_app_limited: true, interval: 728.310053ms, delivered: 128, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 30771027 }), send_elapsed: 696.320095ms, ack_elapsed: 728.310053ms, rtt: 31.989958ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 313180, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.295189735Z TRACE quiche_apps::client] written 286 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.295194383Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.326952308Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.326981743Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=1199 pn=10 
[2025-04-30T18:35:53.326996721Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm ACK delay=0 blocks=[16..16] ecn_counts=None
[2025-04-30T18:35:53.327002422Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f packet newly acked 16
[2025-04-30T18:35:53.327007892Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm HANDSHAKE_DONE
[2025-04-30T18:35:53.327014925Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f dropped epoch 1 state
[2025-04-30T18:35:53.327020686Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[a8, e1, 21, e6, 25, d4, fb, a7, 68] reset_token=[70, 21, 02, ee, 14, 0b, 89, 4f, 53, 0f, d4, 70, 68, ef, 6f, 43]
[2025-04-30T18:35:53.327028691Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[a8, e1, f1, c9, 5d, 8e, 6b, 27, 54] reset_token=[84, ab, ab, 02, 34, 12, 7e, 46, 5e, e5, 90, 53, aa, 20, 34, 8f]
[2025-04-30T18:35:53.327045142Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[a8, e1, 2d, 15, 4f, 77, 16, 36, 97] reset_token=[0c, fb, fe, c3, 74, 88, 8f, 01, f5, 72, bd, c4, 70, 97, e6, 27]
[2025-04-30T18:35:53.327052956Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm PADDING len=1086
[2025-04-30T18:35:53.327074066Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.327078444Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.327081199Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.327090897Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.327095886Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=17 
[2025-04-30T18:35:53.327098371Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=14 blocks=[10..10] ecn_counts=None
[2025-04-30T18:35:53.327105875Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 17, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.327160728Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.327165226Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.327904831Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.327915350Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=1231 pn=11 
[2025-04-30T18:35:53.327921692Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm PING mtu_probe=None
[2025-04-30T18:35:53.327928525Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm PADDING len=1210
[2025-04-30T18:35:53.327935067Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1252 bytes
[2025-04-30T18:35:53.327938594Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.327940988Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.327947360Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.327950626Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=18 
[2025-04-30T18:35:53.327953021Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=4 blocks=[10..11] ecn_counts=None
[2025-04-30T18:35:53.327964612Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 18, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.328000410Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.328004467Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.328167933Z TRACE quiche_apps::client] got 366 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.328175517Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=345 pn=12 
[2025-04-30T18:35:53.328181759Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm CRYPTO off=0 len=321
[2025-04-30T18:35:53.328216103Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 366 bytes
[2025-04-30T18:35:53.328220231Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.328222706Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.328229298Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.328232524Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=19 
[2025-04-30T18:35:53.328235019Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=6 blocks=[10..12] ecn_counts=None
[2025-04-30T18:35:53.328241611Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 19, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.328284441Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.328288719Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.329217818Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.329229069Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=1199 pn=13 
[2025-04-30T18:35:53.329236604Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm STREAM id=0 off=0 len=1175 fin=false
[2025-04-30T18:35:53.329244869Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.329248506Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.329250890Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.329255749Z TRACE quiche_apps::common] received 1175 bytes
[2025-04-30T18:35:53.329258625Z TRACE quiche_apps::common] stream 0 has 1175 bytes (fin? false)
[2025-04-30T18:35:53.329265538Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.329268874Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=20 
[2025-04-30T18:35:53.329271329Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=4 blocks=[10..13] ecn_counts=None
[2025-04-30T18:35:53.329292067Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 20, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.329329517Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.329333675Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.330216207Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.330226506Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=1199 pn=14 
[2025-04-30T18:35:53.330233359Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm STREAM id=0 off=1175 len=1173 fin=false
[2025-04-30T18:35:53.330240943Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.330244380Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.330246774Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.330250972Z TRACE quiche_apps::common] received 1173 bytes
[2025-04-30T18:35:53.330253316Z TRACE quiche_apps::common] stream 0 has 1173 bytes (fin? false)
[2025-04-30T18:35:53.330259909Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.330268014Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=21 
[2025-04-30T18:35:53.330270448Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=4 blocks=[10..14] ecn_counts=None
[2025-04-30T18:35:53.330277161Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 21, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.330311315Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.330315303Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.331216860Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.331226719Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=1199 pn=15 
[2025-04-30T18:35:53.331233321Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm STREAM id=0 off=2348 len=1173 fin=false
[2025-04-30T18:35:53.331240515Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.331244291Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.331246796Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.331250874Z TRACE quiche_apps::common] received 1173 bytes
[2025-04-30T18:35:53.331253208Z TRACE quiche_apps::common] stream 0 has 1173 bytes (fin? false)
[2025-04-30T18:35:53.331259740Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.331263027Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=22 
[2025-04-30T18:35:53.331265501Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=4 blocks=[10..15] ecn_counts=None
[2025-04-30T18:35:53.331271693Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 22, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.331311718Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.331315986Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.332216662Z TRACE quiche_apps::client] got 1220 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.332226921Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=1199 pn=16 
[2025-04-30T18:35:53.332233573Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm STREAM id=0 off=3521 len=1173 fin=false
[2025-04-30T18:35:53.332240737Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1220 bytes
[2025-04-30T18:35:53.332244213Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.332246578Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.332250635Z TRACE quiche_apps::common] received 1173 bytes
[2025-04-30T18:35:53.332252849Z TRACE quiche_apps::common] stream 0 has 1173 bytes (fin? false)
[2025-04-30T18:35:53.332259251Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1318
[2025-04-30T18:35:53.332262397Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=5 pn=23 
[2025-04-30T18:35:53.332264762Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm ACK delay=4 blocks=[10..16] ecn_counts=None
[2025-04-30T18:35:53.332271013Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=none latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 796328592 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, end_of_app_limited: 16, last_sent_packet: 23, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 759185877 }, next_time: Instant { tv_sec: 414, tv_nsec: 760495604 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.332304456Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.332308283Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.332615839Z TRACE quiche_apps::client] got 473 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.332623192Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx pkt Short dcid=5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f key_phase=false len=452 pn=17 
[2025-04-30T18:35:53.332629364Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f rx frm STREAM id=0 off=4694 len=426 fin=true
[2025-04-30T18:35:53.332642448Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 473 bytes
[2025-04-30T18:35:53.332646095Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.332648500Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.332654571Z TRACE quiche_apps::common] received 426 bytes
[2025-04-30T18:35:53.332656846Z TRACE quiche_apps::common] stream 0 has 426 bytes (fin? true)
[2025-04-30T18:35:53.332659100Z DEBUG quiche_apps::common] 1/1 responses received
[2025-04-30T18:35:53.332661544Z INFO  quiche_apps::common] 1/1 response(s) received in 925.845626ms, closing...
[2025-04-30T18:35:53.332667876Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=10969 out_len=1350 left=1323
[2025-04-30T18:35:53.332671343Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx pkt Short dcid=a8e1b9b1375401f3cb key_phase=false len=10 pn=24 
[2025-04-30T18:35:53.332673747Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-04-30T18:35:53.332680851Z TRACE quiche::recovery::congestion::recovery] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f timer=113.543217ms latest_rtt=35.914121ms srtt=37.49236ms min_rtt=31.989958ms rttvar=12.516599ms cwnd=9450 ssthresh=9450 bytes_in_flight=37 app_limited=true congestion_recovery_start_time=Some(Instant { tv_sec: 414, tv_nsec: 833920296 }) Rate { delivered: 630, delivered_time: Instant { tv_sec: 414, tv_nsec: 802098373 }, first_sent_time: Instant { tv_sec: 414, tv_nsec: 802098373 }, end_of_app_limited: 23, last_sent_packet: 24, largest_acked: 16, rate_sample: RateSample { delivery_rate: 4705, is_app_limited: true, interval: 35.914121ms, delivered: 169, prior_delivered: 461, prior_time: Some(Instant { tv_sec: 414, tv_nsec: 760495604 }), send_elapsed: 0ns, ack_elapsed: 35.914121ms, rtt: 35.914121ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 315064, last_update: Instant { tv_sec: 414, tv_nsec: 802098373 }, next_time: Instant { tv_sec: 414, tv_nsec: 802098373 }, 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=1.9574338205844317 w_max=13500 } 
[2025-04-30T18:35:53.332715395Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:60413 to 193.167.100.100:443
[2025-04-30T18:35:53.332718952Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.359436152Z TRACE quiche_apps::client] got 1332 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.359449627Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 1332 bytes
[2025-04-30T18:35:53.359453233Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.359455648Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.359459766Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.363138111Z TRACE quiche_apps::client] got 57 bytes from 193.167.100.100:443 to 0.0.0.0:60413
[2025-04-30T18:35:53.363146847Z TRACE quiche_apps::client] 0.0.0.0:60413: processed 57 bytes
[2025-04-30T18:35:53.363150124Z TRACE quiche_apps::client] 0.0.0.0:60413: recv() would block
[2025-04-30T18:35:53.363152568Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.363156085Z TRACE quiche_apps::client] 0.0.0.0:60413 -> 193.167.100.100:443: done writing
[2025-04-30T18:35:53.596443556Z TRACE quiche_apps::client] timed out
[2025-04-30T18:35:53.596478311Z TRACE quiche] 5d40809c3f75bf6dcc761df4e7caf8fd268f0f2f draining timeout expired
[2025-04-30T18:35:53.596524207Z TRACE quiche_apps::client] done reading
[2025-04-30T18:35:53.596529417Z INFO  quiche_apps::client] connection closed, recv=18 sent=25 lost=6 retrans=0 sent_bytes=1739 recv_bytes=18906 lost_bytes=190 [local_addr=0.0.0.0:60413 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=18 sent=25 lost=6 retrans=0 rtt=37.49236ms min_rtt=Some(31.989958ms) rttvar=12.516599ms cwnd=9450 sent_bytes=1739 recv_bytes=18906 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=4705]