[2025-12-14T07:19:31.367343646Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-12-14T07:19:31.367622767Z INFO quiche_apps::client] connecting to 193.167.100.100:443 from 0.0.0.0:44001 with scid 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec [2025-12-14T07:19:31.367664174Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec write message lvl=Initial len=266 [2025-12-14T07:19:31.367681346Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Initial version=1 dcid=1cf5d9ffeb5a6344256426b374f1873b scid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec len=270 pn=0 [2025-12-14T07:19:31.367685064Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm CRYPTO off=0 len=266 [2025-12-14T07:19:31.367699691Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=998.93072ms 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: 855, tv_nsec: 659850485 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 659850485 }, end_of_app_limited: 1, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 659850485 }, next_time: Instant { tv_sec: 855, tv_nsec: 659850485 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.367761446Z TRACE quiche_apps::client] written 1200 [2025-12-14T07:19:31.404419704Z TRACE quiche_apps::client] got 92 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.404451313Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Retry version=1 dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec scid=67dd692f5308975729693cdd token=100d187f982ad1e2a1b128c100f68029a476d1dbce2fbb02dd1c434cad78d0a49b97f52a78 [2025-12-14T07:19:31.404482011Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec dropped epoch 0 state [2025-12-14T07:19:31.404493873Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 92 bytes [2025-12-14T07:19:31.404499393Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.404503100Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.404551030Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec write message lvl=Initial len=266 [2025-12-14T07:19:31.404570155Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Initial version=1 dcid=67dd692f5308975729693cdd scid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec token=100d187f982ad1e2a1b128c100f68029a476d1dbce2fbb02dd1c434cad78d0a49b97f52a78 len=270 pn=1 [2025-12-14T07:19:31.404574964Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm CRYPTO off=0 len=266 [2025-12-14T07:19:31.404591054Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=998.920452ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=366 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 696732001 }, next_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.404660424Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.404668329Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.438383168Z TRACE quiche_apps::client] got 1200 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.438421589Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Initial version=1 dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec scid=890e5087e754418b2592fe0d token=100d187f982ad1e2a1b128c100f68029a476d1dbce2fbb02dd1c434cad78d0a49b97f52a78 len=1121 pn=0 [2025-12-14T07:19:31.438440906Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=0 len=90 [2025-12-14T07:19:31.438563365Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec set write secret lvl=Handshake [2025-12-14T07:19:31.438577060Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec set read secret lvl=Handshake [2025-12-14T07:19:31.438591898Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm PADDING len=1007 [2025-12-14T07:19:31.438620732Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1200 bytes [2025-12-14T07:19:31.438627614Z TRACE quiche_apps::client] got 225 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.438632584Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Handshake version=1 dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec scid=890e5087e754418b2592fe0d len=184 pn=0 [2025-12-14T07:19:31.438639487Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=0 len=160 [2025-12-14T07:19:31.438659774Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 225 bytes [2025-12-14T07:19:31.438665064Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.438668761Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.438697295Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Initial version=1 dcid=890e5087e754418b2592fe0d scid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec token=100d187f982ad1e2a1b128c100f68029a476d1dbce2fbb02dd1c434cad78d0a49b97f52a78 len=5 pn=2 [2025-12-14T07:19:31.438702154Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=34 blocks=[0..0] ecn_counts=None [2025-12-14T07:19:31.438714687Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=964.796999ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=366 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 730905206 }, next_time: Instant { tv_sec: 855, tv_nsec: 730905206 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.438740465Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Handshake version=1 dcid=890e5087e754418b2592fe0d scid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec len=5 pn=3 [2025-12-14T07:19:31.438749773Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=13 blocks=[0..0] ecn_counts=None [2025-12-14T07:19:31.438757327Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=964.75478ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=366 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 696732001 }, end_of_app_limited: 1, last_sent_packet: 3, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 730905206 }, next_time: Instant { tv_sec: 855, tv_nsec: 730905206 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.438773678Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec dropped epoch 0 state [2025-12-14T07:19:31.438850290Z TRACE quiche_apps::client] written 1200 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.438858766Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.438933977Z TRACE quiche_apps::client] got 537 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.438941260Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Handshake version=1 dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec scid=890e5087e754418b2592fe0d len=496 pn=1 [2025-12-14T07:19:31.438949807Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=160 len=471 [2025-12-14T07:19:31.439017874Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 537 bytes [2025-12-14T07:19:31.439024897Z TRACE quiche_apps::client] got 144 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.439029565Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Handshake version=1 dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec scid=890e5087e754418b2592fe0d len=103 pn=2 [2025-12-14T07:19:31.439036048Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=631 len=78 [2025-12-14T07:19:31.439199824Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 144 bytes [2025-12-14T07:19:31.439207638Z TRACE quiche_apps::client] got 101 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.439212658Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Handshake version=1 dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec scid=890e5087e754418b2592fe0d len=60 pn=3 [2025-12-14T07:19:31.439219520Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=709 len=36 [2025-12-14T07:19:31.439248645Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec write message lvl=Handshake len=36 [2025-12-14T07:19:31.439253073Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec set write secret lvl=OneRTT [2025-12-14T07:19:31.439262000Z TRACE quiche::tls] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec set read secret lvl=OneRTT [2025-12-14T07:19:31.439276727Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=Some("ecdsa_secp256r1_sha256") resumed=false TransportParams { original_destination_connection_id: Some(1cf5d9ffeb5a6344256426b374f1873b), max_idle_timeout: 120000, stateless_reset_token: Some(198301561883056846192706652463511224080), max_udp_payload_size: 1500, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 16777216, initial_max_stream_data_bidi_remote: 16777216, initial_max_stream_data_uni: 16777216, 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(890e5087e754418b2592fe0d), retry_source_connection_id: Some(67dd692f5308975729693cdd), max_datagram_frame_size: None, unknown_params: None } [2025-12-14T07:19:31.439308787Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 101 bytes [2025-12-14T07:19:31.439314789Z TRACE quiche_apps::client] got 105 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.439319387Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec dropped invalid packet [2025-12-14T07:19:31.439323074Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 105 bytes [2025-12-14T07:19:31.439327512Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.439331229Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.439341358Z DEBUG quiche_apps::common] sending HTTP request "GET /bright-broken-mittens\r\n" [2025-12-14T07:19:31.439413523Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Handshake version=1 dcid=890e5087e754418b2592fe0d scid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec len=45 pn=4 [2025-12-14T07:19:31.439418943Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=24 blocks=[0..3] ecn_counts=None [2025-12-14T07:19:31.439423582Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm CRYPTO off=0 len=36 [2025-12-14T07:19:31.439435093Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=998.968191ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=103 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 731623208 }, next_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.439459499Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=313 pn=5 [2025-12-14T07:19:31.439463616Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[36, 0d, 34, 3a, 85, 32, 6d, b4, a1, d1, c4, 10, 9a, c3, bb, 25, b0, 57, fe, a1] reset_token=[21, b4, 86, d1, 2f, 43, 93, 7f, 33, 39, 51, 28, 73, f1, 40, 1a] [2025-12-14T07:19:31.439472293Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[27, b3, 07, 63, 1e, db, bd, 70, cd, f9, f3, a0, b2, 68, bd, 8d, 35, 3f, b8, 94] reset_token=[fc, 02, a6, 17, 59, c2, 4b, fd, 6f, 1e, 76, 32, c2, ab, 8f, 05] [2025-12-14T07:19:31.439480167Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[f0, 27, b8, 6d, 35, 0a, 15, 32, 14, 7e, 8c, 5a, a8, 43, 83, 0a, fd, b0, 24, 4c] reset_token=[68, d9, da, e4, da, 46, db, 77, 9f, 7b, 56, 9c, cb, 4e, 4f, 74] [2025-12-14T07:19:31.439488503Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[08, 57, 63, 40, 70, e8, 95, 23, 8d, ae, 0b, 35, fd, ea, 52, 47, a5, de, 48, 13] reset_token=[05, d1, c0, 1a, e6, dd, a2, 31, 83, f4, e7, c2, 92, 3e, d0, 87] [2025-12-14T07:19:31.439501106Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[a0, 37, 6e, 51, fe, 7d, f5, 3c, d1, 7a, 1e, 20, d9, 0f, e5, 2f, b1, 36, b9, 78] reset_token=[49, 6e, 2a, 55, 27, f1, 8a, 59, 4c, 04, 50, 94, ad, e9, a3, d6] [2025-12-14T07:19:31.439507108Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[5f, f0, 36, 6c, b7, bc, 00, 58, 25, 11, 46, 2a, b4, 98, c8, 7b, 49, 39, a2, bb] reset_token=[5f, a4, 4a, 62, 64, 5e, 60, 7d, 26, a1, a8, 8b, 03, cb, fd, 41] [2025-12-14T07:19:31.439512979Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[de, 37, 09, ba, e5, be, 00, c0, 38, 3b, ba, 53, 45, 25, ac, e3, f0, 63, cf, 88] reset_token=[33, 78, 1c, ee, c8, b1, fb, 11, b0, 8e, e5, 5e, 03, aa, 95, c1] [2025-12-14T07:19:31.439518880Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm STREAM id=0 off=0 len=28 fin=true [2025-12-14T07:19:31.439528538Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=998.875017ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=446 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 731623208 }, next_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.439567871Z TRACE quiche_apps::client] written 446 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.439573522Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.471918551Z TRACE quiche_apps::client] got 42 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.471956001Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=21 pn=0 [2025-12-14T07:19:31.471970377Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm HANDSHAKE_DONE [2025-12-14T07:19:31.471979294Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec dropped epoch 1 state [2025-12-14T07:19:31.471995965Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 42 bytes [2025-12-14T07:19:31.472002197Z TRACE quiche_apps::client] got 80 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.472006615Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=59 pn=1 [2025-12-14T07:19:31.472016965Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm NEW_TOKEN len=37 [2025-12-14T07:19:31.472059724Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 80 bytes [2025-12-14T07:19:31.472065325Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.472069162Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.472084811Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=5 pn=6 [2025-12-14T07:19:31.472089230Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=9 blocks=[0..1] ecn_counts=None [2025-12-14T07:19:31.472105761Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=991.296943ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 6, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 764294817 }, next_time: Instant { tv_sec: 855, tv_nsec: 764294817 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.472169349Z TRACE quiche_apps::client] written 35 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.472178036Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.472266270Z TRACE quiche_apps::client] got 302 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.472279034Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=281 pn=2 [2025-12-14T07:19:31.472292259Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=0 len=257 [2025-12-14T07:19:31.472329769Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 302 bytes [2025-12-14T07:19:31.472335760Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.472339477Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.472349446Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=5 pn=7 [2025-12-14T07:19:31.472353484Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=8 blocks=[0..2] ecn_counts=None [2025-12-14T07:19:31.472362370Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=991.040844ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 7, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 764563749 }, next_time: Instant { tv_sec: 855, tv_nsec: 764563749 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.472405010Z TRACE quiche_apps::client] written 35 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.472414067Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.472488125Z TRACE quiche_apps::client] got 303 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.472500929Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=282 pn=3 [2025-12-14T07:19:31.472530554Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm CRYPTO off=257 len=257 [2025-12-14T07:19:31.472556873Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 303 bytes [2025-12-14T07:19:31.472563927Z TRACE quiche_apps::client] got 67 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.472568946Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec dropped invalid packet [2025-12-14T07:19:31.472572833Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 67 bytes [2025-12-14T07:19:31.472577322Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.472580788Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.472591358Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=5 pn=8 [2025-12-14T07:19:31.472595285Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=11 blocks=[0..3] ecn_counts=None [2025-12-14T07:19:31.472604162Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=990.799353ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 8, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 764804890 }, next_time: Instant { tv_sec: 855, tv_nsec: 764804890 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.472652402Z TRACE quiche_apps::client] written 35 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.472661699Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.472672269Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.472679393Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=52 pn=4 [2025-12-14T07:19:31.472691244Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[30, 83, 40, f4, d9, b1, 5a, a9, 12, 18, 2c, 44] reset_token=[52, a2, bd, ec, 1e, 59, e8, f1, 77, 46, fc, 59, 27, b2, 08, e9] [2025-12-14T07:19:31.472708026Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 73 bytes [2025-12-14T07:19:31.472713446Z TRACE quiche_apps::client] got 73 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.472717153Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=52 pn=5 [2025-12-14T07:19:31.472722814Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[83, 6d, f8, 84, 98, bf, 2f, cc, 3e, 3e, a8, 0c] reset_token=[75, bf, 1a, 84, a6, e4, 97, c0, 5d, 4f, 85, 7c, d9, be, 76, c5] [2025-12-14T07:19:31.472729155Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 73 bytes [2025-12-14T07:19:31.472733293Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.472737250Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.472749223Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=5 pn=9 [2025-12-14T07:19:31.472758520Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=3 blocks=[0..5] ecn_counts=None [2025-12-14T07:19:31.472771575Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=990.631078ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 9, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 764964749 }, next_time: Instant { tv_sec: 855, tv_nsec: 764964749 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.472837869Z TRACE quiche_apps::client] written 35 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.472844341Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.473739603Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.473749392Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=6 [2025-12-14T07:19:31.473756655Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=0 len=1171 fin=false [2025-12-14T07:19:31.473765091Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.473769069Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.473771904Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.473777334Z TRACE quiche_apps::common] received 1171 bytes [2025-12-14T07:19:31.473780490Z TRACE quiche_apps::common] stream 0 has 1171 bytes (fin? false) [2025-12-14T07:19:31.473808222Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=5 pn=10 [2025-12-14T07:19:31.473811638Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=7 blocks=[0..6] ecn_counts=None [2025-12-14T07:19:31.473819022Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=989.584443ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 10, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 766022936 }, next_time: Instant { tv_sec: 855, tv_nsec: 766022936 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.473855700Z TRACE quiche_apps::client] written 35 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.473860980Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.474733661Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.474742337Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=7 [2025-12-14T07:19:31.474749400Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=1171 len=1169 fin=false [2025-12-14T07:19:31.474757285Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.474761272Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.474764078Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.474768646Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.474771471Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.474779346Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=5 pn=11 [2025-12-14T07:19:31.474801748Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=4 blocks=[0..7] ecn_counts=None [2025-12-14T07:19:31.474809312Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=988.594162ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 11, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 766994601 }, next_time: Instant { tv_sec: 855, tv_nsec: 766994601 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.474839799Z TRACE quiche_apps::client] written 35 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.474844428Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.475732227Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.475741073Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=9 [2025-12-14T07:19:31.475748367Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=2340 len=1169 fin=false [2025-12-14T07:19:31.475756272Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.475760269Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.475763115Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.475767693Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.475770478Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.475778613Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=7 pn=12 [2025-12-14T07:19:31.475798541Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=4 blocks=[0..7, 9..9] ecn_counts=None [2025-12-14T07:19:31.475809822Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=987.593593ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 12, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 767993608 }, next_time: Instant { tv_sec: 855, tv_nsec: 767993608 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.475847061Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.475852882Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.476726705Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.476735161Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=10 [2025-12-14T07:19:31.476742194Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=3509 len=1169 fin=false [2025-12-14T07:19:31.476750039Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.476753996Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.476756801Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.476761360Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.476764045Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.476772020Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=7 pn=13 [2025-12-14T07:19:31.476775146Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=4 blocks=[0..7, 9..10] ecn_counts=None [2025-12-14T07:19:31.476800062Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=986.603332ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 13, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 768987134 }, next_time: Instant { tv_sec: 855, tv_nsec: 768987134 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.476833535Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.476838334Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.477725341Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.477738907Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=11 [2025-12-14T07:19:31.477746010Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=4678 len=1169 fin=false [2025-12-14T07:19:31.477753904Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.477757832Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.477760667Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.477765256Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.477767931Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.477775896Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=7 pn=14 [2025-12-14T07:19:31.477779001Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=4 blocks=[0..7, 9..11] ecn_counts=None [2025-12-14T07:19:31.477805942Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=985.597362ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 14, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 769991021 }, next_time: Instant { tv_sec: 855, tv_nsec: 769991021 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.477836930Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.477841598Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.478718898Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.478727574Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=12 [2025-12-14T07:19:31.478734487Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=5847 len=1169 fin=false [2025-12-14T07:19:31.478742281Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.478746178Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.478748964Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.478753512Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.478756137Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.478764052Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=7 pn=15 [2025-12-14T07:19:31.478767158Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=4 blocks=[0..7, 9..12] ecn_counts=None [2025-12-14T07:19:31.478773961Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=984.629534ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 15, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 770979257 }, next_time: Instant { tv_sec: 855, tv_nsec: 770979257 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.478829625Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.478835606Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.479716752Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.479725619Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=13 [2025-12-14T07:19:31.479732492Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=7016 len=1169 fin=false [2025-12-14T07:19:31.479740296Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.479744203Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.479747009Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.479751517Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.479754162Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.479762237Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=7 pn=16 [2025-12-14T07:19:31.479765353Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=4 blocks=[0..7, 9..13] ecn_counts=None [2025-12-14T07:19:31.479772146Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=983.631389ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 16, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 771977302 }, next_time: Instant { tv_sec: 855, tv_nsec: 771977302 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.479821839Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.479826828Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.480714206Z TRACE quiche_apps::client] got 1216 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.480722762Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=1195 pn=14 [2025-12-14T07:19:31.480729645Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=8185 len=1169 fin=false [2025-12-14T07:19:31.480737439Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 1216 bytes [2025-12-14T07:19:31.480746567Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.480749462Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.480754161Z TRACE quiche_apps::common] received 1169 bytes [2025-12-14T07:19:31.480756806Z TRACE quiche_apps::common] stream 0 has 1169 bytes (fin? false) [2025-12-14T07:19:31.480778206Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=7 pn=17 [2025-12-14T07:19:31.480799025Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm ACK delay=6 blocks=[0..7, 9..14] ecn_counts=None [2025-12-14T07:19:31.480809564Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=982.5939ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=343 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 4, last_sent_packet: 17, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 772993010 }, next_time: Instant { tv_sec: 855, tv_nsec: 772993010 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.480840502Z TRACE quiche_apps::client] written 37 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.480845020Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.481434752Z TRACE quiche_apps::client] got 933 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.481446103Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx pkt Short dcid=5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec key_phase=false len=912 pn=15 [2025-12-14T07:19:31.481453828Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec rx frm STREAM id=0 off=9354 len=886 fin=true [2025-12-14T07:19:31.481462294Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 933 bytes [2025-12-14T07:19:31.481466502Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.481469297Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.481474326Z TRACE quiche_apps::common] received 886 bytes [2025-12-14T07:19:31.481477051Z TRACE quiche_apps::common] stream 0 has 886 bytes (fin? true) [2025-12-14T07:19:31.481479846Z DEBUG quiche_apps::common] 1/1 responses received [2025-12-14T07:19:31.481482712Z INFO quiche_apps::common] 1/1 response(s) received in 113.717068ms, closing... [2025-12-14T07:19:31.481490607Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx pkt Short dcid=890e5087e754418b2592fe0d key_phase=false len=10 pn=18 [2025-12-14T07:19:31.481493803Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec tx frm APPLICATION_CLOSE err=0 reason=[6b, 74, 68, 78, 62, 79, 65] [2025-12-14T07:19:31.481501557Z TRACE quiche::recovery::congestion::recovery] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec timer=1.023985102s latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=383 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, first_sent_time: Instant { tv_sec: 855, tv_nsec: 731623208 }, end_of_app_limited: 17, last_sent_packet: 18, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, is_app_limited: false, interval: 0ns, delivered: 0, prior_delivered: 0, prior_time: None, send_elapsed: 0ns, ack_elapsed: 0ns, rtt: 0ns } } pacer=Pacer { enabled: true, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 855, tv_nsec: 773706393 }, next_time: Instant { tv_sec: 855, tv_nsec: 773706393 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-12-14T07:19:31.481539939Z TRACE quiche_apps::client] written 40 bytes from 0.0.0.0:44001 to 193.167.100.100:443 [2025-12-14T07:19:31.481544377Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.496513317Z TRACE quiche_apps::client] got 47 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.496522424Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 47 bytes [2025-12-14T07:19:31.496526291Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.496529167Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.496533325Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:31.512107316Z TRACE quiche_apps::client] got 45 bytes from 193.167.100.100:443 to 0.0.0.0:44001 [2025-12-14T07:19:31.512120030Z TRACE quiche_apps::client] 0.0.0.0:44001: processed 45 bytes [2025-12-14T07:19:31.512124848Z TRACE quiche_apps::client] 0.0.0.0:44001: recv() would block [2025-12-14T07:19:31.512128405Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:31.512133645Z TRACE quiche_apps::client] 0.0.0.0:44001 -> 193.167.100.100:443: done writing [2025-12-14T07:19:34.482159891Z TRACE quiche_apps::client] timed out [2025-12-14T07:19:34.482193254Z TRACE quiche] 5ea841c4d6a10bdfc3fc5b31609a48b688bcd1ec draining timeout expired [2025-12-14T07:19:34.482242235Z TRACE quiche_apps::client] done reading [2025-12-14T07:19:34.482249128Z INFO quiche_apps::client] connection closed, recv=20 sent=19 lost=0 retrans=0 sent_bytes=1781 recv_bytes=13741 lost_bytes=0 [local_addr=0.0.0.0:44001 peer_addr=193.167.100.100:443 validation_state=Validated active=true recv=20 sent=19 lost=0 retrans=0 rtt=333ms min_rtt=None rttvar=166.5ms cwnd=13500 sent_bytes=1781 recv_bytes=13741 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=0]