[2025-04-30T19:22:47.948336300Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T19:22:47.948649437Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:59370 with scid 02693c35a8deadc681d2e4fc1d4127041b1e262f
[2025-04-30T19:22:47.948692117Z TRACE quiche::tls] 02693c35a8deadc681d2e4fc1d4127041b1e262f write message lvl=Initial len=266
[2025-04-30T19:22:47.948712836Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Initial version=1 dcid=b6dd009f9cd5cf973342e773fe7dac25 scid=02693c35a8deadc681d2e4fc1d4127041b1e262f len=270 pn=0 
[2025-04-30T19:22:47.948716463Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm CRYPTO off=0 len=266
[2025-04-30T19:22:47.948754093Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=998.901575ms 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: 160, tv_nsec: 950932525 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 950932525 }, 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: 160, tv_nsec: 950932525 }, next_time: Instant { tv_sec: 160, tv_nsec: 950932525 }, 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-30T19:22:47.948848480Z TRACE quiche_apps::client] written 1200
[2025-04-30T19:22:47.990695588Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:59370
[2025-04-30T19:22:47.990724272Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Initial version=1 dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f scid=f6b19a2637c5b946 token= len=118 pn=0 
[2025-04-30T19:22:47.990767803Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm ACK delay=456 blocks=[0..0] ecn_counts=None
[2025-04-30T19:22:47.990775688Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f packet newly acked 0
[2025-04-30T19:22:47.990782812Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm CRYPTO off=0 len=90
[2025-04-30T19:22:47.990899290Z TRACE quiche::tls] 02693c35a8deadc681d2e4fc1d4127041b1e262f set write secret lvl=Handshake
[2025-04-30T19:22:47.990912895Z TRACE quiche::tls] 02693c35a8deadc681d2e4fc1d4127041b1e262f set read secret lvl=Handshake
[2025-04-30T19:22:47.990951488Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Handshake version=1 dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f scid=f6b19a2637c5b946 len=755 pn=1 
[2025-04-30T19:22:47.990958861Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm CRYPTO off=0 len=733
[2025-04-30T19:22:47.991223848Z TRACE quiche::tls] 02693c35a8deadc681d2e4fc1d4127041b1e262f write message lvl=Handshake len=52
[2025-04-30T19:22:47.991228947Z TRACE quiche::tls] 02693c35a8deadc681d2e4fc1d4127041b1e262f set write secret lvl=OneRTT
[2025-04-30T19:22:47.991238826Z TRACE quiche::tls] 02693c35a8deadc681d2e4fc1d4127041b1e262f set read secret lvl=OneRTT
[2025-04-30T19:22:47.991260496Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f connection established: proto=Ok("h3") cipher=Some(AES256_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=false TransportParams { original_destination_connection_id: Some(b6dd009f9cd5cf973342e773fe7dac25), max_idle_timeout: 60000, stateless_reset_token: Some(89080809928216645481429069381714119607), max_udp_payload_size: 65527, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 1048576, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 1048576, initial_max_streams_bidi: 128, initial_max_streams_uni: 128, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(f6b19a2637c5b946), retry_source_connection_id: None, max_datagram_frame_size: Some(65536), unknown_params: None }
[2025-04-30T19:22:47.991295462Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Short dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f key_phase=false len=231 pn=2 
[2025-04-30T19:22:47.991302495Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm CRYPTO off=0 len=89
[2025-04-30T19:22:47.991317964Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm STREAM id=3 off=0 len=19 fin=false
[2025-04-30T19:22:47.991323625Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm STREAM id=7 off=0 len=1 fin=false
[2025-04-30T19:22:47.991326841Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm STREAM id=11 off=0 len=1 fin=false
[2025-04-30T19:22:47.991330418Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm PADDING len=87
[2025-04-30T19:22:47.991336108Z TRACE quiche_apps::client] 0.0.0.0:59370: processed 1200 bytes
[2025-04-30T19:22:47.991340777Z TRACE quiche_apps::client] 0.0.0.0:59370: recv() would block
[2025-04-30T19:22:47.991343542Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:47.991357759Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm SETTINGS stream=2 len=18
[2025-04-30T19:22:47.991370152Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f open GREASE stream 14
[2025-04-30T19:22:47.991379660Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm GREASE stream=0 len=0
[2025-04-30T19:22:47.991385170Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm GREASE stream=0 len=18
[2025-04-30T19:22:47.991392303Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm HEADERS stream=0 len=30 fin=true
[2025-04-30T19:22:47.991399006Z DEBUG quiche_apps::common] Sent HTTP request [":method: GET", ":scheme: https", ":authority: server4", ":path: /ieodbkkzvc", "user-agent: quiche"]
[2025-04-30T19:22:47.991456524Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f stream id 3 is readable
[2025-04-30T19:22:47.991462766Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 3
[2025-04-30T19:22:47.991466733Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f open peer's control stream 3
[2025-04-30T19:22:47.991470029Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 3
[2025-04-30T19:22:47.991473115Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 3
[2025-04-30T19:22:47.991476621Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 16 bytes on stream 3
[2025-04-30T19:22:47.991480078Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm SETTINGS max_field_section=None, qpack_max_table=Some(4096), qpack_blocked=Some(16) raw=Some([(1, 4096), (7, 16), (8, 1), (33, 1), (51, 1), (727725890, 1)]), additional_settings=Some([(33, 1), (727725890, 1)]) stream=3 payload_len=16
[2025-04-30T19:22:47.991489255Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f stream id 7 is readable
[2025-04-30T19:22:47.991492601Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 7
[2025-04-30T19:22:47.991495998Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f stream id 11 is readable
[2025-04-30T19:22:47.991499434Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 11
[2025-04-30T19:22:47.991522708Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Initial version=1 dcid=f6b19a2637c5b946 scid=02693c35a8deadc681d2e4fc1d4127041b1e262f len=6 pn=1 
[2025-04-30T19:22:47.991525613Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm ACK delay=100 blocks=[0..0] ecn_counts=None
[2025-04-30T19:22:47.991553656Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=125.338553ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 993533586 }, next_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, 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-30T19:22:47.991575557Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Handshake version=1 dcid=f6b19a2637c5b946 scid=02693c35a8deadc681d2e4fc1d4127041b1e262f len=62 pn=2 
[2025-04-30T19:22:47.991578322Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm ACK delay=77 blocks=[1..1] ecn_counts=None
[2025-04-30T19:22:47.991580977Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm CRYPTO off=0 len=52
[2025-04-30T19:22:47.991587028Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=126.104368ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=116 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 993790287 }, next_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, max_datagram_size: 1350, last_packet_size: None, iv: 289.116µ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-30T19:22:47.991599341Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f dropped epoch 0 state
[2025-04-30T19:22:47.991603719Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13384 out_len=1173 left=1142
[2025-04-30T19:22:47.991615732Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=1147 pn=3 
[2025-04-30T19:22:47.991618397Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm ACK delay=38 blocks=[2..2] ecn_counts=None
[2025-04-30T19:22:47.991621072Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[70, d7, ac, d6, 48, d0, a2, 71, fa, 99, aa, 30, 43, 4f, cd, a4, f4, e7, e3, 09] reset_token=[ac, d3, 12, 85, d6, e9, 38, 09, ec, e9, cc, 4f, 33, 32, 85, fa]
[2025-04-30T19:22:47.991628035Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[92, 40, dd, 23, 43, 52, e9, 29, 8d, 4a, f5, 35, c2, e9, 44, f1, 34, b1, d3, 78] reset_token=[2c, ce, 5e, aa, 41, 28, d0, 7e, b1, bc, e2, 62, 67, bd, be, 5b]
[2025-04-30T19:22:47.991637092Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c7, af, d2, 35, 64, b3, a1, c3, 23, 67, 91, ee, 58, e3, 50, e8, 45, 22, 3c, 6f] reset_token=[5e, b6, ed, d9, d0, 33, b2, 5f, e1, 38, d5, 3e, 3a, b9, 90, 2d]
[2025-04-30T19:22:47.991642753Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[d2, df, 0a, 10, b7, ed, 45, 9d, b6, ce, 99, fa, 79, 94, 3b, 01, d3, 69, 2d, c3] reset_token=[fc, 19, 9e, 87, 17, 93, 6c, 8d, 82, 96, ed, 36, dd, ce, c1, 68]
[2025-04-30T19:22:47.991648443Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[6c, 0b, 1c, bc, 3a, e6, db, 1c, 83, 58, 7e, 31, 3d, 68, 39, 87, e2, 7f, 48, 3b] reset_token=[50, f2, cb, 53, ab, a4, 7d, a5, db, bc, 48, 0f, 21, e0, 2b, 37]
[2025-04-30T19:22:47.991654174Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[64, 05, fd, 47, cf, 53, 37, a6, b7, 59, 0c, 1b, 93, 99, 5d, 3b, 3f, 6f, 89, 9a] reset_token=[58, 2b, 94, 33, b9, 57, 5d, c5, d2, 1b, 75, b4, 0a, 24, 76, b0]
[2025-04-30T19:22:47.991659835Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[85, e8, d3, f7, ac, 6a, e7, 92, 4e, 6b, fa, 36, 47, 61, 70, 42, 26, a6, 94, aa] reset_token=[43, 52, b0, b6, 5b, 76, 1a, 5b, 72, f1, 20, a0, 2d, e0, 16, 49]
[2025-04-30T19:22:47.991665325Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm STREAM id=2 off=0 len=19 fin=false
[2025-04-30T19:22:47.991667970Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm PADDING len=838
[2025-04-30T19:22:47.991677418Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=126.013989ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1289 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1173, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 993790287 }, next_time: Instant { tv_sec: 160, tv_nsec: 994079403 }, max_datagram_size: 1350, last_packet_size: Some(1173), 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-30T19:22:47.991722212Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:47.991752378Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12211 out_len=1350 left=1324
[2025-04-30T19:22:47.991758950Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=6 pn=4 
[2025-04-30T19:22:47.991763068Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm STREAM id=6 off=0 len=1 fin=false
[2025-04-30T19:22:47.991772346Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=125.91839ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1321 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 994023283 }, next_time: Instant { tv_sec: 160, tv_nsec: 994079403 }, max_datagram_size: 1350, last_packet_size: None, iv: 3.003317ms, 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-30T19:22:47.991818051Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:47.991828080Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12179 out_len=1350 left=1324
[2025-04-30T19:22:47.991834222Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=6 pn=5 
[2025-04-30T19:22:47.991838059Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm STREAM id=10 off=0 len=1 fin=false
[2025-04-30T19:22:47.991847156Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=125.84387ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1353 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 32, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 994023283 }, next_time: Instant { tv_sec: 160, tv_nsec: 997102913 }, 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-04-30T19:22:47.991882702Z TRACE quiche_apps::client] written 32 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:47.991892320Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12147 out_len=1350 left=1324
[2025-04-30T19:22:47.991898412Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=73 pn=6 
[2025-04-30T19:22:47.991902249Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm STREAM id=0 off=0 len=68 fin=true
[2025-04-30T19:22:47.991911486Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=125.77963ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1452 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 994163837 }, next_time: Instant { tv_sec: 160, tv_nsec: 997102913 }, max_datagram_size: 1350, last_packet_size: None, iv: 326.502µ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-30T19:22:47.991951742Z TRACE quiche_apps::client] written 99 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:47.991961029Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12048 out_len=1350 left=1324
[2025-04-30T19:22:47.991966840Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=31 pn=7 
[2025-04-30T19:22:47.991970677Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm STREAM id=14 off=0 len=26 fin=true
[2025-04-30T19:22:47.991980476Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=125.71054ms latest_rtt=42.058875ms srtt=42.058875ms min_rtt=42.058875ms rttvar=21.029437ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1509 app_limited=true congestion_recovery_start_time=None Rate { delivered: 333, delivered_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 993533626 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { delivery_rate: 7917, is_app_limited: true, interval: 42.058875ms, delivered: 333, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 950932525 }), send_elapsed: 0ns, ack_elapsed: 42.058875ms, rtt: 42.058875ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 57, rate: 401223, last_update: Instant { tv_sec: 160, tv_nsec: 994163837 }, next_time: Instant { tv_sec: 160, tv_nsec: 997429415 }, max_datagram_size: 1350, last_packet_size: Some(57), 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-30T19:22:47.992014680Z TRACE quiche_apps::client] written 57 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:47.992021402Z TRACE quiche_apps::client] 0.0.0.0:59370 -> 193.167.100.100:443: done writing
[2025-04-30T19:22:48.024586037Z TRACE quiche_apps::client] got 242 bytes from 193.167.100.100:443 to 0.0.0.0:59370
[2025-04-30T19:22:48.024602719Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Short dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f key_phase=false len=221 pn=3 
[2025-04-30T19:22:48.024613529Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm ACK delay=125 blocks=[3..3] ecn_counts=None
[2025-04-30T19:22:48.024618458Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f packet newly acked 3
[2025-04-30T19:22:48.024623527Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm HANDSHAKE_DONE
[2025-04-30T19:22:48.024628817Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f dropped epoch 1 state
[2025-04-30T19:22:48.024633586Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[f5, 42, fb, 12, 5c, cd, 2d, 64] reset_token=[d6, 93, ca, a7, f4, 7b, 6e, 88, ab, cc, 47, c2, 4b, ad, 3e, e7]
[2025-04-30T19:22:48.024646991Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[58, b7, 2c, 73, 46, 23, c8, 0f] reset_token=[9c, 82, 36, f7, 28, 55, 71, 0a, 77, d3, 4f, 0e, 3e, 10, a6, 30]
[2025-04-30T19:22:48.024652512Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[45, ab, f8, 85, e1, 0d, 47, 91] reset_token=[ae, b3, ed, 5a, b7, a6, 02, f9, 6b, 7a, 23, 4d, df, b5, e0, 60]
[2025-04-30T19:22:48.024657121Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[17, b5, df, 38, f6, 0e, a5, 4a] reset_token=[af, 9d, f7, dc, 5e, 91, 40, c3, 98, f0, 3c, 02, 4d, ea, aa, 2f]
[2025-04-30T19:22:48.024662050Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[cc, c3, 5d, 3d, c5, 8e, 94, 41] reset_token=[3d, 56, 31, c1, 41, d2, b4, 21, 3b, 7b, 6e, 31, 09, f7, 04, ea]
[2025-04-30T19:22:48.024666638Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[7f, 4d, 5c, cd, 5c, 1b, e1, dd] reset_token=[4c, 3d, 22, 34, 38, ed, a1, 61, 70, d7, 1b, 83, b9, 8b, e7, 1c]
[2025-04-30T19:22:48.024671497Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[11, 57, e4, 5b, 2a, 26, e8, 50] reset_token=[a8, 46, 3b, ac, be, 75, 1a, d4, db, c2, dc, 39, 64, dd, 5b, 44]
[2025-04-30T19:22:48.024690643Z TRACE quiche_apps::client] 0.0.0.0:59370: processed 242 bytes
[2025-04-30T19:22:48.024694791Z TRACE quiche_apps::client] 0.0.0.0:59370: recv() would block
[2025-04-30T19:22:48.024697446Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:48.024706583Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13280 out_len=1350 left=1319
[2025-04-30T19:22:48.024711543Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=5 pn=8 
[2025-04-30T19:22:48.024714117Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm ACK delay=13 blocks=[3..3] ecn_counts=None
[2025-04-30T19:22:48.024720970Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=105.489031ms latest_rtt=32.795734ms srtt=40.900981ms min_rtt=32.795734ms rttvar=18.087862ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=220 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1506, delivered_time: Instant { tv_sec: 161, tv_nsec: 26875137 }, first_sent_time: Instant { tv_sec: 160, tv_nsec: 994079403 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 3, rate_sample: RateSample { delivery_rate: 35181, is_app_limited: true, interval: 33.341511ms, delivered: 1173, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 993533626 }), send_elapsed: 545.777µs, ack_elapsed: 33.341511ms, rtt: 32.795734ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 412581, last_update: Instant { tv_sec: 161, tv_nsec: 26977939 }, next_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, 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-30T19:22:48.024789338Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:48.024797093Z TRACE quiche_apps::client] 0.0.0.0:59370 -> 193.167.100.100:443: done writing
[2025-04-30T19:22:48.025569360Z TRACE quiche_apps::client] got 45 bytes from 193.167.100.100:443 to 0.0.0.0:59370
[2025-04-30T19:22:48.025574620Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Short dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f key_phase=false len=24 pn=4 
[2025-04-30T19:22:48.025585340Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm ACK delay=125 blocks=[3..4] ecn_counts=None
[2025-04-30T19:22:48.025588716Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f packet newly acked 4
[2025-04-30T19:22:48.025598494Z TRACE quiche_apps::client] 0.0.0.0:59370: processed 45 bytes
[2025-04-30T19:22:48.025602081Z TRACE quiche_apps::client] 0.0.0.0:59370: recv() would block
[2025-04-30T19:22:48.025604465Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:48.025608724Z TRACE quiche_apps::client] 0.0.0.0:59370 -> 193.167.100.100:443: done writing
[2025-04-30T19:22:48.029506016Z TRACE quiche_apps::client] got 44 bytes from 193.167.100.100:443 to 0.0.0.0:59370
[2025-04-30T19:22:48.029514592Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Short dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f key_phase=false len=23 pn=5 
[2025-04-30T19:22:48.029519952Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm ACK delay=17 blocks=[3..7] ecn_counts=None
[2025-04-30T19:22:48.029523068Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f packet newly acked 5
[2025-04-30T19:22:48.029525432Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f packet newly acked 6
[2025-04-30T19:22:48.029527727Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f packet newly acked 7
[2025-04-30T19:22:48.029539128Z TRACE quiche_apps::client] 0.0.0.0:59370: processed 44 bytes
[2025-04-30T19:22:48.029542785Z TRACE quiche_apps::client] 0.0.0.0:59370: recv() would block
[2025-04-30T19:22:48.029545239Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:48.029549417Z TRACE quiche_apps::client] 0.0.0.0:59370 -> 193.167.100.100:443: done writing
[2025-04-30T19:22:48.032087403Z TRACE quiche_apps::client] got 162 bytes from 193.167.100.100:443 to 0.0.0.0:59370
[2025-04-30T19:22:48.032095257Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Short dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f key_phase=false len=141 pn=6 
[2025-04-30T19:22:48.032100768Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm STREAM id=0 off=0 len=119 fin=false
[2025-04-30T19:22:48.032107250Z TRACE quiche_apps::client] 0.0.0.0:59370: processed 162 bytes
[2025-04-30T19:22:48.032110726Z TRACE quiche_apps::client] 0.0.0.0:59370: recv() would block
[2025-04-30T19:22:48.032113091Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:48.032115615Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f stream id 0 is readable
[2025-04-30T19:22:48.032120004Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 0
[2025-04-30T19:22:48.032123450Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 0
[2025-04-30T19:22:48.032138769Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 0
[2025-04-30T19:22:48.032143227Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 116 bytes on stream 0
[2025-04-30T19:22:48.032146263Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm HEADERS stream=0 payload_len=116
[2025-04-30T19:22:48.032149429Z TRACE quiche::h3::qpack::decoder] Header count=0 base=0
[2025-04-30T19:22:48.032152004Z TRACE quiche::h3::qpack::decoder] Indexed index=25 static=true
[2025-04-30T19:22:48.032156542Z TRACE quiche::h3::qpack::decoder] Literal name_idx=92 static=true value=[97, 105, 111, 113, 117, 105, 99, 47, 49, 46, 50, 46, 48]
[2025-04-30T19:22:48.032163154Z TRACE quiche::h3::qpack::decoder] Literal name_idx=6 static=true value=[87, 101, 100, 44, 32, 51, 48, 32, 65, 112, 114, 32, 50, 48, 50, 53, 32, 49, 57, 58, 50, 50, 58, 52, 56, 32, 71, 77, 84]
[2025-04-30T19:22:48.032168975Z TRACE quiche::h3::qpack::decoder] Literal name_idx=44 static=true value=[116, 101, 120, 116, 47, 112, 108, 97, 105, 110, 59, 32, 99, 104, 97, 114, 115, 101, 116, 61, 117, 116, 102, 45, 56]
[2025-04-30T19:22:48.032175427Z TRACE quiche::h3::qpack::decoder] Literal name_idx=4 static=true value=[49, 48, 50, 52]
[2025-04-30T19:22:48.032178583Z TRACE quiche::h3::qpack::decoder] Literal name_idx=10 static=true value=[87, 101, 100, 44, 32, 51, 48, 32, 65, 112, 114, 32, 50, 48, 50, 53, 32, 49, 57, 58, 50, 50, 58, 52, 54, 32, 71, 77, 84]
[2025-04-30T19:22:48.032183913Z TRACE quiche::h3::qpack::decoder] Literal name_idx=7 static=true value=[34, 49, 101, 54, 49, 100, 53, 49, 53, 98, 57, 100, 48, 49, 102, 49, 49, 48, 54, 56, 57, 52, 50, 97, 48, 57, 97, 49, 101, 97, 49, 54, 98, 34]
[2025-04-30T19:22:48.032194693Z DEBUG quiche_apps::common] got response headers [(":status", "200"), ("server", "aioquic/1.2.0"), ("date", "Wed, 30 Apr 2025 19:22:48 GMT"), ("content-type", "text/plain; charset=utf-8"), ("content-length", "1024"), ("last-modified", "Wed, 30 Apr 2025 19:22:46 GMT"), ("etag", "\"1e61d515b9d01f11068942a09a1ea16b\"")] on stream id 0
[2025-04-30T19:22:48.032204672Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T19:22:48.032208089Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=5 pn=9 
[2025-04-30T19:22:48.032210583Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm ACK delay=13 blocks=[3..6] ecn_counts=None
[2025-04-30T19:22:48.032216945Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=none latest_rtt=34.359418ms srtt=39.286271ms min_rtt=32.795734ms rttvar=12.958117ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1726, delivered_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, first_sent_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 7, rate_sample: RateSample { delivery_rate: 41779, is_app_limited: true, interval: 33.341511ms, delivered: 1393, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 993533626 }), send_elapsed: 545.777µs, ack_elapsed: 33.341511ms, rtt: 32.795734ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 429539, last_update: Instant { tv_sec: 161, tv_nsec: 26977939 }, next_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, 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-30T19:22:48.032257671Z TRACE quiche_apps::client] written 31 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:48.032265296Z TRACE quiche_apps::client] 0.0.0.0:59370 -> 193.167.100.100:443: done writing
[2025-04-30T19:22:48.033344518Z TRACE quiche_apps::client] got 1072 bytes from 193.167.100.100:443 to 0.0.0.0:59370
[2025-04-30T19:22:48.033352553Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx pkt Short dcid=02693c35a8deadc681d2e4fc1d4127041b1e262f key_phase=false len=1051 pn=7 
[2025-04-30T19:22:48.033358815Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm STREAM id=0 off=119 len=1027 fin=true
[2025-04-30T19:22:48.033365878Z TRACE quiche_apps::client] 0.0.0.0:59370: processed 1072 bytes
[2025-04-30T19:22:48.033369445Z TRACE quiche_apps::client] 0.0.0.0:59370: recv() would block
[2025-04-30T19:22:48.033371929Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:48.033374464Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f stream id 0 is readable
[2025-04-30T19:22:48.033378361Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 0
[2025-04-30T19:22:48.033381597Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 0
[2025-04-30T19:22:48.033384603Z TRACE quiche::h3::stream] 02693c35a8deadc681d2e4fc1d4127041b1e262f read 1 bytes on stream 0
[2025-04-30T19:22:48.033391907Z TRACE quiche::h3] 02693c35a8deadc681d2e4fc1d4127041b1e262f rx frm DATA stream=0 wire_payload_len=1024
[2025-04-30T19:22:48.033398529Z DEBUG quiche_apps::common] got 1024 bytes of response data on stream 0
[2025-04-30T19:22:48.033401495Z DEBUG quiche_apps::common] 1/1 responses received
[2025-04-30T19:22:48.033404070Z INFO  quiche_apps::common] 1/1 response(s) received in 84.55084ms, closing...
[2025-04-30T19:22:48.033410241Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1324
[2025-04-30T19:22:48.033413728Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx pkt Short dcid=f6b19a2637c5b946 key_phase=false len=11 pn=10 
[2025-04-30T19:22:48.033416212Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f tx frm APPLICATION_CLOSE err=100 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-04-30T19:22:48.033423135Z TRACE quiche::recovery::congestion::recovery] 02693c35a8deadc681d2e4fc1d4127041b1e262f timer=116.10339ms latest_rtt=34.359418ms srtt=39.286271ms min_rtt=32.795734ms rttvar=12.958117ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=37 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1726, delivered_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, first_sent_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, end_of_app_limited: 9, last_sent_packet: 10, largest_acked: 7, rate_sample: RateSample { delivery_rate: 41779, is_app_limited: true, interval: 33.341511ms, delivered: 1393, prior_delivered: 333, prior_time: Some(Instant { tv_sec: 160, tv_nsec: 993533626 }), send_elapsed: 545.777µs, ack_elapsed: 33.341511ms, rtt: 32.795734ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 429539, last_update: Instant { tv_sec: 161, tv_nsec: 35683310 }, next_time: Instant { tv_sec: 161, tv_nsec: 26977939 }, max_datagram_size: 1350, last_packet_size: None, iv: 86.139µ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-30T19:22:48.033461567Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:59370 to 193.167.100.100:443
[2025-04-30T19:22:48.033467679Z TRACE quiche_apps::client] 0.0.0.0:59370 -> 193.167.100.100:443: done writing
[2025-04-30T19:22:48.307772345Z TRACE quiche_apps::client] timed out
[2025-04-30T19:22:48.307789297Z TRACE quiche] 02693c35a8deadc681d2e4fc1d4127041b1e262f draining timeout expired
[2025-04-30T19:22:48.307820846Z TRACE quiche_apps::client] done reading
[2025-04-30T19:22:48.307825294Z INFO  quiche_apps::client] connection closed, recv=8 sent=11 lost=0 retrans=0 sent_bytes=2002 recv_bytes=2765 lost_bytes=0 [local_addr=0.0.0.0:59370 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=8 sent=11 lost=0 retrans=0 rtt=39.286271ms min_rtt=Some(32.795734ms) rttvar=12.958117ms cwnd=13500 sent_bytes=2002 recv_bytes=2765 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=41779]