[2025-12-14T03:31:10.134050742Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-12-14T03:31:10.134349849Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:47601 with scid 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc
[2025-12-14T03:31:10.134409420Z TRACE quiche::tls] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc write message lvl=Initial len=329
[2025-12-14T03:31:10.134432443Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Initial version=1 dcid=f0d176ed0b1100533d2c9698c1047b88 scid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc len=333 pn=0 
[2025-12-14T03:31:10.134436340Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm CRYPTO off=0 len=329
[2025-12-14T03:31:10.134450065Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=998.908509ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=396 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 248, tv_nsec: 199215231 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 199215231 }, 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: 248, tv_nsec: 199215231 }, next_time: Instant { tv_sec: 248, tv_nsec: 199215231 }, 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-12-14T03:31:10.134537689Z TRACE quiche_apps::client] written 1200
[2025-12-14T03:31:10.176501473Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.176533803Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Initial version=1 dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc scid=1e5b349de5908dc9 token= len=947 pn=0 
[2025-12-14T03:31:10.176551906Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm ACK delay=0 blocks=[0..0] ecn_counts=None
[2025-12-14T03:31:10.176560653Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc packet newly acked 0
[2025-12-14T03:31:10.176568938Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm CRYPTO off=0 len=96
[2025-12-14T03:31:10.176674234Z TRACE quiche::tls] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc set write secret lvl=Handshake
[2025-12-14T03:31:10.176686176Z TRACE quiche::tls] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc set read secret lvl=Handshake
[2025-12-14T03:31:10.176699531Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm PADDING len=825
[2025-12-14T03:31:10.176725219Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Handshake version=1 dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc scid=1e5b349de5908dc9 len=178 pn=0 
[2025-12-14T03:31:10.176731851Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm CRYPTO off=0 len=157
[2025-12-14T03:31:10.176764242Z TRACE quiche::tls] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc write message lvl=Handshake len=36
[2025-12-14T03:31:10.176768790Z TRACE quiche::tls] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc set write secret lvl=OneRTT
[2025-12-14T03:31:10.176776705Z TRACE quiche::tls] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc set read secret lvl=OneRTT
[2025-12-14T03:31:10.176796031Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=true TransportParams { original_destination_connection_id: Some(f0d176ed0b1100533d2c9698c1047b88), max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 1500, initial_max_data: 10000000, initial_max_stream_data_bidi_local: 1000000, initial_max_stream_data_bidi_remote: 1000000, initial_max_stream_data_uni: 1000000, initial_max_streams_bidi: 100, initial_max_streams_uni: 0, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: true, active_conn_id_limit: 3, initial_source_connection_id: Some(1e5b349de5908dc9), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-12-14T03:31:10.176832979Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1200 bytes
[2025-12-14T03:31:10.176839271Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.176843429Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.176853808Z DEBUG quiche_apps::common] sending HTTP request "GET /dull-mild-ninja\r\n"
[2025-12-14T03:31:10.176926043Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Initial version=1 dcid=1e5b349de5908dc9 scid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc len=5 pn=1 
[2025-12-14T03:31:10.176931774Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=49 blocks=[0..0] ecn_counts=None
[2025-12-14T03:31:10.176944948Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=126.084263ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 241648499 }, next_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, 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-12-14T03:31:10.176973852Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Handshake version=1 dcid=1e5b349de5908dc9 scid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc len=45 pn=2 
[2025-12-14T03:31:10.176978230Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=30 blocks=[0..0] ecn_counts=None
[2025-12-14T03:31:10.176982227Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm CRYPTO off=0 len=36
[2025-12-14T03:31:10.176989892Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=126.428764ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=99 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 241772019 }, next_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, max_datagram_size: 1350, last_packet_size: None, iv: 247.384µ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-12-14T03:31:10.177012945Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc dropped epoch 0 state
[2025-12-14T03:31:10.177029876Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=1165 pn=3 
[2025-12-14T03:31:10.177033864Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[cb, af, d7, e9, c9, ab, 68, f7, 32, 7f, 9e, 80, f5, 98, 95, fd, 3e, b8, 3a, 9b] reset_token=[5b, fb, a2, a5, d8, fc, f5, 24, 4a, 3d, 15, 60, 9f, f9, 14, 9e]
[2025-12-14T03:31:10.177042780Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[84, 3d, f2, cd, 00, 14, b4, 1c, 96, d5, 30, 83, 8d, d0, 85, 6c, 8e, 82, d7, 8c] reset_token=[61, 6c, a1, 52, af, 9c, e8, 45, 9a, c6, 10, 01, 21, da, 31, 15]
[2025-12-14T03:31:10.177050715Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm STREAM id=0 off=0 len=22 fin=true
[2025-12-14T03:31:10.177054642Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm PADDING len=1058
[2025-12-14T03:31:10.177063839Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=126.354756ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1290 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1191, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 241772019 }, next_time: Instant { tv_sec: 248, tv_nsec: 242019403 }, 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-12-14T03:31:10.177117619Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.177129221Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.211777316Z TRACE quiche_apps::client] got 41 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.211817371Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=20 pn=0 
[2025-12-14T03:31:10.211835224Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm HANDSHAKE_DONE
[2025-12-14T03:31:10.211845072Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc dropped epoch 1 state
[2025-12-14T03:31:10.211850572Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm PADDING len=2
[2025-12-14T03:31:10.211869688Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 41 bytes
[2025-12-14T03:31:10.211876591Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.211880939Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.211901607Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=4 
[2025-12-14T03:31:10.211906907Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=10 blocks=[0..0] ecn_counts=None
[2025-12-14T03:31:10.211922466Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=116.495207ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.212001153Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.212010370Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.212905005Z TRACE quiche_apps::client] got 223 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.212918821Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=202 pn=1 
[2025-12-14T03:31:10.212931735Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[1f, 32, 8c, c2, 2c, 0a, c7, 9f] reset_token=[66, d4, 95, 0c, ab, 2a, dc, 9d, f3, bc, e8, 8c, 64, 1c, 3c, ce]
[2025-12-14T03:31:10.212944779Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[59, 2d, 19, 34, ff, 4f, f3, 11] reset_token=[59, 40, 85, ff, 61, 93, 3f, a0, 4a, d9, 91, c0, 21, 8e, 74, 29]
[2025-12-14T03:31:10.212954497Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[3e, 03, b6, 82, c1, 84, d1, 72] reset_token=[7f, 55, e5, 20, a4, 12, 60, 74, 31, 36, ac, 0e, 37, bb, 3b, 09]
[2025-12-14T03:31:10.212963123Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[a3, e4, 3e, e1, f2, 8b, fe, a4] reset_token=[76, 21, 3e, 86, 19, 99, c0, 8f, ea, 09, b3, 87, 23, 4a, a4, 8d]
[2025-12-14T03:31:10.212972010Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[a9, 16, 1b, 62, 50, 53, b9, 23] reset_token=[45, f4, 98, ab, 22, d4, 0b, cc, cb, ee, 95, f0, 82, af, 64, 50]
[2025-12-14T03:31:10.212979915Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm CRYPTO off=0 len=42
[2025-12-14T03:31:10.213019288Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 223 bytes
[2025-12-14T03:31:10.213026691Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.213031140Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.213050506Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=5 
[2025-12-14T03:31:10.213055295Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=16 blocks=[0..1] ecn_counts=None
[2025-12-14T03:31:10.213065794Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=115.35237ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.213122320Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.213130455Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.215126130Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.215139414Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=2 
[2025-12-14T03:31:10.215165753Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=0 len=1209 fin=false
[2025-12-14T03:31:10.215180611Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.215185330Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.215188305Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.215193796Z TRACE quiche_apps::common] received 1209 bytes
[2025-12-14T03:31:10.215197472Z TRACE quiche_apps::common] stream 0 has 1209 bytes (fin? false)
[2025-12-14T03:31:10.215206559Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=6 
[2025-12-14T03:31:10.215209855Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=8 blocks=[0..2] ecn_counts=None
[2025-12-14T03:31:10.215217409Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=113.201306ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.215254969Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.215260259Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.216160144Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.216171365Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=3 
[2025-12-14T03:31:10.216183598Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=1209 len=1208 fin=false
[2025-12-14T03:31:10.216191442Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.216195560Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.216198426Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.216202823Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.216205549Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.216212942Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=7 
[2025-12-14T03:31:10.216216168Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=5 blocks=[0..3] ecn_counts=None
[2025-12-14T03:31:10.216223192Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=112.195494ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.216255452Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.216260601Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.217177157Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.217185162Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=4 
[2025-12-14T03:31:10.217191584Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=2417 len=1208 fin=false
[2025-12-14T03:31:10.217220418Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.217224696Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.217227521Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.217232190Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.217234965Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.217242158Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=8 
[2025-12-14T03:31:10.217245224Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=7 blocks=[0..4] ecn_counts=None
[2025-12-14T03:31:10.217251846Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=111.166889ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.217286160Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.217291410Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.218229970Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.218245579Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=5 
[2025-12-14T03:31:10.218258654Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=3625 len=1208 fin=false
[2025-12-14T03:31:10.218273581Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.218277959Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.218280915Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.218285924Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.218288980Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.218297806Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=9 
[2025-12-14T03:31:10.218301203Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=6 blocks=[0..5] ecn_counts=None
[2025-12-14T03:31:10.218308687Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=110.110019ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.218350805Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.218360323Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.219222598Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.219231004Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=6 
[2025-12-14T03:31:10.219244859Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=4833 len=1208 fin=false
[2025-12-14T03:31:10.219252704Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.219256932Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.219259847Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.219264366Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.219267111Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.219274505Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=10 
[2025-12-14T03:31:10.219277720Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=5 blocks=[0..6] ecn_counts=None
[2025-12-14T03:31:10.219284423Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=109.134322ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 10, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.219321141Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.219329417Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.220237767Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.220246363Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=7 
[2025-12-14T03:31:10.220253417Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=6041 len=1208 fin=false
[2025-12-14T03:31:10.220260720Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.220264778Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.220267733Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.220272212Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.220274997Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.220282010Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=11 
[2025-12-14T03:31:10.220285366Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=4 blocks=[0..7] ecn_counts=None
[2025-12-14T03:31:10.220292620Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=108.126106ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 11, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.220333897Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.220343043Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.221262725Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.221270910Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=8 
[2025-12-14T03:31:10.221277563Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=7249 len=1208 fin=false
[2025-12-14T03:31:10.221284736Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.221288654Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.221291509Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.221295997Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.221298672Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.221322406Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=12 
[2025-12-14T03:31:10.221325903Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=6 blocks=[0..8] ecn_counts=None
[2025-12-14T03:31:10.221332836Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=107.0859ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 12, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.221367881Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.221376988Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.222287513Z TRACE quiche_apps::client] got 1252 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.222295778Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=1231 pn=9 
[2025-12-14T03:31:10.222307069Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=8457 len=1208 fin=false
[2025-12-14T03:31:10.222314373Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 1252 bytes
[2025-12-14T03:31:10.222318340Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.222321196Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.222325734Z TRACE quiche_apps::common] received 1208 bytes
[2025-12-14T03:31:10.222328439Z TRACE quiche_apps::common] stream 0 has 1208 bytes (fin? false)
[2025-12-14T03:31:10.222335512Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=5 pn=13 
[2025-12-14T03:31:10.222338618Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm ACK delay=4 blocks=[0..9] ecn_counts=None
[2025-12-14T03:31:10.222345000Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=106.073796ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1191 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 2, last_sent_packet: 13, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 276744037 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, 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-12-14T03:31:10.222380576Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.222389262Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.222808322Z TRACE quiche_apps::client] got 622 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.222813963Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx pkt Short dcid=32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc key_phase=false len=601 pn=10 
[2025-12-14T03:31:10.222820144Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm STREAM id=0 off=9665 len=575 fin=true
[2025-12-14T03:31:10.222823921Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc rx frm MAX_STREAMS type=bidi max=101
[2025-12-14T03:31:10.222831095Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 622 bytes
[2025-12-14T03:31:10.222835012Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.222837837Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.222842326Z TRACE quiche_apps::common] received 575 bytes
[2025-12-14T03:31:10.222845001Z TRACE quiche_apps::common] stream 0 has 575 bytes (fin? true)
[2025-12-14T03:31:10.222847806Z DEBUG quiche_apps::common] 1/1 responses received
[2025-12-14T03:31:10.222850621Z INFO  quiche_apps::common] 1/1 response(s) received in 88.306661ms, closing...
[2025-12-14T03:31:10.222857394Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx pkt Short dcid=1e5b349de5908dc9 key_phase=false len=10 pn=14 
[2025-12-14T03:31:10.222860590Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-12-14T03:31:10.222868464Z TRACE quiche::recovery::congestion::recovery] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc timer=151.488615ms latest_rtt=42.167674ms srtt=42.167674ms min_rtt=42.167674ms rttvar=21.083837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1227 app_limited=true congestion_recovery_start_time=None Rate { delivered: 396, delivered_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, first_sent_time: Instant { tv_sec: 248, tv_nsec: 241648539 }, end_of_app_limited: 13, last_sent_packet: 14, largest_acked: 0, rate_sample: RateSample { bandwidth: 75.13 Kbps, is_app_limited: true, interval: 42.167674ms, delivered: 396, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 248, tv_nsec: 199215231 }), send_elapsed: 0ns, ack_elapsed: 42.167674ms, rtt: 42.167674ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 400188, last_update: Instant { tv_sec: 248, tv_nsec: 287710473 }, next_time: Instant { tv_sec: 248, tv_nsec: 276744037 }, max_datagram_size: 1350, last_packet_size: None, iv: 89.958µ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-12-14T03:31:10.222909881Z TRACE quiche_apps::client] written 36 bytes from 0.0.0.0:47601 to 193.167.100.100:443
[2025-12-14T03:31:10.222917886Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.233136678Z TRACE quiche_apps::client] got 44 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.233170180Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 44 bytes
[2025-12-14T03:31:10.233177253Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.233181812Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.233188124Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.254335238Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:47601
[2025-12-14T03:31:10.254350837Z TRACE quiche_apps::client] 0.0.0.0:47601: processed 42 bytes
[2025-12-14T03:31:10.254356637Z TRACE quiche_apps::client] 0.0.0.0:47601: recv() would block
[2025-12-14T03:31:10.254360605Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.254366145Z TRACE quiche_apps::client] 0.0.0.0:47601 -> 193.167.100.100:443: done writing
[2025-12-14T03:31:10.602741277Z TRACE quiche_apps::client] timed out
[2025-12-14T03:31:10.602762506Z TRACE quiche] 32e55d5bbdf888cd3e28bfe2eeb38ccbbb2ab5dc draining timeout expired
[2025-12-14T03:31:10.602797191Z TRACE quiche_apps::client] done reading
[2025-12-14T03:31:10.602802962Z INFO  quiche_apps::client] connection closed, recv=13 sent=15 lost=0 retrans=0 sent_bytes=2092 recv_bytes=12102 lost_bytes=0 [local_addr=0.0.0.0:47601 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=13 sent=15 lost=0 retrans=0 rtt=42.167674ms min_rtt=Some(42.167674ms) rttvar=21.083837ms cwnd=13500 sent_bytes=2092 recv_bytes=12102 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=9391]