[2025-04-30T10:36:46.354892761Z INFO quiche_server] listening on [::]:443 [2025-04-30T10:36:46.354915394Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T10:36:46.354922167Z TRACE quiche_server] GSO detected: false [2025-04-30T10:36:47.169658012Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:43464 to [::]:443 [2025-04-30T10:36:47.169690634Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:36:47.169698578Z WARN quiche_server] Doing version negotiation [2025-04-30T10:36:47.169803536Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:43464 to [::]:443 [2025-04-30T10:36:47.169809788Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:36:47.169813635Z WARN quiche_server] Doing version negotiation [2025-04-30T10:36:47.169834404Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:43464 to [::]:443 [2025-04-30T10:36:47.169838482Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:36:47.169841758Z WARN quiche_server] Doing version negotiation [2025-04-30T10:36:47.169857708Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.392483682Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.392505934Z TRACE quiche_server] got packet Initial version=1 dcid=6ca9750611c8db2a65e9b9b8d87b00fbd796 scid=2e0d288488eea946 token= [2025-04-30T10:36:47.392515292Z WARN quiche_server] Doing stateless retry [2025-04-30T10:36:47.392564885Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.424234029Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.424254518Z TRACE quiche_server] got packet Initial version=1 dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 scid=2e0d288488eea946 token=71756963686500000000000000000000ffffc1a700646ca9750611c8db2a65e9b9b8d87b00fbd796 [2025-04-30T10:36:47.424265468Z DEBUG quiche_server] New connection: dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 scid=744086f7ddc955b3c3e7fffdf39e5e1100970476 [2025-04-30T10:36:47.424524345Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Initial version=1 dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 scid=2e0d288488eea946 token=71756963686500000000000000000000ffffc1a700646ca9750611c8db2a65e9b9b8d87b00fbd796 len=1122 pn=1 [2025-04-30T10:36:47.424543481Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm CRYPTO off=0 len=248 [2025-04-30T10:36:47.424570532Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T10:36:47.424575422Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T10:36:47.424674758Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 write message lvl=Initial len=90 [2025-04-30T10:36:47.424705506Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 set write secret lvl=Handshake [2025-04-30T10:36:47.424779936Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 write message lvl=Handshake len=730 [2025-04-30T10:36:47.424783754Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 set write secret lvl=OneRTT [2025-04-30T10:36:47.424791468Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 set read secret lvl=Handshake [2025-04-30T10:36:47.424814271Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm PADDING len=853 [2025-04-30T10:36:47.424837675Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 1200 bytes [2025-04-30T10:36:47.424859696Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.424873122Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Initial version=1 dcid=2e0d288488eea946 scid=744086f7ddc955b3c3e7fffdf39e5e1100970476 len=99 pn=0 [2025-04-30T10:36:47.424876989Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm ACK delay=45 blocks=[1..1] ecn_counts=None [2025-04-30T10:36:47.424882880Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm CRYPTO off=0 len=90 [2025-04-30T10:36:47.424899501Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=998.962269ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=154 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 298, tv_nsec: 776417536 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 776417536 }, 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: 298, tv_nsec: 776417536 }, next_time: Instant { tv_sec: 298, tv_nsec: 776417536 }, 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-30T10:36:47.424920651Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Handshake version=1 dcid=2e0d288488eea946 scid=744086f7ddc955b3c3e7fffdf39e5e1100970476 len=734 pn=1 [2025-04-30T10:36:47.424923426Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm CRYPTO off=0 len=730 [2025-04-30T10:36:47.424928827Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=998.933485ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=942 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 298, tv_nsec: 776417536 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 776417536 }, 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: 298, tv_nsec: 776417536 }, next_time: Instant { tv_sec: 298, tv_nsec: 776417536 }, 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-30T10:36:47.424972899Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:34438, at: Instant { tv_sec: 298, tv_nsec: 776417536 } }) [2025-04-30T10:36:47.424979181Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.424986084Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.424991574Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.424995422Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.459182052Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.459201078Z TRACE quiche_server] got packet Initial version=1 dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 scid=2e0d288488eea946 token=71756963686500000000000000000000ffffc1a700646ca9750611c8db2a65e9b9b8d87b00fbd796 [2025-04-30T10:36:47.459215916Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Initial version=1 dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 scid=2e0d288488eea946 token=71756963686500000000000000000000ffffc1a700646ca9750611c8db2a65e9b9b8d87b00fbd796 len=937 pn=2 [2025-04-30T10:36:47.459228380Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=202 blocks=[0..0] ecn_counts=None [2025-04-30T10:36:47.459242476Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 0 [2025-04-30T10:36:47.459251463Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm PADDING len=913 [2025-04-30T10:36:47.459272834Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Handshake version=1 dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 scid=2e0d288488eea946 len=62 pn=3 [2025-04-30T10:36:47.459278774Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=90 blocks=[1..1] ecn_counts=None [2025-04-30T10:36:47.459282271Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 1 [2025-04-30T10:36:47.459286159Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm CRYPTO off=0 len=36 [2025-04-30T10:36:47.459301888Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 set read secret lvl=OneRTT [2025-04-30T10:36:47.459338787Z TRACE quiche::tls] 744086f7ddc955b3c3e7fffdf39e5e1100970476 write message lvl=OneRTT len=396 [2025-04-30T10:36:47.459348215Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 dropped epoch 1 state [2025-04-30T10:36:47.459352503Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 15728640, initial_max_stream_data_bidi_local: 6291456, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 32768, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(2e0d288488eea946), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T10:36:47.459373262Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 dropped epoch 0 state [2025-04-30T10:36:47.459377070Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=65 pn=4 [2025-04-30T10:36:47.459383952Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[86, cd, 9d, 09, cc, 23, 35, 59] reset_token=[8c, 76, de, 16, 63, e4, 62, 66, a1, 35, 0c, d5, c1, ea, c2, d5] [2025-04-30T10:36:47.459391206Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm STREAM id=0 off=0 len=17 fin=true [2025-04-30T10:36:47.459399902Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 1200 bytes [2025-04-30T10:36:47.459404301Z DEBUG quiche_apps::common] 744086f7ddc955b3c3e7fffdf39e5e1100970476 response stream 0 is writable with capacity Ok(13500) [2025-04-30T10:36:47.459411735Z TRACE quiche_apps::common] 744086f7ddc955b3c3e7fffdf39e5e1100970476 received 17 bytes [2025-04-30T10:36:47.459414801Z TRACE quiche_apps::common] 744086f7ddc955b3c3e7fffdf39e5e1100970476 stream 0 has 17 bytes (fin? true) [2025-04-30T10:36:47.459420000Z INFO quiche_apps::common] 744086f7ddc955b3c3e7fffdf39e5e1100970476 got GET request for "/www/ttuujwjykd" on stream 0 [2025-04-30T10:36:47.459472028Z INFO quiche_apps::common] 744086f7ddc955b3c3e7fffdf39e5e1100970476 sending response of size 10240 on stream 0 [2025-04-30T10:36:47.459489551Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.459499219Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319 [2025-04-30T10:36:47.459509429Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=2 [2025-04-30T10:36:47.459513115Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm ACK delay=15 blocks=[4..4] ecn_counts=None [2025-04-30T10:36:47.459517203Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[f1, fe, c7, 06, e3, b1, fc, f9, e5, 45, 01, 62, 74, 1d, 52, 93, 41, d6, ea, 9b] reset_token=[de, b3, 58, e1, 9d, 4c, e4, 05, 37, fd, 5d, 93, d5, f9, 59, 91] [2025-04-30T10:36:47.459529917Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[42, 36, 04, f8, 7c, 34, 3d, 22, 35, e2, 4e, 96, 8b, 5f, 87, ed, e3, 2b, 84, 21] reset_token=[cf, 6c, 8f, 7f, 3e, 68, a6, 0e, 37, 63, 6b, 04, 8a, ad, ec, af] [2025-04-30T10:36:47.459536349Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[20, 46, 95, 21, 50, 0f, 28, 47, 48, 4e, 6e, e8, 36, ef, d6, cc, 04, 5b, e5, 2e] reset_token=[b4, f7, 03, e1, 58, 7f, 8e, a9, 30, ba, 6b, 5c, 64, 44, 09, 49] [2025-04-30T10:36:47.459542811Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[41, 8b, 06, 1f, 6c, 2c, b1, e0, 31, 88, f1, 58, 8e, 18, 70, ff, 3a, a8, c0, 91] reset_token=[de, fb, e9, 9c, 7d, 7c, fb, f6, 97, 11, 42, db, 45, 0a, 9b, d4] [2025-04-30T10:36:47.459549093Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[3f, 87, d4, 0b, 19, fd, dc, 50, d9, f0, 13, 34, 23, fc, 37, 16, 1a, 28, f6, 4f] reset_token=[d4, 56, be, ed, 92, 7a, a2, 11, 97, 6b, d1, eb, 3a, 38, 34, 3e] [2025-04-30T10:36:47.459555074Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[69, a3, 2d, 26, 68, e0, e2, 18, 02, 81, a3, ee, ed, 37, 94, 28, 01, 7f, c7, 1a] reset_token=[77, b5, 6c, 15, b2, 50, 3a, 7e, 8e, d7, 65, 71, 52, 1b, 0a, 0e] [2025-04-30T10:36:47.459561236Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[a7, 15, a1, 54, 9f, d5, 92, fd, fd, ce, 5d, 83, 67, f1, da, df, 71, 57, 4d, e5] reset_token=[c2, 99, 72, f1, 13, d6, b5, 80, 17, bb, 16, 75, 49, 17, b9, 93] [2025-04-30T10:36:47.459567077Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm HANDSHAKE_DONE [2025-04-30T10:36:47.459569852Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm CRYPTO off=0 len=396 [2025-04-30T10:36:47.459572698Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=0 len=633 fin=false [2025-04-30T10:36:47.459588267Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.844544ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459613344Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324 [2025-04-30T10:36:47.459617542Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=3 [2025-04-30T10:36:47.459624104Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=633 len=1318 fin=false [2025-04-30T10:36:47.459630697Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.9216ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459643451Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1324 [2025-04-30T10:36:47.459647268Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=4 [2025-04-30T10:36:47.459650153Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=1951 len=1318 fin=false [2025-04-30T10:36:47.459655764Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.92736ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459667205Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1324 [2025-04-30T10:36:47.459670812Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=5 [2025-04-30T10:36:47.459673728Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=3269 len=1318 fin=false [2025-04-30T10:36:47.459679188Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.927791ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459693735Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1324 [2025-04-30T10:36:47.459697242Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=6 [2025-04-30T10:36:47.459700097Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=4587 len=1318 fin=false [2025-04-30T10:36:47.459706099Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.927441ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459717550Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=6750 out_len=1350 left=1324 [2025-04-30T10:36:47.459721117Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=7 [2025-04-30T10:36:47.459723982Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=5905 len=1318 fin=false [2025-04-30T10:36:47.459749330Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.907774ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459764729Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5400 out_len=1350 left=1324 [2025-04-30T10:36:47.459768687Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=8 [2025-04-30T10:36:47.459771562Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=7223 len=1318 fin=false [2025-04-30T10:36:47.459777313Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.926869ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459788854Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4050 out_len=1350 left=1324 [2025-04-30T10:36:47.459792391Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=1324 pn=9 [2025-04-30T10:36:47.459795237Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=8541 len=1318 fin=false [2025-04-30T10:36:47.459800677Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.927902ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.459811858Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1324 [2025-04-30T10:36:47.459818570Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx pkt Short dcid=2e0d288488eea946 key_phase=false len=387 pn=10 [2025-04-30T10:36:47.459821606Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 tx frm STREAM id=0 off=9859 len=381 fin=true [2025-04-30T10:36:47.459827267Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 timer=110.924536ms latest_rtt=34.40949ms srtt=34.357031ms min_rtt=34.349538ms rttvar=12.896064ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11213 app_limited=true congestion_recovery_start_time=None Rate { delivered: 942, delivered_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, first_sent_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27423, is_app_limited: true, interval: 34.349538ms, delivered: 942, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 298, tv_nsec: 776417536 }), send_elapsed: 0ns, ack_elapsed: 34.349538ms, rtt: 34.349538ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 491165, last_update: Instant { tv_sec: 298, tv_nsec: 811047731 }, next_time: Instant { tv_sec: 298, tv_nsec: 811047731 }, 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-30T10:36:47.460051118Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 written 11213 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:34438, at: Instant { tv_sec: 298, tv_nsec: 811047731 } }) [2025-04-30T10:36:47.460062048Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.460068651Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.460073189Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.460076896Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.492641192Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.492663454Z TRACE quiche_server] got packet Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false [2025-04-30T10:36:47.492677280Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=23 pn=5 [2025-04-30T10:36:47.492689813Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=5 blocks=[2..3] ecn_counts=None [2025-04-30T10:36:47.492697107Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 2 [2025-04-30T10:36:47.492703008Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 3 [2025-04-30T10:36:47.492726622Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 44 bytes [2025-04-30T10:36:47.492734096Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.492822984Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.492829235Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.494830965Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.494848648Z TRACE quiche_server] got packet Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false [2025-04-30T10:36:47.494859298Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=23 pn=6 [2025-04-30T10:36:47.494869287Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=8 blocks=[2..5] ecn_counts=None [2025-04-30T10:36:47.494876210Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 4 [2025-04-30T10:36:47.494889365Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 5 [2025-04-30T10:36:47.494905465Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 44 bytes [2025-04-30T10:36:47.494912067Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.494916436Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.494919682Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.497013066Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.497026451Z TRACE quiche_server] got packet Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false [2025-04-30T10:36:47.497034396Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=23 pn=7 [2025-04-30T10:36:47.497042070Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=6 blocks=[2..7] ecn_counts=None [2025-04-30T10:36:47.497047070Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 6 [2025-04-30T10:36:47.497050536Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 7 [2025-04-30T10:36:47.497064944Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 44 bytes [2025-04-30T10:36:47.497070775Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.497074712Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.497077948Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.499186238Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.499197319Z TRACE quiche_server] got packet Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false [2025-04-30T10:36:47.499203711Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=23 pn=8 [2025-04-30T10:36:47.499209452Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=5 blocks=[2..9] ecn_counts=None [2025-04-30T10:36:47.499213148Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 8 [2025-04-30T10:36:47.499215603Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 9 [2025-04-30T10:36:47.499227405Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 44 bytes [2025-04-30T10:36:47.499231714Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.499234819Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.499237093Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.499601993Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.499613554Z TRACE quiche_server] got packet Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false [2025-04-30T10:36:47.499621800Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=23 pn=9 [2025-04-30T10:36:47.499630266Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm ACK delay=5 blocks=[2..10] ecn_counts=None [2025-04-30T10:36:47.499634204Z TRACE quiche::recovery::congestion::recovery] 744086f7ddc955b3c3e7fffdf39e5e1100970476 packet newly acked 10 [2025-04-30T10:36:47.499645966Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 44 bytes [2025-04-30T10:36:47.499651526Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:34438 to [::]:443 [2025-04-30T10:36:47.499654422Z TRACE quiche_server] got packet Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false [2025-04-30T10:36:47.499658189Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx pkt Short dcid=744086f7ddc955b3c3e7fffdf39e5e1100970476 key_phase=false len=21 pn=10 [2025-04-30T10:36:47.499669500Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[] [2025-04-30T10:36:47.499676132Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 processed 42 bytes [2025-04-30T10:36:47.499679649Z TRACE quiche_server] recv() would block [2025-04-30T10:36:47.499681933Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.499684158Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.677891085Z TRACE quiche_server] timed out [2025-04-30T10:36:47.677929237Z TRACE quiche] 744086f7ddc955b3c3e7fffdf39e5e1100970476 draining timeout expired [2025-04-30T10:36:47.677978209Z TRACE quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 done writing [2025-04-30T10:36:47.677983639Z TRACE quiche_server] Collecting garbage [2025-04-30T10:36:47.677988859Z INFO quiche_server] 744086f7ddc955b3c3e7fffdf39e5e1100970476 connection collected recv=10 sent=11 lost=0 retrans=0 sent_bytes=12155 recv_bytes=2662 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:34438 validation_state=Validated active=true recv=10 sent=11 lost=0 retrans=0 rtt=35.947499ms min_rtt=Some(33.181738ms) rttvar=5.818089ms cwnd=13500 sent_bytes=12155 recv_bytes=2662 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=337926]