[2025-04-30T09:45:56.294713973Z INFO quiche_server] listening on [::]:443 [2025-04-30T09:45:56.294735263Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T09:45:56.294742226Z TRACE quiche_server] GSO detected: false [2025-04-30T09:45:57.108186000Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:49421 to [::]:443 [2025-04-30T09:45:57.108218290Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:45:57.108226265Z WARN quiche_server] Doing version negotiation [2025-04-30T09:45:57.108316974Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:49421 to [::]:443 [2025-04-30T09:45:57.108327293Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:45:57.108333555Z WARN quiche_server] Doing version negotiation [2025-04-30T09:45:57.108366106Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:49421 to [::]:443 [2025-04-30T09:45:57.108372908Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:45:57.108377396Z WARN quiche_server] Doing version negotiation [2025-04-30T09:45:57.108408885Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.319667789Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:60874 to [::]:443 [2025-04-30T09:45:57.319690371Z TRACE quiche_server] got packet Initial version=1 dcid=14e203fa9ff3dca2 scid=c87a80be87472151 token= [2025-04-30T09:45:57.319699598Z DEBUG quiche_server] New connection: dcid=14e203fa9ff3dca2 scid=09977c3f05cf366697c4f99ee40b07f06198b726 [2025-04-30T09:45:57.319888781Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx pkt Initial version=1 dcid=14e203fa9ff3dca2 scid=c87a80be87472151 token= len=1226 pn=92863 [2025-04-30T09:45:57.319902296Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm PING mtu_probe=None [2025-04-30T09:45:57.319906734Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm CRYPTO off=0 len=285 [2025-04-30T09:45:57.319933845Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T09:45:57.319938243Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T09:45:57.320050943Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 write message lvl=Initial len=123 [2025-04-30T09:45:57.320109272Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 set write secret lvl=Handshake [2025-04-30T09:45:57.320179553Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 write message lvl=Handshake len=697 [2025-04-30T09:45:57.320183190Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 set write secret lvl=OneRTT [2025-04-30T09:45:57.320191064Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 set read secret lvl=Handshake [2025-04-30T09:45:57.320212725Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm PADDING len=916 [2025-04-30T09:45:57.320234756Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 processed 1252 bytes [2025-04-30T09:45:57.320255565Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.320268940Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx pkt Initial version=1 dcid=c87a80be87472151 scid=09977c3f05cf366697c4f99ee40b07f06198b726 len=135 pn=0 [2025-04-30T09:45:57.320273027Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm ACK delay=49 blocks=[92863..92863] ecn_counts=None [2025-04-30T09:45:57.320278007Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm CRYPTO off=0 len=123 [2025-04-30T09:45:57.320288787Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 timer=998.968701ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=190 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 187, tv_nsec: 107196939 }, first_sent_time: Instant { tv_sec: 187, tv_nsec: 107196939 }, 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: 187, tv_nsec: 107196939 }, next_time: Instant { tv_sec: 187, tv_nsec: 107196939 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:45:57.320320446Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx pkt Handshake version=1 dcid=c87a80be87472151 scid=09977c3f05cf366697c4f99ee40b07f06198b726 len=701 pn=1 [2025-04-30T09:45:57.320324153Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm CRYPTO off=0 len=697 [2025-04-30T09:45:57.320330915Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 timer=998.927094ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=945 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 187, tv_nsec: 107196939 }, first_sent_time: Instant { tv_sec: 187, tv_nsec: 107196939 }, 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: 187, tv_nsec: 107196939 }, next_time: Instant { tv_sec: 187, tv_nsec: 107196939 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:45:57.320383373Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:60874, at: Instant { tv_sec: 187, tv_nsec: 107196939 } }) [2025-04-30T09:45:57.320394564Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.320402689Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.320409602Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 done writing [2025-04-30T09:45:57.320413900Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.352468254Z TRACE quiche_server] got 412 bytes from [::ffff:193.167.0.100]:60874 to [::]:443 [2025-04-30T09:45:57.352482701Z TRACE quiche_server] got packet Handshake version=1 dcid=09977c3f05cf366697c4f99ee40b07f06198b726 scid=c87a80be87472151 [2025-04-30T09:45:57.352492419Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx pkt Handshake version=1 dcid=09977c3f05cf366697c4f99ee40b07f06198b726 scid=c87a80be87472151 len=64 pn=0 [2025-04-30T09:45:57.352500975Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm ACK delay=35 blocks=[1..1] ecn_counts=None [2025-04-30T09:45:57.352506896Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 packet newly acked 1 [2025-04-30T09:45:57.352512246Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm CRYPTO off=0 len=36 [2025-04-30T09:45:57.352525060Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 set read secret lvl=OneRTT [2025-04-30T09:45:57.352559224Z TRACE quiche::tls] 09977c3f05cf366697c4f99ee40b07f06198b726 write message lvl=OneRTT len=396 [2025-04-30T09:45:57.352567389Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 dropped epoch 1 state [2025-04-30T09:45:57.352571476Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("P-256") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 180000, stateless_reset_token: None, max_udp_payload_size: 1440, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 2097152, initial_max_stream_data_bidi_remote: 65635, initial_max_stream_data_uni: 65535, initial_max_streams_bidi: 512, initial_max_streams_uni: 512, ack_delay_exponent: 3, max_ack_delay: 10, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(c87a80be87472151), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T09:45:57.352605941Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 dropped epoch 0 state [2025-04-30T09:45:57.352610409Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx pkt Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false len=290 pn=0 [2025-04-30T09:45:57.352617853Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[9a, 00, bc, 73, 1b, bb, 70, 98] reset_token=[1a, 1a, cc, 53, 7f, ff, 05, cb, c6, a4, 9c, 90, 4a, df, d2, aa] [2025-04-30T09:45:57.352625908Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[6a, 3c, 06, ba, 83, 35, 2e, 9f] reset_token=[12, 68, 7c, cd, 2f, 77, 20, 8e, 45, f7, f7, e5, 15, fd, 16, 33] [2025-04-30T09:45:57.352631769Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[0b, da, a6, 76, 89, 20, 65, 51] reset_token=[6c, 10, 0c, 63, 3a, 61, ff, e0, 59, 59, 3f, ed, d1, 93, 33, 1f] [2025-04-30T09:45:57.352637259Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[30, 2f, 8e, b2, 42, 0c, f6, d2] reset_token=[1b, 2c, ad, 6b, 12, 67, 75, 37, 3e, 8a, 20, ad, 6e, 0f, aa, 57] [2025-04-30T09:45:57.352643321Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[8e, c8, 84, 36, 33, 59, a1, ea] reset_token=[fe, a8, 34, 6e, b3, d9, 32, c6, d2, de, 9f, d3, c8, d4, 97, 96] [2025-04-30T09:45:57.352649001Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[a5, 36, e1, e9, 68, 95, 65, b6] reset_token=[4b, 16, 41, 6f, 22, a6, 51, 5e, 54, 8c, 13, 83, 66, f0, 8a, 67] [2025-04-30T09:45:57.352654461Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[2a, 3b, 10, 14, 93, 95, f4, 45] reset_token=[cb, 6a, 9e, a2, f5, bf, 64, 86, 3c, b7, ea, 68, a8, 7f, 60, eb] [2025-04-30T09:45:57.352659340Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm PADDING len=77 [2025-04-30T09:45:57.352669399Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 processed 412 bytes [2025-04-30T09:45:57.352678215Z TRACE quiche_server] got 183 bytes from [::ffff:193.167.0.100]:60874 to [::]:443 [2025-04-30T09:45:57.352682153Z TRACE quiche_server] got packet Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false [2025-04-30T09:45:57.352687372Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx pkt Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false len=162 pn=1 [2025-04-30T09:45:57.352692502Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm STREAM id=0 off=0 len=17 fin=true [2025-04-30T09:45:57.352698353Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm PADDING len=125 [2025-04-30T09:45:57.352703823Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 processed 183 bytes [2025-04-30T09:45:57.352707440Z DEBUG quiche_apps::common] 09977c3f05cf366697c4f99ee40b07f06198b726 response stream 0 is writable with capacity Ok(13500) [2025-04-30T09:45:57.352714343Z TRACE quiche_apps::common] 09977c3f05cf366697c4f99ee40b07f06198b726 received 17 bytes [2025-04-30T09:45:57.352721987Z TRACE quiche_apps::common] 09977c3f05cf366697c4f99ee40b07f06198b726 stream 0 has 17 bytes (fin? true) [2025-04-30T09:45:57.352726696Z INFO quiche_apps::common] 09977c3f05cf366697c4f99ee40b07f06198b726 got GET request for "/www/zqntefsjmv" on stream 0 [2025-04-30T09:45:57.352749348Z INFO quiche_apps::common] 09977c3f05cf366697c4f99ee40b07f06198b726 sending response of size 1024 on stream 0 [2025-04-30T09:45:57.352757623Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.352765128Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319 [2025-04-30T09:45:57.352774254Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx pkt Short dcid=c87a80be87472151 key_phase=false len=1324 pn=2 [2025-04-30T09:45:57.352777761Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm ACK delay=9 blocks=[0..1] ecn_counts=None [2025-04-30T09:45:57.352781558Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[bf, 72, 35, 81, dd, f1, 84, 80, 8e, 23, bb, 6f, 84, e1, bd, 8b, d7, 35, 37, 3f] reset_token=[03, f0, d0, ba, aa, 9e, ac, 82, 56, e5, a0, a7, fb, e3, df, 79] [2025-04-30T09:45:57.352788551Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[a5, 24, 7c, 08, 9a, 22, 65, 4b, 1d, 72, cf, a5, c2, ea, 9d, cf, 6e, 6d, 23, 86] reset_token=[60, 6c, dc, f6, 61, 10, 68, 17, 9a, e5, ae, fc, 26, 4e, 3b, 72] [2025-04-30T09:45:57.352795144Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[fa, b6, fb, 4f, 93, 07, 54, 8e, 26, ca, 89, 3a, 46, 31, 21, 1a, b8, a4, 13, 13] reset_token=[73, 37, 0e, 9c, 58, 99, 5b, b3, 61, a2, 32, 53, a6, ab, 91, 8d] [2025-04-30T09:45:57.352801415Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[fc, ae, e4, 77, c0, 62, 59, 0a, 81, 31, cb, 87, 35, 6a, e5, b7, b2, 75, b9, ff] reset_token=[ff, c8, 29, c5, db, 41, 71, c1, 5a, 1a, 59, 24, b8, b6, 59, d4] [2025-04-30T09:45:57.352807847Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[fe, 92, 1e, 80, 2c, 1b, 8a, 8d, 46, 64, a2, 83, 1e, 93, a6, e8, e7, f2, a1, 84] reset_token=[83, 9c, 9d, 9f, 5a, 97, 94, 05, 35, a3, ed, f3, a5, e8, 01, a7] [2025-04-30T09:45:57.352814209Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[8f, af, e9, 55, 6a, 39, 53, e8, 45, 51, 9c, d3, 4d, f5, 97, a2, 6d, 6a, 52, 2d] reset_token=[c9, cc, 30, 02, f4, b0, 6f, 23, e4, af, 56, 51, fc, aa, 03, 90] [2025-04-30T09:45:57.352820441Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[5c, c0, 38, 69, 9b, 86, db, e6, 37, 8e, ed, e5, 88, c8, aa, 59, 81, 31, 40, 41] reset_token=[a8, 79, 4d, a2, cd, 1c, 31, bc, 81, 7f, bb, 67, 85, bb, 1d, d5] [2025-04-30T09:45:57.352826612Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm HANDSHAKE_DONE [2025-04-30T09:45:57.352829468Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm CRYPTO off=0 len=396 [2025-04-30T09:45:57.352832403Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm STREAM id=0 off=0 len=633 fin=false [2025-04-30T09:45:57.352846589Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 timer=106.608221ms latest_rtt=32.231625ms srtt=32.231625ms min_rtt=32.231625ms rttvar=16.115812ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 755, delivered_time: Instant { tv_sec: 187, tv_nsec: 139699068 }, first_sent_time: Instant { tv_sec: 187, tv_nsec: 139699068 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 23424, is_app_limited: true, interval: 32.231625ms, delivered: 755, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 187, tv_nsec: 107196939 }), send_elapsed: 0ns, ack_elapsed: 32.231625ms, rtt: 32.231625ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 523554, last_update: Instant { tv_sec: 187, tv_nsec: 139699068 }, next_time: Instant { tv_sec: 187, tv_nsec: 139699068 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:45:57.352869542Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324 [2025-04-30T09:45:57.352873850Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx pkt Short dcid=c87a80be87472151 key_phase=false len=397 pn=3 [2025-04-30T09:45:57.352877016Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 tx frm STREAM id=0 off=633 len=391 fin=true [2025-04-30T09:45:57.352882997Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 timer=106.679014ms latest_rtt=32.231625ms srtt=32.231625ms min_rtt=32.231625ms rttvar=16.115812ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1773 app_limited=true congestion_recovery_start_time=None Rate { delivered: 755, delivered_time: Instant { tv_sec: 187, tv_nsec: 139699068 }, first_sent_time: Instant { tv_sec: 187, tv_nsec: 139699068 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 23424, is_app_limited: true, interval: 32.231625ms, delivered: 755, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 187, tv_nsec: 107196939 }), send_elapsed: 0ns, ack_elapsed: 32.231625ms, rtt: 32.231625ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 523554, last_update: Instant { tv_sec: 187, tv_nsec: 139699068 }, next_time: Instant { tv_sec: 187, tv_nsec: 139699068 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:45:57.352947558Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 written 1773 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:60874, at: Instant { tv_sec: 187, tv_nsec: 139699068 } }) [2025-04-30T09:45:57.352954340Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.352959840Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.352963277Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 done writing [2025-04-30T09:45:57.352966102Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.384509196Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:60874 to [::]:443 [2025-04-30T09:45:57.384522400Z TRACE quiche_server] got packet Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false [2025-04-30T09:45:57.384530345Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx pkt Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false len=34 pn=2 [2025-04-30T09:45:57.384537859Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm ACK delay=14 blocks=[2..2] ecn_counts=None [2025-04-30T09:45:57.384542468Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 packet newly acked 2 [2025-04-30T09:45:57.384548479Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm PADDING len=12 [2025-04-30T09:45:57.384585598Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 processed 55 bytes [2025-04-30T09:45:57.384591599Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.384595386Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 done writing [2025-04-30T09:45:57.384602079Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.384792574Z TRACE quiche_server] got 46 bytes from [::ffff:193.167.0.100]:60874 to [::]:443 [2025-04-30T09:45:57.384797874Z TRACE quiche_server] got packet Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false [2025-04-30T09:45:57.384803795Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx pkt Short dcid=09977c3f05cf366697c4f99ee40b07f06198b726 key_phase=false len=25 pn=3 [2025-04-30T09:45:57.384809676Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm ACK delay=7 blocks=[2..3] ecn_counts=None [2025-04-30T09:45:57.384813623Z TRACE quiche::recovery::congestion::recovery] 09977c3f05cf366697c4f99ee40b07f06198b726 packet newly acked 3 [2025-04-30T09:45:57.384817911Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 rx frm APPLICATION_CLOSE err=0 reason=[] [2025-04-30T09:45:57.384829673Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 processed 46 bytes [2025-04-30T09:45:57.384834342Z TRACE quiche_server] recv() would block [2025-04-30T09:45:57.384837117Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 done writing [2025-04-30T09:45:57.384840263Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.592100651Z TRACE quiche_server] timed out [2025-04-30T09:45:57.592139764Z TRACE quiche] 09977c3f05cf366697c4f99ee40b07f06198b726 draining timeout expired [2025-04-30T09:45:57.592181352Z TRACE quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 done writing [2025-04-30T09:45:57.592185470Z TRACE quiche_server] Collecting garbage [2025-04-30T09:45:57.592189277Z INFO quiche_server] 09977c3f05cf366697c4f99ee40b07f06198b726 connection collected recv=6 sent=4 lost=0 retrans=0 sent_bytes=2718 recv_bytes=1948 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:60874 validation_state=Validated active=true recv=6 sent=4 lost=0 retrans=0 rtt=32.150322ms min_rtt=Some(31.768544ms) rttvar=9.198802ms cwnd=13500 sent_bytes=2718 recv_bytes=1948 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=55809]