[2025-04-30T11:50:20.806923747Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T11:50:20.807205225Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:34141 with scid d3b5c5f25358297566cf2a1d3b815ccf982a179a
[2025-04-30T11:50:20.807249148Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a write message lvl=Initial len=266
[2025-04-30T11:50:20.807267883Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Initial version=1 dcid=126791efce5100582bc92716bbe1d484 scid=d3b5c5f25358297566cf2a1d3b815ccf982a179a len=270 pn=0 
[2025-04-30T11:50:20.807271059Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm CRYPTO off=0 len=266
[2025-04-30T11:50:20.807285145Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=998.926522ms 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: 280, tv_nsec: 575866972 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 575866972 }, 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: 280, tv_nsec: 575866972 }, next_time: Instant { tv_sec: 280, tv_nsec: 575866972 }, 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-30T11:50:20.807365907Z TRACE quiche_apps::client] written 1200
[2025-04-30T11:50:20.844279864Z TRACE quiche_apps::client] got 105 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.844299150Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Retry version=1 dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a scid=5c50305dac65631c token=9cc38e4d5131ee57e25391adbc92290c41b79c8f3e838cef46d004f2a33bfc59f2acca78d4c2aea678c839ef5d07f1c4d0b955169b0e
[2025-04-30T11:50:20.844320770Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a dropped epoch 0 state
[2025-04-30T11:50:20.844327553Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 105 bytes
[2025-04-30T11:50:20.844331401Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.844333815Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.844398877Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a write message lvl=Initial len=266
[2025-04-30T11:50:20.844414837Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Initial version=1 dcid=5c50305dac65631c scid=d3b5c5f25358297566cf2a1d3b815ccf982a179a token=9cc38e4d5131ee57e25391adbc92290c41b79c8f3e838cef46d004f2a33bfc59f2acca78d4c2aea678c839ef5d07f1c4d0b955169b0e len=270 pn=1 
[2025-04-30T11:50:20.844418003Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm CRYPTO off=0 len=266
[2025-04-30T11:50:20.844428022Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=998.912035ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=379 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 280, tv_nsec: 612995131 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 612995131 }, 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: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 280, tv_nsec: 612995131 }, next_time: Instant { tv_sec: 280, tv_nsec: 612995131 }, 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-30T11:50:20.844477204Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.844482935Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.879308045Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.879323865Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Initial version=1 dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a scid=623ac1630b79ea85 token= len=117 pn=0 
[2025-04-30T11:50:20.879335637Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm ACK delay=125 blocks=[1..1] ecn_counts=None
[2025-04-30T11:50:20.879342180Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a packet newly acked 1
[2025-04-30T11:50:20.879369240Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm CRYPTO off=0 len=90
[2025-04-30T11:50:20.879486290Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a set write secret lvl=Handshake
[2025-04-30T11:50:20.879498783Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a set read secret lvl=Handshake
[2025-04-30T11:50:20.879532236Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Handshake version=1 dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a scid=623ac1630b79ea85 len=1008 pn=0 
[2025-04-30T11:50:20.879539149Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm CRYPTO off=0 len=747
[2025-04-30T11:50:20.879773248Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a write message lvl=Handshake len=52
[2025-04-30T11:50:20.879777927Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a set write secret lvl=OneRTT
[2025-04-30T11:50:20.879787525Z TRACE quiche::tls] d3b5c5f25358297566cf2a1d3b815ccf982a179a set read secret lvl=OneRTT
[2025-04-30T11:50:20.879808775Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a 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(126791efce5100582bc92716bbe1d484), max_idle_timeout: 30000, stateless_reset_token: Some(142672899294390142580294230538957459217), max_udp_payload_size: 2048, initial_max_data: 1638000, initial_max_stream_data_bidi_local: 16380, initial_max_stream_data_bidi_remote: 1474200, initial_max_stream_data_uni: 16380, initial_max_streams_bidi: 100, initial_max_streams_uni: 3, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: true, active_conn_id_limit: 8, initial_source_connection_id: Some(623ac1630b79ea85), retry_source_connection_id: Some(5c50305dac65631c), max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T11:50:20.879822170Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm PADDING len=240
[2025-04-30T11:50:20.879837919Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1200 bytes
[2025-04-30T11:50:20.879843410Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.879846636Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.879855763Z DEBUG quiche_apps::common] sending HTTP request "GET /bwvmjremyg\r\n"
[2025-04-30T11:50:20.879936955Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Initial version=1 dcid=623ac1630b79ea85 scid=d3b5c5f25358297566cf2a1d3b815ccf982a179a token=9cc38e4d5131ee57e25391adbc92290c41b79c8f3e838cef46d004f2a33bfc59f2acca78d4c2aea678c839ef5d07f1c4d0b955169b0e len=6 pn=2 
[2025-04-30T11:50:20.879941754Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=76 blocks=[0..0] ecn_counts=None
[2025-04-30T11:50:20.879958095Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=104.301204ms latest_rtt=34.979861ms srtt=34.979861ms min_rtt=34.979861ms rttvar=17.48993ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 379, delivered_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 10834, is_app_limited: true, interval: 34.979861ms, delivered: 379, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 612995131 }), send_elapsed: 0ns, ack_elapsed: 34.979861ms, rtt: 34.979861ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 482420, last_update: Instant { tv_sec: 280, tv_nsec: 648460994 }, next_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, 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-30T11:50:20.879981669Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Handshake version=1 dcid=623ac1630b79ea85 scid=d3b5c5f25358297566cf2a1d3b815ccf982a179a len=61 pn=3 
[2025-04-30T11:50:20.879985066Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=56 blocks=[0..0] ecn_counts=None
[2025-04-30T11:50:20.879988282Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm CRYPTO off=0 len=52
[2025-04-30T11:50:20.879995635Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=104.869449ms latest_rtt=34.979861ms srtt=34.979861ms min_rtt=34.979861ms rttvar=17.48993ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=115 app_limited=true congestion_recovery_start_time=None Rate { delivered: 379, delivered_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 10834, is_app_limited: true, interval: 34.979861ms, delivered: 379, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 612995131 }), send_elapsed: 0ns, ack_elapsed: 34.979861ms, rtt: 34.979861ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 482420, last_update: Instant { tv_sec: 280, tv_nsec: 648580498 }, next_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, max_datagram_size: 1350, last_packet_size: None, iv: 238.381µ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=0 w_max=0 } 
[2025-04-30T11:50:20.880008630Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a dropped epoch 0 state
[2025-04-30T11:50:20.880013739Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13385 out_len=1120 left=1094
[2025-04-30T11:50:20.880027044Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=1094 pn=4 
[2025-04-30T11:50:20.880030180Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[6d, 2e, f7, 7c, 50, a2, e9, 3c, f7, e5, d3, 02, c3, 2f, f1, 60, 88, 6c, 6f, 94] reset_token=[1d, ac, 0a, 05, 2e, 31, 2a, a6, 1e, 38, d0, 3c, d2, 10, ff, 73]
[2025-04-30T11:50:20.880038326Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[2d, 9f, 7f, d5, 57, 83, 06, c7, 76, d6, de, 4a, 9a, b7, 5e, c8, 64, 9b, 44, 2f] reset_token=[70, 7e, 8b, e9, f1, b6, 53, 16, 6a, 05, fc, ae, cd, 69, 63, e1]
[2025-04-30T11:50:20.880048775Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[45, 61, 07, b2, 3a, 54, ac, b6, e5, e1, b4, 04, 73, 5f, 3d, 36, fe, 26, f5, e7] reset_token=[2b, bc, 1a, fa, 9f, d3, 38, b4, da, 43, e1, 8d, 8e, 5e, f7, 6d]
[2025-04-30T11:50:20.880055087Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[a5, 0a, f6, f4, 8d, e7, 97, 9c, cf, 28, 7c, 2f, 6b, e7, 97, f4, 32, ae, b9, d3] reset_token=[83, 9b, c9, 1b, 52, d9, 6e, 8b, 75, 9a, 1a, cb, 57, 02, 6a, 5b]
[2025-04-30T11:50:20.880061178Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[54, 7f, 12, 45, e5, c8, 23, 27, 61, 58, 75, 25, 9b, 4b, cb, 01, 39, 34, 70, ff] reset_token=[a4, eb, a8, d8, 2c, 5f, 45, db, aa, 9f, be, a4, ac, 87, ae, 94]
[2025-04-30T11:50:20.880067180Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[52, ae, f4, 6c, 9d, 10, e9, 10, 8d, 4e, 64, 64, e4, 82, 1e, 07, 7c, 7b, 05, 4b] reset_token=[fc, 96, 87, 40, 11, 7d, 64, e8, 8d, b3, e1, 9f, 8d, 6d, 50, 61]
[2025-04-30T11:50:20.880073171Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[2b, f3, 20, bf, 79, b3, f1, 36, 62, 0f, 50, b8, 7d, 85, b3, 08, 57, 91, 7c, 8a] reset_token=[d4, 4d, 59, f8, b1, 9f, 7c, 39, 7c, c3, 92, 0b, 28, ae, ff, ef]
[2025-04-30T11:50:20.880079162Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T11:50:20.880082358Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm PADDING len=792
[2025-04-30T11:50:20.880092928Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=104.772167ms latest_rtt=34.979861ms srtt=34.979861ms min_rtt=34.979861ms rttvar=17.48993ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1235 app_limited=true congestion_recovery_start_time=None Rate { delivered: 379, delivered_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 10834, is_app_limited: true, interval: 34.979861ms, delivered: 379, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 612995131 }), send_elapsed: 0ns, ack_elapsed: 34.979861ms, rtt: 34.979861ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1120, rate: 482420, last_update: Instant { tv_sec: 280, tv_nsec: 648580498 }, next_time: Instant { tv_sec: 280, tv_nsec: 648818879 }, max_datagram_size: 1350, last_packet_size: Some(1120), 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-30T11:50:20.880141239Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.880146829Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.913939668Z TRACE quiche_apps::client] got 646 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.913952001Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Handshake version=1 dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a scid=623ac1630b79ea85 len=22 pn=1 
[2025-04-30T11:50:20.913959004Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm ACK delay=0 blocks=[3..3] ecn_counts=None
[2025-04-30T11:50:20.913963323Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a packet newly acked 3
[2025-04-30T11:50:20.913977098Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=567 pn=0 
[2025-04-30T11:50:20.913988339Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm CRYPTO off=0 len=546
[2025-04-30T11:50:20.914013667Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 646 bytes
[2025-04-30T11:50:20.914017885Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.914020410Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.914027673Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12380 out_len=1350 left=1319
[2025-04-30T11:50:20.914031290Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=5 
[2025-04-30T11:50:20.914033815Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=6 blocks=[0..0] ecn_counts=None
[2025-04-30T11:50:20.914040056Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=79.067226ms latest_rtt=34.143126ms srtt=34.875268ms min_rtt=34.143126ms rttvar=13.32663ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1120 app_limited=true congestion_recovery_start_time=None Rate { delivered: 494, delivered_time: Instant { tv_sec: 280, tv_nsec: 682604160 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 648461034 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 3, rate_sample: RateSample { delivery_rate: 3368, is_app_limited: true, interval: 34.143126ms, delivered: 115, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483867, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.914080272Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.914084750Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.915094865Z TRACE quiche_apps::client] got 168 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.915102509Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=147 pn=1 
[2025-04-30T11:50:20.915107920Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm ACK delay=250 blocks=[4..4] ecn_counts=None
[2025-04-30T11:50:20.915111146Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a packet newly acked 4
[2025-04-30T11:50:20.915115273Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm HANDSHAKE_DONE
[2025-04-30T11:50:20.915118419Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a dropped epoch 1 state
[2025-04-30T11:50:20.915122998Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm NEW_TOKEN len=37
[2025-04-30T11:50:20.915126555Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[16, ea, e1, 38, 53, 9b, c5, 88] reset_token=[31, a7, 69, 69, 82, 02, b9, a1, 85, 01, 4a, 1b, 90, 39, b6, 7e]
[2025-04-30T11:50:20.915132636Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[95, 83, 55, fa, 3b, 3c, 44, 2b] reset_token=[ce, 95, 13, 4b, 6d, a4, 3a, ea, 9f, 68, 56, de, 7d, 45, ed, c5]
[2025-04-30T11:50:20.915137225Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[36, 48, 66, bc, 76, 47, 09, 93] reset_token=[8f, 9f, 19, de, 3e, 6d, 7a, 59, c0, 46, c0, 46, d9, 9b, 0b, 1b]
[2025-04-30T11:50:20.915172150Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 168 bytes
[2025-04-30T11:50:20.915176368Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.915178752Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.915185225Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.915188621Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=6 
[2025-04-30T11:50:20.915191146Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=10 blocks=[0..1] ecn_counts=None
[2025-04-30T11:50:20.915197558Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.915231482Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.915235770Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.917470702Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.917480170Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=2 
[2025-04-30T11:50:20.917487063Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=0 len=1210 fin=false
[2025-04-30T11:50:20.917494928Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.917498605Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.917500999Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.917505548Z TRACE quiche_apps::common] received 1210 bytes
[2025-04-30T11:50:20.917508113Z TRACE quiche_apps::common] stream 0 has 1210 bytes (fin? false)
[2025-04-30T11:50:20.917514775Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.917518121Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=7 
[2025-04-30T11:50:20.917520586Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=4 blocks=[0..2] ecn_counts=None
[2025-04-30T11:50:20.917526938Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 7, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.917567243Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.917571541Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.918491487Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.918498771Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=3 
[2025-04-30T11:50:20.918504923Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=1210 len=1208 fin=false
[2025-04-30T11:50:20.918511675Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.918515192Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.918517466Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.918521403Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.918523648Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.918529438Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.918532434Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=8 
[2025-04-30T11:50:20.918534828Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=3 blocks=[0..3] ecn_counts=None
[2025-04-30T11:50:20.918540379Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 8, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.918570526Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.918574303Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.923096787Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.923110492Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=4 
[2025-04-30T11:50:20.923117355Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=2418 len=1208 fin=false
[2025-04-30T11:50:20.923124930Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.923128576Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.923130891Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.923135209Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.923137563Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.923144236Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.923147652Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=9 
[2025-04-30T11:50:20.923150107Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=4 blocks=[0..4] ecn_counts=None
[2025-04-30T11:50:20.923157020Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 9, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.923190302Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.923194330Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.924097895Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.924106271Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=5 
[2025-04-30T11:50:20.924112211Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=3626 len=1208 fin=false
[2025-04-30T11:50:20.924119055Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.924122551Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.924124875Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.924128923Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.924131147Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.924137279Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.924140435Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=10 
[2025-04-30T11:50:20.924142869Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=3 blocks=[0..5] ecn_counts=None
[2025-04-30T11:50:20.924153840Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 10, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.924185429Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.924189286Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.928750643Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.928760061Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=6 
[2025-04-30T11:50:20.928767315Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=4834 len=1208 fin=false
[2025-04-30T11:50:20.928775019Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.928778496Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.928780860Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.928784957Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.928787202Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.928793654Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.928796950Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=11 
[2025-04-30T11:50:20.928799295Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=4 blocks=[0..6] ecn_counts=None
[2025-04-30T11:50:20.928805887Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 11, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.928843958Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.928848046Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.929764455Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.929773181Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=7 
[2025-04-30T11:50:20.929779824Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=6042 len=1208 fin=false
[2025-04-30T11:50:20.929787097Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.929790524Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.929792878Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.929797016Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.929799240Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.929805452Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.929808688Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=12 
[2025-04-30T11:50:20.929811093Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=4 blocks=[0..7] ecn_counts=None
[2025-04-30T11:50:20.929817274Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 12, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.929850166Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.929854153Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.933339051Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.933370259Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=8 
[2025-04-30T11:50:20.933380538Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=7250 len=1208 fin=false
[2025-04-30T11:50:20.933389736Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.933394154Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.933397080Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.933402179Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.933404995Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.933437666Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.933441974Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=13 
[2025-04-30T11:50:20.933445010Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=8 blocks=[0..8] ecn_counts=None
[2025-04-30T11:50:20.933453425Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 13, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.933495354Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.933500263Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.934368712Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.934377268Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=1231 pn=9 
[2025-04-30T11:50:20.934383620Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=8458 len=1208 fin=false
[2025-04-30T11:50:20.934390864Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 1252 bytes
[2025-04-30T11:50:20.934394340Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.934396675Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.934400752Z TRACE quiche_apps::common] received 1208 bytes
[2025-04-30T11:50:20.934402987Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-04-30T11:50:20.934409379Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T11:50:20.934412615Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=5 pn=14 
[2025-04-30T11:50:20.934415049Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm ACK delay=4 blocks=[0..9] ecn_counts=None
[2025-04-30T11:50:20.934421010Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=none latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 5, last_sent_packet: 14, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 682678780 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, 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-30T11:50:20.934459252Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.934463470Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.937336310Z TRACE quiche_apps::client] got 618 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.937345336Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx pkt Short dcid=d3b5c5f25358297566cf2a1d3b815ccf982a179a key_phase=false len=597 pn=10 
[2025-04-30T11:50:20.937365895Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a rx frm STREAM id=0 off=9666 len=574 fin=true
[2025-04-30T11:50:20.937373259Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 618 bytes
[2025-04-30T11:50:20.937376876Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.937379280Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.937384841Z TRACE quiche_apps::common] received 574 bytes
[2025-04-30T11:50:20.937387115Z TRACE quiche_apps::common] stream 0 has 574 bytes (fin? true)
[2025-04-30T11:50:20.937389409Z DEBUG quiche_apps::common] 1/1 responses received
[2025-04-30T11:50:20.937391794Z INFO  quiche_apps::common] 1/1 response(s) received in 130.016409ms, closing...
[2025-04-30T11:50:20.937398015Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1324
[2025-04-30T11:50:20.937401432Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx pkt Short dcid=623ac1630b79ea85 key_phase=false len=10 pn=15 
[2025-04-30T11:50:20.937403886Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-04-30T11:50:20.937411030Z TRACE quiche::recovery::congestion::recovery] d3b5c5f25358297566cf2a1d3b815ccf982a179a timer=99.909202ms latest_rtt=34.937142ms srtt=34.883001ms min_rtt=34.143126ms rttvar=10.01044ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=36 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1614, delivered_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, first_sent_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, end_of_app_limited: 14, last_sent_packet: 15, largest_acked: 4, rate_sample: RateSample { delivery_rate: 36171, is_app_limited: true, interval: 34.143126ms, delivered: 1235, prior_delivered: 379, prior_time: Some(Instant { tv_sec: 280, tv_nsec: 648461034 }), send_elapsed: 0ns, ack_elapsed: 34.143126ms, rtt: 34.143126ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 483759, last_update: Instant { tv_sec: 280, tv_nsec: 706050465 }, next_time: Instant { tv_sec: 280, tv_nsec: 682678780 }, max_datagram_size: 1350, last_packet_size: None, iv: 74.417µ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=0 w_max=0 } 
[2025-04-30T11:50:20.937444933Z TRACE quiche_apps::client] written 36 bytes from 0.0.0.0:34141 to 193.167.100.100:443
[2025-04-30T11:50:20.937448460Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:20.968246185Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:34141
[2025-04-30T11:50:20.968257947Z TRACE quiche_apps::client] 0.0.0.0:34141: processed 42 bytes
[2025-04-30T11:50:20.968268407Z TRACE quiche_apps::client] 0.0.0.0:34141: recv() would block
[2025-04-30T11:50:20.968271553Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:20.968276332Z TRACE quiche_apps::client] 0.0.0.0:34141 -> 193.167.100.100:443: done writing
[2025-04-30T11:50:21.162525366Z TRACE quiche_apps::client] timed out
[2025-04-30T11:50:21.162549822Z TRACE quiche] d3b5c5f25358297566cf2a1d3b815ccf982a179a draining timeout expired
[2025-04-30T11:50:21.162593745Z TRACE quiche_apps::client] done reading
[2025-04-30T11:50:21.162598543Z INFO  quiche_apps::client] connection closed, recv=14 sent=16 lost=0 retrans=0 sent_bytes=2408 recv_bytes=12648 lost_bytes=0 [local_addr=0.0.0.0:34141 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=14 sent=16 lost=0 retrans=0 rtt=34.883001ms min_rtt=Some(34.143126ms) rttvar=10.01044ms cwnd=13500 sent_bytes=2408 recv_bytes=12648 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=36171]