[2025-04-30T09:13:08.194389685Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T09:13:08.194699957Z INFO  quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:43587 with scid ec63b78b8157076fef0737276bddad9fd079e7a7
[2025-04-30T09:13:08.194741996Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 write message lvl=Initial len=266
[2025-04-30T09:13:08.194758968Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Initial version=1 dcid=96aacee2040a1cfe35dbea45c25d5054 scid=ec63b78b8157076fef0737276bddad9fd079e7a7 len=270 pn=0 
[2025-04-30T09:13:08.194762294Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm CRYPTO off=0 len=266
[2025-04-30T09:13:08.194775980Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=998.932583ms 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: 344, tv_nsec: 854173123 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 854173123 }, 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: 344, tv_nsec: 854173123 }, next_time: Instant { tv_sec: 344, tv_nsec: 854173123 }, 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-30T09:13:08.194836153Z TRACE quiche_apps::client] written 1200
[2025-04-30T09:13:08.231604303Z TRACE quiche_apps::client] got 137 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.231626144Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Retry version=1 dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 scid=1b98ccc5b184e404255dd3a9c03c97961ffc9362 token=6978c60f9080d65de88afd8c5d79608482708ca4702f27fc4e9be7c88ae9f1bc9e8aa55c5fb735e7adf6e316b6abc72f945466780d2f3a04a72bf36d4ed0ed153cc82e8cca35cd5a0d58
[2025-04-30T09:13:08.231653646Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 dropped epoch 0 state
[2025-04-30T09:13:08.231662352Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 137 bytes
[2025-04-30T09:13:08.231667392Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.231670518Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.231713829Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 write message lvl=Initial len=266
[2025-04-30T09:13:08.231731011Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Initial version=1 dcid=1b98ccc5b184e404255dd3a9c03c97961ffc9362 scid=ec63b78b8157076fef0737276bddad9fd079e7a7 token=6978c60f9080d65de88afd8c5d79608482708ca4702f27fc4e9be7c88ae9f1bc9e8aa55c5fb735e7adf6e316b6abc72f945466780d2f3a04a72bf36d4ed0ed153cc82e8cca35cd5a0d58 len=270 pn=1 
[2025-04-30T09:13:08.231734999Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm CRYPTO off=0 len=266
[2025-04-30T09:13:08.231746230Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=998.932053ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=412 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 344, tv_nsec: 891142772 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 891142772 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { delivery_rate: 0, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 344, tv_nsec: 891142772 }, next_time: Instant { tv_sec: 344, tv_nsec: 891142772 }, 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-30T09:13:08.231807785Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.231815830Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.265951843Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.265971781Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Initial version=1 dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 scid=0000000000001003a8ed1b2a94b1add3b502980c token= len=116 pn=0 
[2025-04-30T09:13:08.265986007Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm ACK delay=0 blocks=[1..1] ecn_counts=None
[2025-04-30T09:13:08.265992199Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 packet newly acked 1
[2025-04-30T09:13:08.265998411Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm CRYPTO off=0 len=90
[2025-04-30T09:13:08.266108447Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 set write secret lvl=Handshake
[2025-04-30T09:13:08.266119979Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 set read secret lvl=Handshake
[2025-04-30T09:13:08.266153712Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Handshake version=1 dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 scid=0000000000001003a8ed1b2a94b1add3b502980c len=985 pn=0 
[2025-04-30T09:13:08.266160865Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm CRYPTO off=0 len=741
[2025-04-30T09:13:08.266395004Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 write message lvl=Handshake len=36
[2025-04-30T09:13:08.266399773Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 set write secret lvl=OneRTT
[2025-04-30T09:13:08.266407949Z TRACE quiche::tls] ec63b78b8157076fef0737276bddad9fd079e7a7 set read secret lvl=OneRTT
[2025-04-30T09:13:08.266426043Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 connection established: proto=Ok("h3") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=false TransportParams { original_destination_connection_id: Some(96aacee2040a1cfe35dbea45c25d5054), max_idle_timeout: 75000, stateless_reset_token: Some(263651414850995128961090075173518544902), max_udp_payload_size: 65527, initial_max_data: 8585216, initial_max_stream_data_bidi_local: 65536, initial_max_stream_data_bidi_remote: 65536, initial_max_stream_data_uni: 65536, initial_max_streams_bidi: 128, initial_max_streams_uni: 3, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 2, initial_source_connection_id: Some(0000000000001003a8ed1b2a94b1add3b502980c), retry_source_connection_id: Some(1b98ccc5b184e404255dd3a9c03c97961ffc9362), max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T09:13:08.266440951Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm PADDING len=223
[2025-04-30T09:13:08.266457923Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.266463573Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.266466729Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.266483901Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm SETTINGS stream=2 len=18
[2025-04-30T09:13:08.266502777Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm GREASE stream=0 len=0
[2025-04-30T09:13:08.266509950Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm GREASE stream=0 len=18
[2025-04-30T09:13:08.266525199Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm HEADERS stream=0 len=29 fin=true
[2025-04-30T09:13:08.266532673Z DEBUG quiche_apps::common] Sent HTTP request [":method: GET", ":scheme: https", ":authority: server4", ":path: /zaoaszgjof", "user-agent: quiche"]
[2025-04-30T09:13:08.266642279Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Initial version=1 dcid=0000000000001003a8ed1b2a94b1add3b502980c scid=ec63b78b8157076fef0737276bddad9fd079e7a7 token=6978c60f9080d65de88afd8c5d79608482708ca4702f27fc4e9be7c88ae9f1bc9e8aa55c5fb735e7adf6e316b6abc72f945466780d2f3a04a72bf36d4ed0ed153cc82e8cca35cd5a0d58 len=6 pn=2 
[2025-04-30T09:13:08.266646446Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=84 blocks=[0..0] ecn_counts=None
[2025-04-30T09:13:08.266655323Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=102.177094ms latest_rtt=34.288459ms srtt=34.288459ms min_rtt=34.288459ms rttvar=17.144229ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 412, delivered_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 12015, is_app_limited: true, interval: 34.288459ms, delivered: 412, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 891142772 }), send_elapsed: 0ns, ack_elapsed: 34.288459ms, rtt: 34.288459ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 492148, last_update: Instant { tv_sec: 344, tv_nsec: 925887947 }, next_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, 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-30T09:13:08.266674429Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Handshake version=1 dcid=0000000000001003a8ed1b2a94b1add3b502980c scid=ec63b78b8157076fef0737276bddad9fd079e7a7 len=46 pn=3 
[2025-04-30T09:13:08.266677334Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=65 blocks=[0..0] ecn_counts=None
[2025-04-30T09:13:08.266680009Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm CRYPTO off=0 len=36
[2025-04-30T09:13:08.266686091Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=102.810151ms latest_rtt=34.288459ms srtt=34.288459ms min_rtt=34.288459ms rttvar=17.144229ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=112 app_limited=true congestion_recovery_start_time=None Rate { delivered: 412, delivered_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 12015, is_app_limited: true, interval: 34.288459ms, delivered: 412, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 891142772 }), send_elapsed: 0ns, ack_elapsed: 34.288459ms, rtt: 34.288459ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 492148, last_update: Instant { tv_sec: 344, tv_nsec: 926094906 }, next_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, max_datagram_size: 1350, last_packet_size: None, iv: 227.574µ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-30T09:13:08.266697302Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 dropped epoch 0 state
[2025-04-30T09:13:08.266706669Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13388 out_len=1090 left=1052
[2025-04-30T09:13:08.266717469Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=1052 pn=4 
[2025-04-30T09:13:08.266720285Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[24, bb, 95, a7, 36, c4, 88, de, 2f, 6a, 10, d3, 98, 6c, 71, 53, 79, 15, 6d, 72] reset_token=[20, 2b, c0, ce, c6, 95, 3d, d8, 99, 59, e7, 96, 13, f6, 8a, bd]
[2025-04-30T09:13:08.266726817Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm STREAM id=2 off=0 len=19 fin=false
[2025-04-30T09:13:08.266729532Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm PADDING len=988
[2025-04-30T09:13:08.266736004Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=102.760258ms latest_rtt=34.288459ms srtt=34.288459ms min_rtt=34.288459ms rttvar=17.144229ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1202 app_limited=true congestion_recovery_start_time=None Rate { delivered: 412, delivered_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 12015, is_app_limited: true, interval: 34.288459ms, delivered: 412, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 891142772 }), send_elapsed: 0ns, ack_elapsed: 34.288459ms, rtt: 34.288459ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 1090, rate: 492148, last_update: Instant { tv_sec: 344, tv_nsec: 926094906 }, next_time: Instant { tv_sec: 344, tv_nsec: 926322480 }, max_datagram_size: 1350, last_packet_size: Some(1090), 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-30T09:13:08.266777542Z TRACE quiche_apps::client] written 1350 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.266784065Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12298 out_len=1350 left=1312
[2025-04-30T09:13:08.266787641Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=6 pn=5 
[2025-04-30T09:13:08.266790236Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm STREAM id=6 off=0 len=1 fin=false
[2025-04-30T09:13:08.266795927Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=102.700325ms latest_rtt=34.288459ms srtt=34.288459ms min_rtt=34.288459ms rttvar=17.144229ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1246 app_limited=true congestion_recovery_start_time=None Rate { delivered: 412, delivered_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 12015, is_app_limited: true, interval: 34.288459ms, delivered: 412, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 891142772 }), send_elapsed: 0ns, ack_elapsed: 34.288459ms, rtt: 34.288459ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 492148, last_update: Instant { tv_sec: 344, tv_nsec: 926245208 }, next_time: Instant { tv_sec: 344, tv_nsec: 926322480 }, max_datagram_size: 1350, last_packet_size: None, iv: 2.304185ms, 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-30T09:13:08.266828989Z TRACE quiche_apps::client] written 44 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.266834910Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12254 out_len=1350 left=1312
[2025-04-30T09:13:08.266838146Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=6 pn=6 
[2025-04-30T09:13:08.266840641Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm STREAM id=10 off=0 len=1 fin=false
[2025-04-30T09:13:08.266863013Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=102.632979ms latest_rtt=34.288459ms srtt=34.288459ms min_rtt=34.288459ms rttvar=17.144229ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1290 app_limited=true congestion_recovery_start_time=None Rate { delivered: 412, delivered_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 12015, is_app_limited: true, interval: 34.288459ms, delivered: 412, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 891142772 }), send_elapsed: 0ns, ack_elapsed: 34.288459ms, rtt: 34.288459ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 44, rate: 492148, last_update: Instant { tv_sec: 344, tv_nsec: 926245208 }, next_time: Instant { tv_sec: 344, tv_nsec: 928626665 }, max_datagram_size: 1350, last_packet_size: Some(44), 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-30T09:13:08.266892638Z TRACE quiche_apps::client] written 44 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.266898620Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12210 out_len=1350 left=1312
[2025-04-30T09:13:08.266902106Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=72 pn=7 
[2025-04-30T09:13:08.266904701Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm STREAM id=0 off=0 len=67 fin=true
[2025-04-30T09:13:08.266910031Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=102.586211ms latest_rtt=34.288459ms srtt=34.288459ms min_rtt=34.288459ms rttvar=17.144229ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 412, delivered_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 925887988 }, end_of_app_limited: 6, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 12015, is_app_limited: true, interval: 34.288459ms, delivered: 412, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 891142772 }), send_elapsed: 0ns, ack_elapsed: 34.288459ms, rtt: 34.288459ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 492148, last_update: Instant { tv_sec: 344, tv_nsec: 926359763 }, next_time: Instant { tv_sec: 344, tv_nsec: 928626665 }, max_datagram_size: 1350, last_packet_size: None, iv: 312.914µ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-30T09:13:08.266935919Z TRACE quiche_apps::client] written 110 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.266943684Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.301477806Z TRACE quiche_apps::client] got 950 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.301491642Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=929 pn=0 
[2025-04-30T09:13:08.301501901Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm ACK delay=0 blocks=[4..4] ecn_counts=None
[2025-04-30T09:13:08.301506360Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 packet newly acked 4
[2025-04-30T09:13:08.301511739Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm CRYPTO off=0 len=540
[2025-04-30T09:13:08.301534883Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm HANDSHAKE_DONE
[2025-04-30T09:13:08.301561142Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 dropped epoch 1 state
[2025-04-30T09:13:08.301567955Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_TOKEN len=58
[2025-04-30T09:13:08.301572584Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, be, 2f, d7, 0f, 8a, e0, 4d, 6b, de, 65, 3d, b2] reset_token=[aa, 47, a0, 22, 56, 7c, 25, 00, 8a, 4e, 14, ec, 2a, 40, 68, 94]
[2025-04-30T09:13:08.301580569Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, 68, a0, 6d, d9, c0, 1f, fe, 4a, b4, 9f, 7b, bb] reset_token=[fd, 00, 07, 09, 99, a5, b1, 11, 10, 9c, ed, af, ad, 28, 77, f4]
[2025-04-30T09:13:08.301586720Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, 44, ed, 4d, 7d, 84, 03, 83, a0, 3e, 46, c1, 12] reset_token=[8c, eb, cd, 84, 5f, 66, 2e, 32, 29, bc, 41, 17, 8a, ff, f5, 2f]
[2025-04-30T09:13:08.301592281Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, 09, f2, 9c, ce, e1, ca, 07, 02, 9c, bd, f3, f3] reset_token=[a6, f1, 8c, 43, b4, 82, b4, 10, 3d, 3a, 9d, 36, a6, 3e, 3f, f4]
[2025-04-30T09:13:08.301598222Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, 5e, c4, 4c, 44, aa, 14, 38, 4f, f8, 28, 07, 65] reset_token=[6e, 89, 5d, af, 0c, 50, 93, 20, cc, 75, 29, ba, ef, 3f, b8, 45]
[2025-04-30T09:13:08.301603852Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, a8, 5b, ad, 19, 47, c5, c3, 87, 0a, 2f, 02, 9e] reset_token=[62, 81, 09, a1, 0f, 22, bb, 80, 78, f5, fe, 10, 72, b5, 6f, c1]
[2025-04-30T09:13:08.301609363Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[00, 00, 00, 00, 00, 00, 10, 03, a0, c9, a7, c5, 45, 8c, 66, 1a, 56, 4f, 2c, 9c] reset_token=[fa, ad, c9, e6, 97, 99, 07, 9b, 7b, 08, 18, 31, 10, a6, 55, e2]
[2025-04-30T09:13:08.301613711Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=3 off=0 len=1 fin=false
[2025-04-30T09:13:08.301617468Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=3 off=1 len=8 fin=false
[2025-04-30T09:13:08.301620363Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=7 off=0 len=1 fin=false
[2025-04-30T09:13:08.301639058Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 950 bytes
[2025-04-30T09:13:08.301645170Z TRACE quiche_apps::client] got 43 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.301648847Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=22 pn=1 
[2025-04-30T09:13:08.301653576Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm ACK delay=0 blocks=[4..6] ecn_counts=None
[2025-04-30T09:13:08.301662773Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 packet newly acked 5
[2025-04-30T09:13:08.301665318Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 packet newly acked 6
[2025-04-30T09:13:08.301672752Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 43 bytes
[2025-04-30T09:13:08.301676749Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.301679214Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.301682139Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 3 is readable
[2025-04-30T09:13:08.301687540Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 3
[2025-04-30T09:13:08.301692509Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 open peer's control stream 3
[2025-04-30T09:13:08.301695805Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 3
[2025-04-30T09:13:08.301698931Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 3
[2025-04-30T09:13:08.301703550Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 6 bytes on stream 3
[2025-04-30T09:13:08.301707106Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm SETTINGS max_field_section=None, qpack_max_table=Some(4096), qpack_blocked=Some(128) raw=Some([(1, 4096), (7, 128)]), additional_settings=None stream=3 payload_len=6
[2025-04-30T09:13:08.301716203Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 7 is readable
[2025-04-30T09:13:08.301720381Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 7
[2025-04-30T09:13:08.301731231Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13390 out_len=1350 left=1307
[2025-04-30T09:13:08.301736291Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=8 
[2025-04-30T09:13:08.301739507Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=10 blocks=[0..1] ecn_counts=None
[2025-04-30T09:13:08.301747512Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=64.925694ms latest_rtt=32.485259ms srtt=34.100496ms min_rtt=32.485259ms rttvar=10.169304ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=110 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1590, delivered_time: Instant { tv_sec: 344, tv_nsec: 961111924 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 926322480 }, end_of_app_limited: 7, last_sent_packet: 8, largest_acked: 6, rate_sample: RateSample { delivery_rate: 33594, is_app_limited: true, interval: 35.065248ms, delivered: 1178, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 494860, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.301798478Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.301804058Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.302529319Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.302560979Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=2 
[2025-04-30T09:13:08.302579714Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm ACK delay=0 blocks=[4..7] ecn_counts=None
[2025-04-30T09:13:08.302584483Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 packet newly acked 7
[2025-04-30T09:13:08.302590464Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=0 len=1152 fin=false
[2025-04-30T09:13:08.302603739Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.302608688Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.302611703Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.302615010Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.302619658Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 0
[2025-04-30T09:13:08.302623666Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 0
[2025-04-30T09:13:08.302627353Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 0
[2025-04-30T09:13:08.302631701Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 140 bytes on stream 0
[2025-04-30T09:13:08.302634867Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm HEADERS stream=0 payload_len=140
[2025-04-30T09:13:08.302638594Z TRACE quiche::h3::qpack::decoder] Header count=0 base=0
[2025-04-30T09:13:08.302641670Z TRACE quiche::h3::qpack::decoder] Indexed index=25 static=true
[2025-04-30T09:13:08.302646729Z TRACE quiche::h3::qpack::decoder] Literal name_idx=92 static=true value=[110, 103, 105, 110, 120, 47, 49, 46, 50, 55, 46, 48]
[2025-04-30T09:13:08.302653221Z 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, 48, 57, 58, 49, 51, 58, 48, 56, 32, 71, 77, 84]
[2025-04-30T09:13:08.302659103Z TRACE quiche::h3::qpack::decoder] Literal name_idx=53 static=true value=[97, 112, 112, 108, 105, 99, 97, 116, 105, 111, 110, 47, 111, 99, 116, 101, 116, 45, 115, 116, 114, 101, 97, 109]
[2025-04-30T09:13:08.302663090Z TRACE quiche::h3::qpack::decoder] Literal name_idx=4 static=true value=[49, 48, 50, 52, 48]
[2025-04-30T09:13:08.302666096Z 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, 48, 57, 58, 49, 51, 58, 48, 54, 32, 71, 77, 84]
[2025-04-30T09:13:08.302670624Z TRACE quiche::h3::qpack::decoder] Literal Without Name Reference name=[101, 116, 97, 103] value=[34, 54, 56, 49, 49, 101, 57, 97, 50, 45, 50, 56, 48, 48, 34]
[2025-04-30T09:13:08.302675473Z TRACE quiche::h3::qpack::decoder] Literal Without Name Reference name=[97, 108, 116, 45, 115, 118, 99] value=[104, 113, 45, 50, 57, 61, 34, 58, 52, 52, 51, 34]
[2025-04-30T09:13:08.302679250Z TRACE quiche::h3::qpack::decoder] Literal Without Name Reference name=[97, 99, 99, 101, 112, 116, 45, 114, 97, 110, 103, 101, 115] value=[98, 121, 116, 101, 115]
[2025-04-30T09:13:08.302688928Z DEBUG quiche_apps::common] got response headers [(":status", "200"), ("server", "nginx/1.27.0"), ("date", "Wed, 30 Apr 2025 09:13:08 GMT"), ("content-type", "application/octet-stream"), ("content-length", "10240"), ("last-modified", "Wed, 30 Apr 2025 09:13:06 GMT"), ("etag", "\"6811e9a2-2800\""), ("alt-svc", "hq-29=\":443\""), ("accept-ranges", "bytes")] on stream id 0
[2025-04-30T09:13:08.302695190Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.302698366Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 0
[2025-04-30T09:13:08.302701382Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 0
[2025-04-30T09:13:08.302704277Z TRACE quiche::h3::stream] ec63b78b8157076fef0737276bddad9fd079e7a7 read 1 bytes on stream 0
[2025-04-30T09:13:08.302710158Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm DATA stream=0 wire_payload_len=10240
[2025-04-30T09:13:08.302715148Z DEBUG quiche_apps::common] got 1006 bytes of response data on stream 0
[2025-04-30T09:13:08.302723373Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.302726920Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=9 
[2025-04-30T09:13:08.302729525Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=20 blocks=[0..2] ecn_counts=None
[2025-04-30T09:13:08.302735696Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 9, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.302772836Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.302777475Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.303487257Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.303494851Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=3 
[2025-04-30T09:13:08.303501583Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=1152 len=1156 fin=false
[2025-04-30T09:13:08.303509107Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.303512714Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.303515099Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.303517704Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.303522513Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.303529857Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.303533112Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=10 
[2025-04-30T09:13:08.303535587Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=4 blocks=[0..3] ecn_counts=None
[2025-04-30T09:13:08.303578197Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 10, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.303616439Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.303621138Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.304468608Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.304476102Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=4 
[2025-04-30T09:13:08.304482494Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=2308 len=1156 fin=false
[2025-04-30T09:13:08.304489878Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.304493535Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.304495939Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.304498504Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.304503093Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.304510316Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.304513823Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=11 
[2025-04-30T09:13:08.304516337Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=4 blocks=[0..4] ecn_counts=None
[2025-04-30T09:13:08.304522559Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 11, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.304575579Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.304585117Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.305453807Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.305461261Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=5 
[2025-04-30T09:13:08.305467482Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=3464 len=1156 fin=false
[2025-04-30T09:13:08.305474916Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.305478493Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.305480807Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.305483352Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.305487851Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.305494914Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.305498120Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=12 
[2025-04-30T09:13:08.305500554Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=4 blocks=[0..5] ecn_counts=None
[2025-04-30T09:13:08.305507387Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 12, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.305559034Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.305570335Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.306437442Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.306444766Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=6 
[2025-04-30T09:13:08.306450958Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=4620 len=1156 fin=false
[2025-04-30T09:13:08.306458201Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.306461738Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.306464092Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.306466677Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.306471045Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.306478049Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.306481285Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=13 
[2025-04-30T09:13:08.306489259Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=4 blocks=[0..6] ecn_counts=None
[2025-04-30T09:13:08.306495732Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 13, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.306529986Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.306534504Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.307421439Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.307428983Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=7 
[2025-04-30T09:13:08.307435194Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=5776 len=1156 fin=false
[2025-04-30T09:13:08.307442568Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.307446095Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.307448439Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.307451034Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.307455483Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.307462616Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.307465862Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=14 
[2025-04-30T09:13:08.307468297Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=4 blocks=[0..7] ecn_counts=None
[2025-04-30T09:13:08.307474318Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 14, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.307513261Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.307517529Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.308406868Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.308417067Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=8 
[2025-04-30T09:13:08.308423399Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=6932 len=1156 fin=false
[2025-04-30T09:13:08.308430702Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.308434329Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.308436674Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.308439198Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.308443617Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.308450710Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.308453906Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=15 
[2025-04-30T09:13:08.308456331Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=4 blocks=[0..8] ecn_counts=None
[2025-04-30T09:13:08.308462242Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 15, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.308495484Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.308499582Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.309390313Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.309400542Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1179 pn=9 
[2025-04-30T09:13:08.309406784Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=8088 len=1156 fin=false
[2025-04-30T09:13:08.309419277Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1200 bytes
[2025-04-30T09:13:08.309423044Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.309425359Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.309427894Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.309432302Z DEBUG quiche_apps::common] got 1156 bytes of response data on stream 0
[2025-04-30T09:13:08.309455405Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T09:13:08.309459012Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=5 pn=16 
[2025-04-30T09:13:08.309461467Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm ACK delay=6 blocks=[0..9] ecn_counts=None
[2025-04-30T09:13:08.309468199Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=none latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 8, last_sent_packet: 16, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 961190611 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, 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-30T09:13:08.309502504Z TRACE quiche_apps::client] written 43 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.309506652Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.310368268Z TRACE quiche_apps::client] got 1191 bytes from 193.167.100.100:443 to 0.0.0.0:43587
[2025-04-30T09:13:08.310378327Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx pkt Short dcid=ec63b78b8157076fef0737276bddad9fd079e7a7 key_phase=false len=1170 pn=10 
[2025-04-30T09:13:08.310384779Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=9244 len=1142 fin=false
[2025-04-30T09:13:08.310388226Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 rx frm STREAM id=0 off=10386 len=0 fin=true
[2025-04-30T09:13:08.310396080Z TRACE quiche_apps::client] 0.0.0.0:43587: processed 1191 bytes
[2025-04-30T09:13:08.310399747Z TRACE quiche_apps::client] 0.0.0.0:43587: recv() would block
[2025-04-30T09:13:08.310402152Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.310404777Z TRACE quiche::h3] ec63b78b8157076fef0737276bddad9fd079e7a7 stream id 0 is readable
[2025-04-30T09:13:08.310411239Z DEBUG quiche_apps::common] got 1142 bytes of response data on stream 0
[2025-04-30T09:13:08.310413874Z DEBUG quiche_apps::common] 1/1 responses received
[2025-04-30T09:13:08.310416579Z INFO  quiche_apps::common] 1/1 response(s) received in 115.576039ms, closing...
[2025-04-30T09:13:08.310423522Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1312
[2025-04-30T09:13:08.310427008Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx pkt Short dcid=0000000000001003a8ed1b2a94b1add3b502980c key_phase=false len=11 pn=17 
[2025-04-30T09:13:08.310434663Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 tx frm APPLICATION_CLOSE err=100 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-04-30T09:13:08.310441886Z TRACE quiche::recovery::congestion::recovery] ec63b78b8157076fef0737276bddad9fd079e7a7 timer=90.203006ms latest_rtt=33.396278ms srtt=34.012468ms min_rtt=32.485259ms rttvar=7.803032ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=49 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1700, delivered_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, first_sent_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, end_of_app_limited: 16, last_sent_packet: 17, largest_acked: 7, rate_sample: RateSample { delivery_rate: 36731, is_app_limited: true, interval: 35.065248ms, delivered: 1288, prior_delivered: 412, prior_time: Some(Instant { tv_sec: 344, tv_nsec: 925887988 }), send_elapsed: 434.492µs, ack_elapsed: 35.065248ms, rtt: 34.630756ms } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 496141, last_update: Instant { tv_sec: 344, tv_nsec: 969884405 }, next_time: Instant { tv_sec: 344, tv_nsec: 961503525 }, max_datagram_size: 1350, last_packet_size: None, iv: 98.762µ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-30T09:13:08.310477513Z TRACE quiche_apps::client] written 49 bytes from 0.0.0.0:43587 to 193.167.100.100:443
[2025-04-30T09:13:08.310481130Z TRACE quiche_apps::client] 0.0.0.0:43587 -> 193.167.100.100:443: done writing
[2025-04-30T09:13:08.506735116Z TRACE quiche_apps::client] timed out
[2025-04-30T09:13:08.506761546Z TRACE quiche] ec63b78b8157076fef0737276bddad9fd079e7a7 draining timeout expired
[2025-04-30T09:13:08.506804757Z TRACE quiche_apps::client] done reading
[2025-04-30T09:13:08.506809687Z INFO  quiche_apps::client] connection closed, recv=13 sent=18 lost=0 retrans=0 sent_bytes=2729 recv_bytes=12984 lost_bytes=0 [local_addr=0.0.0.0:43587 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=13 sent=18 lost=0 retrans=0 rtt=34.012468ms min_rtt=Some(32.485259ms) rttvar=7.803032ms cwnd=13500 sent_bytes=2729 recv_bytes=12984 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=36731]