[2025-04-30T11:24:03.488977224Z INFO quiche_server] listening on [::]:443 [2025-04-30T11:24:03.489002801Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T11:24:03.489011578Z TRACE quiche_server] GSO detected: false [2025-04-30T11:24:04.336576259Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:45142 to [::]:443 [2025-04-30T11:24:04.336604261Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T11:24:04.336614450Z WARN quiche_server] Doing version negotiation [2025-04-30T11:24:04.336714818Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:45142 to [::]:443 [2025-04-30T11:24:04.336722031Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T11:24:04.336726209Z WARN quiche_server] Doing version negotiation [2025-04-30T11:24:04.336749593Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:45142 to [::]:443 [2025-04-30T11:24:04.336754782Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T11:24:04.336760974Z WARN quiche_server] Doing version negotiation [2025-04-30T11:24:04.336791190Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.723880791Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.723903233Z TRACE quiche_server] got packet Initial version=1 dcid=8389b754d896d0f5 scid=93011db0bcb9c058 token= [2025-04-30T11:24:04.723913172Z WARN quiche_server] Doing stateless retry [2025-04-30T11:24:04.723961552Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.756998727Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.757012733Z TRACE quiche_server] got packet Initial version=1 dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 scid=93011db0bcb9c058 token=71756963686500000000000000000000ffffc1a700648389b754d896d0f5 [2025-04-30T11:24:04.757021209Z DEBUG quiche_server] New connection: dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 scid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 [2025-04-30T11:24:04.757204051Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Initial version=1 dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 scid=93011db0bcb9c058 token=71756963686500000000000000000000ffffc1a700648389b754d896d0f5 len=504 pn=1 [2025-04-30T11:24:04.757217877Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm CRYPTO off=0 len=482 [2025-04-30T11:24:04.757244917Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T11:24:04.757249596Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T11:24:04.757366314Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 write message lvl=Initial len=123 [2025-04-30T11:24:04.757396921Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 set write secret lvl=Handshake [2025-04-30T11:24:04.757506436Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 write message lvl=Handshake len=737 [2025-04-30T11:24:04.757510794Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 set write secret lvl=OneRTT [2025-04-30T11:24:04.757520372Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 set read secret lvl=Handshake [2025-04-30T11:24:04.757559315Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 dropped invalid packet [2025-04-30T11:24:04.757563112Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 1200 bytes [2025-04-30T11:24:04.757582839Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.757595623Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Initial version=1 dcid=93011db0bcb9c058 scid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 len=132 pn=0 [2025-04-30T11:24:04.757599750Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm ACK delay=51 blocks=[1..1] ecn_counts=None [2025-04-30T11:24:04.757604850Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm CRYPTO off=0 len=123 [2025-04-30T11:24:04.757615219Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=998.969603ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=187 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 271, tv_nsec: 787174290 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 787174290 }, 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: false, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 271, tv_nsec: 787174290 }, next_time: Instant { tv_sec: 271, tv_nsec: 787174290 }, 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-30T11:24:04.757646608Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Handshake version=1 dcid=93011db0bcb9c058 scid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 len=741 pn=1 [2025-04-30T11:24:04.757650214Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm CRYPTO off=0 len=737 [2025-04-30T11:24:04.757656977Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=998.928226ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=982 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 271, tv_nsec: 787174290 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 787174290 }, 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: false, capacity: 13500, used: 0, rate: 0, last_update: Instant { tv_sec: 271, tv_nsec: 787174290 }, next_time: Instant { tv_sec: 271, tv_nsec: 787174290 }, 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-30T11:24:04.757703033Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:52618, at: Instant { tv_sec: 271, tv_nsec: 787174290 } }) [2025-04-30T11:24:04.757709916Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.757714855Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.757720175Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.757725105Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.792168780Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.792184810Z TRACE quiche_server] got packet Initial version=1 dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 scid=93011db0bcb9c058 token=71756963686500000000000000000000ffffc1a700648389b754d896d0f5 [2025-04-30T11:24:04.792199788Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Initial version=1 dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 scid=93011db0bcb9c058 token=71756963686500000000000000000000ffffc1a700648389b754d896d0f5 len=24 pn=2 [2025-04-30T11:24:04.792208525Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm ACK delay=235 blocks=[0..0] ecn_counts=None [2025-04-30T11:24:04.792213424Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 0 [2025-04-30T11:24:04.792236176Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Handshake version=1 dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 scid=93011db0bcb9c058 len=80 pn=3 [2025-04-30T11:24:04.792242177Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm ACK delay=235 blocks=[1..1] ecn_counts=None [2025-04-30T11:24:04.792245574Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 1 [2025-04-30T11:24:04.792249391Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm CRYPTO off=0 len=52 [2025-04-30T11:24:04.792261824Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 set read secret lvl=OneRTT [2025-04-30T11:24:04.792298463Z TRACE quiche::tls] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 write message lvl=OneRTT len=428 [2025-04-30T11:24:04.792305967Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 dropped epoch 1 state [2025-04-30T11:24:04.792309874Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 connection established: proto=Ok("hq-interop") cipher=Some(AES256_GCM) curve=Some("P-256") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 60000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 1048576, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 1048576, initial_max_streams_bidi: 128, initial_max_streams_uni: 128, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(93011db0bcb9c058), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T11:24:04.792328899Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 dropped epoch 0 state [2025-04-30T11:24:04.792332536Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=970 pn=4 [2025-04-30T11:24:04.792339550Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[7b, 21, e9, 60, 96, 7f, 1a, a3] reset_token=[dd, f8, 3c, cf, bf, 6d, e8, 32, 02, fd, 52, 39, d3, 02, 3d, b2] [2025-04-30T11:24:04.792347494Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[31, 82, 2f, 60, dc, df, 3e, ff] reset_token=[6c, cc, 96, 28, 93, da, 09, cc, bb, 20, fd, 7c, 64, ed, 31, 3d] [2025-04-30T11:24:04.792353055Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[50, b8, 1c, 87, 51, ac, 5b, ec] reset_token=[ec, 5f, ac, 37, 74, 44, e5, 46, f2, 52, c6, e4, b2, e0, 29, 72] [2025-04-30T11:24:04.792358635Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[33, cf, 25, 03, af, 5d, b0, 10] reset_token=[41, 60, 53, 82, 18, 16, f2, 13, c3, ba, 8a, 69, 63, eb, 83, 02] [2025-04-30T11:24:04.792364657Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[bb, 83, 1d, 80, 26, b9, 37, ed] reset_token=[1b, 88, 1e, a4, 2c, d8, 33, bb, 30, 62, 95, 80, 0b, 77, e1, be] [2025-04-30T11:24:04.792370848Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[cf, 50, 39, a4, 90, 05, 46, 97] reset_token=[20, 62, c0, 80, 0d, 5e, 71, 27, aa, ee, 84, 2d, 93, 67, 36, c6] [2025-04-30T11:24:04.792376448Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[0b, d0, 6a, e1, 74, f3, 03, 7e] reset_token=[39, 9f, 5a, e8, 1f, 70, 2c, 21, e2, cb, fe, 96, fb, ff, 36, 0f] [2025-04-30T11:24:04.792383672Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm PADDING len=756 [2025-04-30T11:24:04.792393130Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 1200 bytes [2025-04-30T11:24:04.792406735Z TRACE quiche_server] got 60 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.792410903Z TRACE quiche_server] got packet Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false [2025-04-30T11:24:04.792445287Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=39 pn=5 [2025-04-30T11:24:04.792450918Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm STREAM id=0 off=0 len=17 fin=true [2025-04-30T11:24:04.792459443Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 60 bytes [2025-04-30T11:24:04.792462860Z DEBUG quiche_apps::common] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 response stream 0 is writable with capacity Ok(13500) [2025-04-30T11:24:04.792469753Z TRACE quiche_apps::common] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 received 17 bytes [2025-04-30T11:24:04.792472779Z TRACE quiche_apps::common] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 stream 0 has 17 bytes (fin? true) [2025-04-30T11:24:04.792477648Z INFO quiche_apps::common] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 got GET request for "/www/vmpuhgvqmv" on stream 0 [2025-04-30T11:24:04.792501642Z INFO quiche_apps::common] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 sending response of size 10240 on stream 0 [2025-04-30T11:24:04.792510649Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.792518504Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319 [2025-04-30T11:24:04.792527531Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=2 [2025-04-30T11:24:04.792531017Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm ACK delay=9 blocks=[4..5] ecn_counts=None [2025-04-30T11:24:04.792534915Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[10, b5, 65, ea, 17, d1, 7b, f0, 7b, 69, 05, 35, 7d, 19, ca, 11, 70, f0, a6, 64] reset_token=[59, ea, 66, aa, 2b, 12, fc, ac, fe, 6f, 58, ee, 93, 85, 62, 02] [2025-04-30T11:24:04.792541908Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[84, b0, 02, b0, a7, ec, 24, 39, ca, 0c, 5b, 16, 5f, 23, 75, 6a, 41, 9f, 3f, ed] reset_token=[09, 3f, da, 29, 81, c5, 32, 2c, 6d, 30, 99, b7, ad, 51, 72, 1b] [2025-04-30T11:24:04.792548260Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[af, ae, 16, 9b, 68, 0e, 0f, 5f, 3d, 61, 07, 4e, 5f, 60, cf, d6, 79, 2f, 5c, 16] reset_token=[20, 7d, f3, 09, 7f, bb, 2e, de, bd, 42, c4, 4c, 2f, d3, a0, 87] [2025-04-30T11:24:04.792554471Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[6b, eb, 2f, 8c, f3, 39, aa, 3a, d4, c9, ac, a9, 75, c8, 23, 9c, 5b, 84, 95, 79] reset_token=[ec, 3e, 37, 76, 0a, b0, d6, a3, 7f, b0, 71, 08, ab, f0, 20, dc] [2025-04-30T11:24:04.792560492Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[b4, a2, 3f, 5c, 7d, b3, 34, 88, 0d, a4, 3c, 44, 1d, 47, 13, a6, cf, 6f, 3c, 04] reset_token=[d8, c3, 26, 63, ac, d0, 4f, c4, 1a, 08, 54, 77, a3, 53, 34, 74] [2025-04-30T11:24:04.792566734Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[8e, ab, 33, 78, 4c, 77, 4b, 12, f1, dd, 8e, de, 55, 48, 72, f7, c7, 1a, 40, a0] reset_token=[11, 71, 00, 94, 41, 01, 3b, 65, 0a, 91, ed, 09, 71, cb, e7, b4] [2025-04-30T11:24:04.792572946Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[e7, d0, ef, d2, be, e4, 89, 5b, 90, ed, 65, df, e8, b2, d9, 05, 44, 55, bc, 3c] reset_token=[89, ad, c9, e4, 54, c9, 50, 8b, a6, ac, 18, 9d, c1, e2, 24, ad] [2025-04-30T11:24:04.792578967Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm HANDSHAKE_DONE [2025-04-30T11:24:04.792586832Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm CRYPTO off=0 len=428 [2025-04-30T11:24:04.792589887Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=0 len=601 fin=false [2025-04-30T11:24:04.792604114Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.481551ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792620695Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324 [2025-04-30T11:24:04.792624943Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=3 [2025-04-30T11:24:04.792627969Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=601 len=1318 fin=false [2025-04-30T11:24:04.792652154Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.538918ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792665529Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1324 [2025-04-30T11:24:04.792669536Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=4 [2025-04-30T11:24:04.792672461Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=1919 len=1318 fin=false [2025-04-30T11:24:04.792678222Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.558004ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792692950Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1324 [2025-04-30T11:24:04.792696647Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=5 [2025-04-30T11:24:04.792699492Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=3237 len=1318 fin=false [2025-04-30T11:24:04.792704872Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.559316ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792716073Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1324 [2025-04-30T11:24:04.792719560Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=6 [2025-04-30T11:24:04.792722445Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=4555 len=1318 fin=false [2025-04-30T11:24:04.792727965Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.559386ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792742332Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=6750 out_len=1350 left=1324 [2025-04-30T11:24:04.792745899Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=7 [2025-04-30T11:24:04.792748774Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=5873 len=1318 fin=false [2025-04-30T11:24:04.792754044Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.559476ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792765085Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5400 out_len=1350 left=1324 [2025-04-30T11:24:04.792768661Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=8 [2025-04-30T11:24:04.792771507Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=7191 len=1318 fin=false [2025-04-30T11:24:04.792776767Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.559637ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792791073Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4050 out_len=1350 left=1324 [2025-04-30T11:24:04.792794610Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=1324 pn=9 [2025-04-30T11:24:04.792797495Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=8509 len=1318 fin=false [2025-04-30T11:24:04.792802675Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.559677ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.792814106Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1324 [2025-04-30T11:24:04.792817553Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx pkt Short dcid=93011db0bcb9c058 key_phase=false len=419 pn=10 [2025-04-30T11:24:04.792820488Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 tx frm STREAM id=0 off=9827 len=413 fin=true [2025-04-30T11:24:04.792825848Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 timer=111.559587ms latest_rtt=34.649751ms srtt=34.616823ms min_rtt=34.612121ms rttvar=12.988952ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11245 app_limited=true congestion_recovery_start_time=None Rate { delivered: 982, delivered_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, first_sent_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 28371, is_app_limited: true, interval: 34.612121ms, delivered: 982, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 271, tv_nsec: 787174290 }), send_elapsed: 0ns, ack_elapsed: 34.612121ms, rtt: 34.612121ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 487479, last_update: Instant { tv_sec: 271, tv_nsec: 822102181 }, next_time: Instant { tv_sec: 271, tv_nsec: 822102181 }, 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-30T11:24:04.793045378Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 written 11245 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:52618, at: Instant { tv_sec: 271, tv_nsec: 822102181 } }) [2025-04-30T11:24:04.793055948Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.793062631Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.793073631Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.793077619Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.825552924Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.825565518Z TRACE quiche_server] got packet Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false [2025-04-30T11:24:04.825573052Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=23 pn=6 [2025-04-30T11:24:04.825580186Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm ACK delay=7 blocks=[2..3] ecn_counts=None [2025-04-30T11:24:04.825584804Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 2 [2025-04-30T11:24:04.825589012Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 3 [2025-04-30T11:24:04.825604010Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 44 bytes [2025-04-30T11:24:04.825609149Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.825612726Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.825615541Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.827752605Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.827761131Z TRACE quiche_server] got packet Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false [2025-04-30T11:24:04.827766170Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=23 pn=7 [2025-04-30T11:24:04.827771009Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm ACK delay=9 blocks=[2..5] ecn_counts=None [2025-04-30T11:24:04.827774175Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 4 [2025-04-30T11:24:04.827776559Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 5 [2025-04-30T11:24:04.827786318Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 44 bytes [2025-04-30T11:24:04.827790195Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.827792910Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.827795074Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.829933650Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.829941805Z TRACE quiche_server] got packet Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false [2025-04-30T11:24:04.829946645Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=23 pn=8 [2025-04-30T11:24:04.829951463Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm ACK delay=6 blocks=[2..7] ecn_counts=None [2025-04-30T11:24:04.829954689Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 6 [2025-04-30T11:24:04.829957425Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 7 [2025-04-30T11:24:04.829969237Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 44 bytes [2025-04-30T11:24:04.829973956Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.829977252Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.829979997Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.832158848Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.832169007Z TRACE quiche_server] got packet Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false [2025-04-30T11:24:04.832175069Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=23 pn=9 [2025-04-30T11:24:04.832187802Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm ACK delay=6 blocks=[2..9] ecn_counts=None [2025-04-30T11:24:04.832191980Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 8 [2025-04-30T11:24:04.832194916Z TRACE quiche::recovery::congestion::recovery] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 packet newly acked 9 [2025-04-30T11:24:04.832206487Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 44 bytes [2025-04-30T11:24:04.832211276Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.832214652Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.832217348Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:04.832865298Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:52618 to [::]:443 [2025-04-30T11:24:04.832875628Z TRACE quiche_server] got packet Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false [2025-04-30T11:24:04.832881809Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx pkt Short dcid=009c87bc09f16bae1228ff483aed0ee7cbdc9d38 key_phase=false len=22 pn=10 [2025-04-30T11:24:04.832887891Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 rx frm APPLICATION_CLOSE err=100 reason=[] [2025-04-30T11:24:04.832896066Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 processed 43 bytes [2025-04-30T11:24:04.832900634Z TRACE quiche_server] recv() would block [2025-04-30T11:24:04.832903510Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:04.832906205Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:05.013129982Z TRACE quiche_server] timed out [2025-04-30T11:24:05.013142976Z TRACE quiche] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 draining timeout expired [2025-04-30T11:24:05.013171049Z TRACE quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 done writing [2025-04-30T11:24:05.013174605Z TRACE quiche_server] Collecting garbage [2025-04-30T11:24:05.013177801Z INFO quiche_server] 009c87bc09f16bae1228ff483aed0ee7cbdc9d38 connection collected recv=10 sent=11 lost=0 retrans=0 sent_bytes=12227 recv_bytes=2051 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:52618 validation_state=Validated active=true recv=10 sent=11 lost=0 retrans=0 rtt=35.467369ms min_rtt=Some(33.058145ms) rttvar=6.10282ms cwnd=13500 sent_bytes=12227 recv_bytes=2051 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=326697]