[2025-09-12T06:30:08.395631076Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-09-12T06:30:08.395909837Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:58382 with scid 1cd2a6904e8fedb6173c978f605302d7a20d1785
[2025-09-12T06:30:08.395956524Z TRACE quiche::tls] 1cd2a6904e8fedb6173c978f605302d7a20d1785 write message lvl=Initial len=553
[2025-09-12T06:30:08.395972554Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Initial version=1 dcid=a116c6369dfd8a764a86703a99b550ff scid=1cd2a6904e8fedb6173c978f605302d7a20d1785 len=557 pn=0 
[2025-09-12T06:30:08.395975690Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm CRYPTO off=0 len=553
[2025-09-12T06:30:08.395988173Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=998.928036ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=620 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 727, tv_nsec: 185645238 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 185645238 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 727, tv_nsec: 185645238 }, next_time: Instant { tv_sec: 727, tv_nsec: 185645238 }, 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-09-12T06:30:08.396055138Z TRACE quiche_apps::client] written 1200
[2025-09-12T06:30:08.429761005Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:58382
[2025-09-12T06:30:08.429776364Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx pkt Initial version=1 dcid=1cd2a6904e8fedb6173c978f605302d7a20d1785 scid=06c59469575e9079 token= len=123 pn=0 
[2025-09-12T06:30:08.429786503Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm ACK delay=155 blocks=[0..0] ecn_counts=None
[2025-09-12T06:30:08.429792464Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 packet newly acked 0
[2025-09-12T06:30:08.429797914Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm CRYPTO off=0 len=96
[2025-09-12T06:30:08.429888834Z TRACE quiche::tls] 1cd2a6904e8fedb6173c978f605302d7a20d1785 set write secret lvl=Handshake
[2025-09-12T06:30:08.429898302Z TRACE quiche::tls] 1cd2a6904e8fedb6173c978f605302d7a20d1785 set read secret lvl=Handshake
[2025-09-12T06:30:08.429919792Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx pkt Handshake version=1 dcid=1cd2a6904e8fedb6173c978f605302d7a20d1785 scid=06c59469575e9079 len=1054 pn=1 
[2025-09-12T06:30:08.429925974Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm CRYPTO off=0 len=161
[2025-09-12T06:30:08.429956060Z TRACE quiche::tls] 1cd2a6904e8fedb6173c978f605302d7a20d1785 write message lvl=Handshake len=36
[2025-09-12T06:30:08.429959556Z TRACE quiche::tls] 1cd2a6904e8fedb6173c978f605302d7a20d1785 set write secret lvl=OneRTT
[2025-09-12T06:30:08.429966699Z TRACE quiche::tls] 1cd2a6904e8fedb6173c978f605302d7a20d1785 set read secret lvl=OneRTT
[2025-09-12T06:30:08.429982309Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 connection established: proto=Ok("h3") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=true TransportParams { original_destination_connection_id: Some(a116c6369dfd8a764a86703a99b550ff), max_idle_timeout: 30000, stateless_reset_token: Some(219225658841718864115623517192453625941), max_udp_payload_size: 65527, initial_max_data: 1572864, initial_max_stream_data_bidi_local: 0, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 12288, initial_max_streams_bidi: 100, initial_max_streams_uni: 3, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(06c59469575e9079), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-09-12T06:30:08.430005422Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm PADDING len=872
[2025-09-12T06:30:08.430020150Z TRACE quiche_apps::client] 0.0.0.0:58382: processed 1252 bytes
[2025-09-12T06:30:08.430025379Z TRACE quiche_apps::client] 0.0.0.0:58382: recv() would block
[2025-09-12T06:30:08.430028465Z TRACE quiche_apps::client] done reading
[2025-09-12T06:30:08.430048432Z TRACE quiche::h3] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm SETTINGS stream=2 len=18
[2025-09-12T06:30:08.430065745Z TRACE quiche::h3] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm GREASE stream=0 len=0
[2025-09-12T06:30:08.430072898Z TRACE quiche::h3] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm GREASE stream=0 len=18
[2025-09-12T06:30:08.430081244Z TRACE quiche::h3] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm HEADERS stream=0 len=30 fin=true
[2025-09-12T06:30:08.430088126Z DEBUG quiche_apps::common] Sent HTTP request [":method: GET", ":scheme: https", ":authority: server4", ":path: /yfgvzrvwrq", "user-agent: quiche"]
[2025-09-12T06:30:08.430154621Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Initial version=1 dcid=06c59469575e9079 scid=1cd2a6904e8fedb6173c978f605302d7a20d1785 len=5 pn=1 
[2025-09-12T06:30:08.430159209Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm ACK delay=47 blocks=[0..0] ecn_counts=None
[2025-09-12T06:30:08.430169438Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=101.173092ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 219709214 }, next_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, 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-09-12T06:30:08.430191570Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Handshake version=1 dcid=06c59469575e9079 scid=1cd2a6904e8fedb6173c978f605302d7a20d1785 len=45 pn=2 
[2025-09-12T06:30:08.430195257Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm ACK delay=33 blocks=[1..1] ecn_counts=None
[2025-09-12T06:30:08.430198533Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm CRYPTO off=0 len=36
[2025-09-12T06:30:08.430205325Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=101.510863ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=99 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 219875284 }, next_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, max_datagram_size: 1350, last_packet_size: None, iv: 198.626µ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-09-12T06:30:08.430225073Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 dropped epoch 0 state
[2025-09-12T06:30:08.430240451Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Short dcid=06c59469575e9079 key_phase=false len=1165 pn=3 
[2025-09-12T06:30:08.430243146Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[8f, 30, 89, 92, 02, eb, c7, af, ba, 93, 63, ff, 1c, b9, 6d, 77, e9, 94, 30, b7] reset_token=[8f, 34, 5e, 69, f7, ba, 88, 81, 95, 10, ce, 2d, 7e, 8c, 14, 7f]
[2025-09-12T06:30:08.430249849Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[b9, dc, 38, ff, 61, 27, fe, 54, 77, 46, 92, bb, 39, f2, 77, 7c, 9d, 4d, b8, 1f] reset_token=[7d, 43, 07, 3f, a7, 0d, 0d, 67, 20, 1e, 6e, c8, 5a, f5, 69, 85]
[2025-09-12T06:30:08.430255389Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[10, 83, 0d, 17, e8, 13, 9a, 1a, 4f, fd, 3a, c9, 09, 8d, 68, 9d, 0f, 56, 6d, c7] reset_token=[30, 7b, f4, a1, 22, aa, 48, f9, 86, 16, 5d, e3, 7f, a8, d0, cd]
[2025-09-12T06:30:08.430260769Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[d3, 69, d8, ba, 73, b1, 90, 5e, 40, be, 8e, 4b, 80, 0c, 78, f2, 7a, 25, 69, 91] reset_token=[3c, f9, 3d, 35, 04, 36, d6, be, 90, d1, bb, a5, 3d, 56, 55, 00]
[2025-09-12T06:30:08.430266129Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[bc, 0f, dc, 02, 50, 6e, 6a, ac, 7d, 3f, 9c, 39, 5b, c2, 09, ef, d4, 98, 3c, 50] reset_token=[72, e1, c1, 1c, 05, 9a, 9b, d1, e8, 7a, 48, dd, da, 3d, 43, ca]
[2025-09-12T06:30:08.430271549Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[1c, 94, 43, dd, 7d, 2a, b3, 2f, b9, 82, 60, ff, 86, d8, dc, b7, 77, ca, 49, 09] reset_token=[2c, 66, 34, 66, 07, fe, 10, 40, 9f, e9, aa, 60, a8, ea, e4, 02]
[2025-09-12T06:30:08.430300764Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[0e, cd, a1, 94, 8c, 81, 57, ec, c7, 5c, da, c8, b7, cf, 71, 17, 11, b4, 17, 0e] reset_token=[17, 7d, ef, c5, a9, f0, ed, 79, f0, 40, c3, 47, 61, 50, 5f, 55]
[2025-09-12T06:30:08.430306294Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm STREAM id=2 off=0 len=19 fin=false
[2025-09-12T06:30:08.430308909Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm PADDING len=861
[2025-09-12T06:30:08.430332854Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=101.383265ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1290 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1191, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 219875284 }, next_time: Instant { tv_sec: 727, tv_nsec: 220073910 }, max_datagram_size: 1350, last_packet_size: Some(1191), 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-09-12T06:30:08.430372879Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:58382 to 193.167.100.100:443
[2025-09-12T06:30:08.430386083Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Short dcid=06c59469575e9079 key_phase=false len=6 pn=4 
[2025-09-12T06:30:08.430390402Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm STREAM id=6 off=0 len=1 fin=false
[2025-09-12T06:30:08.430399619Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=101.316219ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1322 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 220107970 }, next_time: Instant { tv_sec: 727, tv_nsec: 220073910 }, max_datagram_size: 1350, last_packet_size: None, iv: 2.453729ms, 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-09-12T06:30:08.430437389Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:58382 to 193.167.100.100:443
[2025-09-12T06:30:08.430448590Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Short dcid=06c59469575e9079 key_phase=false len=6 pn=5 
[2025-09-12T06:30:08.430456806Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm STREAM id=10 off=0 len=1 fin=false
[2025-09-12T06:30:08.430465883Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=101.250006ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1354 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 32, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 220107970 }, next_time: Instant { tv_sec: 727, tv_nsec: 222625448 }, max_datagram_size: 1350, last_packet_size: Some(32), 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-09-12T06:30:08.430506388Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:58382 to 193.167.100.100:443
[2025-09-12T06:30:08.430517860Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Short dcid=06c59469575e9079 key_phase=false len=73 pn=6 
[2025-09-12T06:30:08.430522118Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm STREAM id=0 off=0 len=68 fin=true
[2025-09-12T06:30:08.430531515Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=101.184233ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1453 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 220240868 }, next_time: Instant { tv_sec: 727, tv_nsec: 222625448 }, max_datagram_size: 1350, last_packet_size: None, iv: 262.828µ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-09-12T06:30:08.430563335Z TRACE quiche_apps::client] written 99 bytes from 0.0.0.0:58382 to 193.167.100.100:443
[2025-09-12T06:30:08.430570138Z TRACE quiche_apps::client] 0.0.0.0:58382 -> 193.167.100.100:443: done writing
[2025-09-12T06:30:08.463386811Z TRACE quiche_apps::client] got 583 bytes from 193.167.100.100:443 to 0.0.0.0:58382
[2025-09-12T06:30:08.463405856Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx pkt Short dcid=1cd2a6904e8fedb6173c978f605302d7a20d1785 key_phase=false len=562 pn=2 
[2025-09-12T06:30:08.463416136Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm CRYPTO off=0 len=540
[2025-09-12T06:30:08.463443367Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm HANDSHAKE_DONE
[2025-09-12T06:30:08.463448727Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 dropped epoch 1 state
[2025-09-12T06:30:08.463459407Z TRACE quiche_apps::client] 0.0.0.0:58382: processed 583 bytes
[2025-09-12T06:30:08.463464666Z TRACE quiche_apps::client] 0.0.0.0:58382: recv() would block
[2025-09-12T06:30:08.463467903Z TRACE quiche_apps::client] done reading
[2025-09-12T06:30:08.463479033Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Short dcid=06c59469575e9079 key_phase=false len=5 pn=7 
[2025-09-12T06:30:08.463482891Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm ACK delay=9 blocks=[2..2] ecn_counts=None
[2025-09-12T06:30:08.463493400Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=93.588132ms latest_rtt=33.856588ms srtt=33.856588ms min_rtt=33.856588ms rttvar=16.928294ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1354 app_limited=true congestion_recovery_start_time=None Rate { delivered: 620, delivered_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 219709254 }, end_of_app_limited: 5, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 146.50 Kbps, is_app_limited: true, interval: 33.856588ms, delivered: 620, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 185645238 }), send_elapsed: 0ns, ack_elapsed: 33.856588ms, rtt: 33.856588ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 498425, last_update: Instant { tv_sec: 727, tv_nsec: 253201731 }, next_time: Instant { tv_sec: 727, tv_nsec: 253464559 }, 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-09-12T06:30:08.463555917Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:58382 to 193.167.100.100:443
[2025-09-12T06:30:08.463567268Z TRACE quiche_apps::client] 0.0.0.0:58382 -> 193.167.100.100:443: done writing
[2025-09-12T06:30:08.463670782Z TRACE quiche_apps::client] got 314 bytes from 193.167.100.100:443 to 0.0.0.0:58382
[2025-09-12T06:30:08.463677695Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 dropped invalid packet
[2025-09-12T06:30:08.463681452Z TRACE quiche_apps::client] 0.0.0.0:58382: processed 314 bytes
[2025-09-12T06:30:08.463686421Z TRACE quiche_apps::client] got 48 bytes from 193.167.100.100:443 to 0.0.0.0:58382
[2025-09-12T06:30:08.463690799Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx pkt Short dcid=1cd2a6904e8fedb6173c978f605302d7a20d1785 key_phase=false len=27 pn=5 
[2025-09-12T06:30:08.463698143Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm ACK delay=17 blocks=[3..6] ecn_counts=None
[2025-09-12T06:30:08.463702892Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 packet newly acked 3
[2025-09-12T06:30:08.463706859Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 packet newly acked 4
[2025-09-12T06:30:08.463710276Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 packet newly acked 5
[2025-09-12T06:30:08.463713281Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 packet newly acked 6
[2025-09-12T06:30:08.463718120Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 rx frm STREAM id=0 off=0 len=0 fin=true
[2025-09-12T06:30:08.463736214Z TRACE quiche_apps::client] 0.0.0.0:58382: processed 48 bytes
[2025-09-12T06:30:08.463741003Z TRACE quiche_apps::client] 0.0.0.0:58382: recv() would block
[2025-09-12T06:30:08.463744109Z TRACE quiche_apps::client] done reading
[2025-09-12T06:30:08.463750050Z TRACE quiche::h3] 1cd2a6904e8fedb6173c978f605302d7a20d1785 stream id 0 is readable
[2025-09-12T06:30:08.463765809Z TRACE quiche::h3::stream] 1cd2a6904e8fedb6173c978f605302d7a20d1785 read 0 bytes on stream 0
[2025-09-12T06:30:08.463769797Z DEBUG quiche_apps::common] 1/1 responses received
[2025-09-12T06:30:08.463773003Z INFO  quiche_apps::common] 1/1 response(s) received in 67.712043ms, closing...
[2025-09-12T06:30:08.463782911Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx pkt Short dcid=06c59469575e9079 key_phase=false len=11 pn=8 
[2025-09-12T06:30:08.463786388Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 tx frm APPLICATION_CLOSE err=100 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-09-12T06:30:08.463795104Z TRACE quiche::recovery::congestion::recovery] 1cd2a6904e8fedb6173c978f605302d7a20d1785 timer=112.30521ms latest_rtt=30.792787ms srtt=33.473612ms min_rtt=30.792787ms rttvar=13.46217ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=37 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1974, delivered_time: Instant { tv_sec: 727, tv_nsec: 253464559 }, first_sent_time: Instant { tv_sec: 727, tv_nsec: 253464559 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 6, rate_sample: RateSample { bandwidth: 321.34 Kbps, is_app_limited: true, interval: 33.708981ms, delivered: 1354, prior_delivered: 620, prior_time: Some(Instant { tv_sec: 727, tv_nsec: 219709254 }), send_elapsed: 2.916194ms, ack_elapsed: 33.708981ms, rtt: 30.792787ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 504128, last_update: Instant { tv_sec: 727, tv_nsec: 253507041 }, next_time: Instant { tv_sec: 727, tv_nsec: 253464559 }, max_datagram_size: 1350, last_packet_size: None, iv: 73.394µ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-09-12T06:30:08.463848544Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:58382 to 193.167.100.100:443
[2025-09-12T06:30:08.463857440Z TRACE quiche_apps::client] 0.0.0.0:58382 -> 193.167.100.100:443: done writing
[2025-09-12T06:30:08.726170435Z TRACE quiche_apps::client] timed out
[2025-09-12T06:30:08.726183700Z TRACE quiche] 1cd2a6904e8fedb6173c978f605302d7a20d1785 draining timeout expired
[2025-09-12T06:30:08.726210560Z TRACE quiche_apps::client] done reading
[2025-09-12T06:30:08.726215599Z INFO  quiche_apps::client] connection closed, recv=4 sent=9 lost=0 retrans=0 sent_bytes=2201 recv_bytes=1883 lost_bytes=0 [local_addr=0.0.0.0:58382 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=4 sent=9 lost=0 retrans=0 rtt=33.473612ms min_rtt=Some(30.792787ms) rttvar=13.46217ms cwnd=13500 sent_bytes=2201 recv_bytes=1883 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=40167]