[2025-04-30T09:48:01.030331059Z INFO quiche_server] listening on [::]:443 [2025-04-30T09:48:01.030353631Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T09:48:01.030360664Z TRACE quiche_server] GSO detected: false [2025-04-30T09:48:01.844261301Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:49157 to [::]:443 [2025-04-30T09:48:01.844291888Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:48:01.844301706Z WARN quiche_server] Doing version negotiation [2025-04-30T09:48:01.844401392Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:49157 to [::]:443 [2025-04-30T09:48:01.844407944Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:48:01.844411902Z WARN quiche_server] Doing version negotiation [2025-04-30T09:48:01.844434734Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:49157 to [::]:443 [2025-04-30T09:48:01.844441807Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:48:01.844447287Z WARN quiche_server] Doing version negotiation [2025-04-30T09:48:01.844481441Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.128869848Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:55801 to [::]:443 [2025-04-30T09:48:02.128895476Z TRACE quiche_server] got packet Initial version=1 dcid=9ae6fa6b65d80ae7 scid=afd68162acfad4ee token= [2025-04-30T09:48:02.128905755Z DEBUG quiche_server] New connection: dcid=9ae6fa6b65d80ae7 scid=1901cc51f173d7a28b4e86c8035ca6efaf08027f [2025-04-30T09:48:02.129135363Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx pkt Initial version=1 dcid=9ae6fa6b65d80ae7 scid=afd68162acfad4ee token= len=1226 pn=104282 [2025-04-30T09:48:02.129149499Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm PING mtu_probe=None [2025-04-30T09:48:02.129153817Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm CRYPTO off=0 len=285 [2025-04-30T09:48:02.129180567Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T09:48:02.129184865Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T09:48:02.129298667Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f write message lvl=Initial len=123 [2025-04-30T09:48:02.129329755Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f set write secret lvl=Handshake [2025-04-30T09:48:02.129414854Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f write message lvl=Handshake len=698 [2025-04-30T09:48:02.129420945Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f set write secret lvl=OneRTT [2025-04-30T09:48:02.129432547Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f set read secret lvl=Handshake [2025-04-30T09:48:02.129462843Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm PADDING len=916 [2025-04-30T09:48:02.129490014Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f processed 1252 bytes [2025-04-30T09:48:02.129517054Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.129534817Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx pkt Initial version=1 dcid=afd68162acfad4ee scid=1901cc51f173d7a28b4e86c8035ca6efaf08027f len=135 pn=0 [2025-04-30T09:48:02.129540207Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm ACK delay=52 blocks=[104282..104282] ecn_counts=None [2025-04-30T09:48:02.129547902Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm CRYPTO off=0 len=123 [2025-04-30T09:48:02.129560736Z TRACE quiche::recovery::congestion::recovery] 1901cc51f173d7a28b4e86c8035ca6efaf08027f timer=998.958973ms 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: 311, tv_nsec: 916459280 }, first_sent_time: Instant { tv_sec: 311, tv_nsec: 916459280 }, 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: 311, tv_nsec: 916459280 }, next_time: Instant { tv_sec: 311, tv_nsec: 916459280 }, 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:48:02.129593747Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx pkt Handshake version=1 dcid=afd68162acfad4ee scid=1901cc51f173d7a28b4e86c8035ca6efaf08027f len=702 pn=1 [2025-04-30T09:48:02.129597294Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm CRYPTO off=0 len=698 [2025-04-30T09:48:02.129605068Z TRACE quiche::recovery::congestion::recovery] 1901cc51f173d7a28b4e86c8035ca6efaf08027f timer=998.915332ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=946 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 311, tv_nsec: 916459280 }, first_sent_time: Instant { tv_sec: 311, tv_nsec: 916459280 }, 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: 311, tv_nsec: 916459280 }, next_time: Instant { tv_sec: 311, tv_nsec: 916459280 }, 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:48:02.129656544Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:55801, at: Instant { tv_sec: 311, tv_nsec: 916459280 } }) [2025-04-30T09:48:02.129666012Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.129673235Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.129678886Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f done writing [2025-04-30T09:48:02.129683064Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.161872080Z TRACE quiche_server] got 412 bytes from [::ffff:193.167.0.100]:55801 to [::]:443 [2025-04-30T09:48:02.161889212Z TRACE quiche_server] got packet Handshake version=1 dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f scid=afd68162acfad4ee [2025-04-30T09:48:02.161902106Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx pkt Handshake version=1 dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f scid=afd68162acfad4ee len=64 pn=0 [2025-04-30T09:48:02.161912676Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm ACK delay=45 blocks=[1..1] ecn_counts=None [2025-04-30T09:48:02.161919769Z TRACE quiche::recovery::congestion::recovery] 1901cc51f173d7a28b4e86c8035ca6efaf08027f packet newly acked 1 [2025-04-30T09:48:02.161926592Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm CRYPTO off=0 len=36 [2025-04-30T09:48:02.161942101Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f set read secret lvl=OneRTT [2025-04-30T09:48:02.161978739Z TRACE quiche::tls] 1901cc51f173d7a28b4e86c8035ca6efaf08027f write message lvl=OneRTT len=444 [2025-04-30T09:48:02.161987876Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f dropped epoch 1 state [2025-04-30T09:48:02.161992124Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f 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(afd68162acfad4ee), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T09:48:02.162030876Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f dropped epoch 0 state [2025-04-30T09:48:02.162035154Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx pkt Short dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f key_phase=false len=290 pn=0 [2025-04-30T09:48:02.162042858Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[88, 50, 18, 08, 80, e4, ec, 3f] reset_token=[c4, 4b, b2, d0, eb, 21, e1, 72, 9b, 01, 21, d5, 28, 9e, b7, 84] [2025-04-30T09:48:02.162056203Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[6f, 67, 94, 27, e4, ab, 78, 46] reset_token=[0a, 35, 36, 54, 75, 69, d0, f6, 57, c7, f3, 47, 67, 23, 7e, 27] [2025-04-30T09:48:02.162083033Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[0b, 1e, cf, 02, 87, 8a, 9d, 01] reset_token=[fe, 91, cc, ec, 36, ce, ff, 40, b0, 01, ce, 70, bb, 59, ea, 18] [2025-04-30T09:48:02.162092230Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[19, a9, ad, 53, 24, ed, b4, c4] reset_token=[b0, 2f, aa, 21, cd, 31, 35, 60, 2f, 1d, b2, 49, 09, da, 17, d0] [2025-04-30T09:48:02.162098702Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[02, 4a, b8, 4f, 8b, 8e, f3, 61] reset_token=[c9, 94, 06, 1c, b2, 55, e5, e3, 56, 08, c6, 50, 77, e1, 82, e2] [2025-04-30T09:48:02.162104684Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[3b, 0e, a5, e6, c0, 64, c1, 5a] reset_token=[73, 82, f9, e4, c7, f3, d7, 70, 4f, 80, b2, 26, 2e, f9, 45, 72] [2025-04-30T09:48:02.162110364Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[86, ed, e1, a8, 43, 98, b7, 91] reset_token=[f1, f1, d3, 32, 82, 44, 9f, da, 76, 0f, 94, 72, 6b, 83, f1, c5] [2025-04-30T09:48:02.162115253Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm PADDING len=77 [2025-04-30T09:48:02.162125983Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f processed 412 bytes [2025-04-30T09:48:02.162135441Z TRACE quiche_server] got 311 bytes from [::ffff:193.167.0.100]:55801 to [::]:443 [2025-04-30T09:48:02.162139449Z TRACE quiche_server] got packet Short dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f key_phase=false [2025-04-30T09:48:02.162144899Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx pkt Short dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f key_phase=false len=290 pn=1 [2025-04-30T09:48:02.162150449Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm STREAM id=0 off=0 len=257 fin=true [2025-04-30T09:48:02.162156049Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm PADDING len=12 [2025-04-30T09:48:02.162161600Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f processed 311 bytes [2025-04-30T09:48:02.162164956Z DEBUG quiche_apps::common] 1901cc51f173d7a28b4e86c8035ca6efaf08027f response stream 0 is writable with capacity Ok(13500) [2025-04-30T09:48:02.162171718Z TRACE quiche_apps::common] 1901cc51f173d7a28b4e86c8035ca6efaf08027f received 257 bytes [2025-04-30T09:48:02.162180164Z TRACE quiche_apps::common] 1901cc51f173d7a28b4e86c8035ca6efaf08027f stream 0 has 257 bytes (fin? true) [2025-04-30T09:48:02.162185895Z INFO quiche_apps::common] 1901cc51f173d7a28b4e86c8035ca6efaf08027f got GET request for "/www/htzdvxlhqynwhxxfknepcxvphvcqpttrvhxxsivfjheiykykiyenszhycqchwvqaeetdojkmjmhmqjcscwgqvtpedovggrxyfyscupcosmwktfaiubylziffshrzzvkwbhlefsirzzdkritfrjanmibpvuunaglhreasiusjasbcslfdgnniyrgkoillxrlacrulczmfqsggweyythxxbihlfdtziiclzucnhyhtlxuqxrvqdapcvlhbzk" on stream 0 [2025-04-30T09:48:02.162218987Z INFO quiche_apps::common] 1901cc51f173d7a28b4e86c8035ca6efaf08027f sending response of size 32 on stream 0 [2025-04-30T09:48:02.162226871Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.162235257Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319 [2025-04-30T09:48:02.162245286Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx pkt Short dcid=afd68162acfad4ee key_phase=false len=771 pn=2 [2025-04-30T09:48:02.162248712Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm ACK delay=11 blocks=[0..1] ecn_counts=None [2025-04-30T09:48:02.162252700Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[b9, b5, 46, 16, 46, 57, a8, 38, b5, 1d, ee, 0a, 25, 16, 7b, ac, 5e, 06, 85, 8c] reset_token=[17, db, 39, 43, c0, 4d, b1, a3, 7d, 01, e7, cc, 73, 5a, 3d, 2c] [2025-04-30T09:48:02.162259963Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[21, 47, 90, c3, 75, 6a, 64, 77, a4, 24, e6, 85, 21, af, b8, 5a, 0d, 92, cd, 20] reset_token=[f6, 0f, c6, 0b, 2b, 39, fb, 04, b5, e1, 69, 4a, bc, 6c, d8, 9a] [2025-04-30T09:48:02.162266575Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[50, 5b, 9d, fd, d8, 7e, 49, 14, 32, cb, e1, e5, b3, 7c, 31, 63, 2f, a0, c5, 9a] reset_token=[dd, ad, 80, 8e, 5d, 41, 39, a8, f0, 31, 62, 0e, 45, 6e, 4f, 75] [2025-04-30T09:48:02.162273087Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[eb, 7e, b4, ec, 41, 85, 6d, cb, 88, 5f, de, 89, ba, d4, b0, e2, 4a, 14, cf, 99] reset_token=[70, ae, 48, 78, e2, f1, c9, 32, 05, 36, c2, ea, 62, 74, 2c, a4] [2025-04-30T09:48:02.162279510Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[d2, 7d, 7e, d8, 14, eb, ef, e7, 3e, 04, 7a, 34, bc, 90, f0, 58, f1, 78, 91, 95] reset_token=[6a, 51, 55, dc, 3b, c5, 8d, 8b, 18, 22, 1a, b4, 2f, 11, 2d, 86] [2025-04-30T09:48:02.162285711Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[f7, e0, 15, 39, 1c, c9, 50, fd, 6e, 86, 4d, 6c, 1b, 2c, 62, 6c, c4, c8, a3, 57] reset_token=[b9, c1, 22, 8b, 4f, 94, 45, 6c, 32, 7f, 24, c5, 12, 70, b2, 75] [2025-04-30T09:48:02.162291873Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[18, bd, ab, 83, ef, 7d, 16, 73, 6d, 94, 86, 9d, 04, ed, ff, 9b, a1, 34, df, ba] reset_token=[ac, cb, 06, 70, 4d, 00, 39, 51, b8, 84, e6, 1d, a7, 3c, f5, 7e] [2025-04-30T09:48:02.162298194Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm HANDSHAKE_DONE [2025-04-30T09:48:02.162300990Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm CRYPTO off=0 len=444 [2025-04-30T09:48:02.162303905Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f tx frm STREAM id=0 off=0 len=32 fin=true [2025-04-30T09:48:02.162318753Z TRACE quiche::recovery::congestion::recovery] 1901cc51f173d7a28b4e86c8035ca6efaf08027f timer=107.043097ms latest_rtt=32.377528ms srtt=32.377528ms min_rtt=32.377528ms rttvar=16.188764ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=797 app_limited=true congestion_recovery_start_time=None Rate { delivered: 756, delivered_time: Instant { tv_sec: 311, tv_nsec: 949168376 }, first_sent_time: Instant { tv_sec: 311, tv_nsec: 949168376 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 23349, is_app_limited: true, interval: 32.377528ms, delivered: 756, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 311, tv_nsec: 916459280 }), send_elapsed: 0ns, ack_elapsed: 32.377528ms, rtt: 32.377528ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521194, last_update: Instant { tv_sec: 311, tv_nsec: 949168376 }, next_time: Instant { tv_sec: 311, tv_nsec: 949168376 }, 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:48:02.162381369Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f written 797 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:55801, at: Instant { tv_sec: 311, tv_nsec: 949168376 } }) [2025-04-30T09:48:02.162392119Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.162400124Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.162406035Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f done writing [2025-04-30T09:48:02.162410373Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.193794388Z TRACE quiche_server] got 46 bytes from [::ffff:193.167.0.100]:55801 to [::]:443 [2025-04-30T09:48:02.193810648Z TRACE quiche_server] got packet Short dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f key_phase=false [2025-04-30T09:48:02.193822590Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx pkt Short dcid=1901cc51f173d7a28b4e86c8035ca6efaf08027f key_phase=false len=25 pn=2 [2025-04-30T09:48:02.193835374Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm ACK delay=31 blocks=[2..2] ecn_counts=None [2025-04-30T09:48:02.193841916Z TRACE quiche::recovery::congestion::recovery] 1901cc51f173d7a28b4e86c8035ca6efaf08027f packet newly acked 2 [2025-04-30T09:48:02.193848929Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f rx frm APPLICATION_CLOSE err=0 reason=[] [2025-04-30T09:48:02.193900866Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f processed 46 bytes [2025-04-30T09:48:02.193907819Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.193910815Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f done writing [2025-04-30T09:48:02.193913890Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.439214050Z TRACE quiche_server] timed out [2025-04-30T09:48:02.439245168Z TRACE quiche] 1901cc51f173d7a28b4e86c8035ca6efaf08027f draining timeout expired [2025-04-30T09:48:02.439290954Z TRACE quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f done writing [2025-04-30T09:48:02.439294681Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.439298648Z INFO quiche_server] 1901cc51f173d7a28b4e86c8035ca6efaf08027f connection collected recv=5 sent=3 lost=0 retrans=0 sent_bytes=1743 recv_bytes=2021 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:55801 validation_state=Validated active=true recv=5 sent=3 lost=0 retrans=0 rtt=32.279106ms min_rtt=Some(31.590159ms) rttvar=12.338415ms cwnd=13500 sent_bytes=1743 recv_bytes=2021 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=25229] [2025-04-30T09:48:02.534666460Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.534689202Z TRACE quiche_server] got packet Initial version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 token= [2025-04-30T09:48:02.534697407Z DEBUG quiche_server] New connection: dcid=8cd77eca39a8d943 scid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea [2025-04-30T09:48:02.534835365Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Initial version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 token= len=553 pn=108042 [2025-04-30T09:48:02.534854580Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PING mtu_probe=None [2025-04-30T09:48:02.534859179Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm CRYPTO off=0 len=528 [2025-04-30T09:48:02.534886420Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T09:48:02.534890577Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T09:48:02.535031560Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea write message lvl=Initial len=129 [2025-04-30T09:48:02.535045416Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea set write secret lvl=Handshake [2025-04-30T09:48:02.535111309Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea write message lvl=Handshake len=152 [2025-04-30T09:48:02.535115286Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea set write secret lvl=OneRTT [2025-04-30T09:48:02.535144421Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea write message lvl=OneRTT len=444 [2025-04-30T09:48:02.535148278Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea set read secret lvl=ZeroRTT [2025-04-30T09:48:02.535155451Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea set read secret lvl=Handshake [2025-04-30T09:48:02.535183143Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=648 pn=0 [2025-04-30T09:48:02.535189835Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=0 off=0 len=257 fin=true [2025-04-30T09:48:02.535195586Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=4 off=0 len=257 fin=true [2025-04-30T09:48:02.535199804Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=8 off=0 len=104 fin=false [2025-04-30T09:48:02.535208209Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1252 bytes [2025-04-30T09:48:02.535212608Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 0 is writable with capacity Ok(13500) [2025-04-30T09:48:02.535216364Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 4 is writable with capacity Ok(13500) [2025-04-30T09:48:02.535219210Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 8 is writable with capacity Ok(13500) [2025-04-30T09:48:02.535225512Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.535228687Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 0 has 257 bytes (fin? true) [2025-04-30T09:48:02.535233787Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/xjcwkygjslbnrwprtdtzlqtwxyuyjzvufdbgsyvisajedkgvjaxrrfmxjdwcikpdcybmqmvbrezncufdblgnklaawwwsqrplhrbesbnuvcktdmwncxxsrwertjvibuglxtwefjetsymqajqivvlxcocftqxlawbgbpmiwpssldinskvvfhitnyxliiejtgeftlxxelrlnhkimmwojiefbcbrnkbiiqvsjadtmmvxmhvbzzecmoxexrqewa" on stream 0 [2025-04-30T09:48:02.535261048Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 0 [2025-04-30T09:48:02.535268372Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.535271267Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 4 has 257 bytes (fin? true) [2025-04-30T09:48:02.535275104Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/mrecocrhcpdagdigkrxojseoewmiykqgjiofviknyuuylflcpzzyokginyrbabxzlukgvbsofrxufbiwjxronbaiqzuuxprsblbdtkrlfxokkwuboninvtvyoptciupujxsayymqxaftkqvmsxbixbjeadhftddqauhtgfkqjsxqfpobqvqinuwzfodvecpjatdmegrbvdqrnpvgyxhakgjdhhcpyimxwognuegxxzlmlqchwgszzitstn" on stream 4 [2025-04-30T09:48:02.535292356Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 4 [2025-04-30T09:48:02.535297847Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 104 bytes [2025-04-30T09:48:02.535306613Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 8 has 104 bytes (fin? false) [2025-04-30T09:48:02.535327161Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.535342109Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Initial version=1 dcid=2fbc14ad5007ed81 scid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea len=142 pn=0 [2025-04-30T09:48:02.535346016Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=65 blocks=[108042..108042] ecn_counts=None [2025-04-30T09:48:02.535350545Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm CRYPTO off=0 len=129 [2025-04-30T09:48:02.535359752Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.969583ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=197 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, 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: 312, tv_nsec: 322268546 }, next_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, 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:48:02.535378567Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Handshake version=1 dcid=2fbc14ad5007ed81 scid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea len=156 pn=1 [2025-04-30T09:48:02.535381292Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm CRYPTO off=0 len=152 [2025-04-30T09:48:02.535386341Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.943405ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=407 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, 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: 312, tv_nsec: 322268546 }, next_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, 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:48:02.535396861Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13093 out_len=793 left=762 [2025-04-30T09:48:02.535404916Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=767 pn=2 [2025-04-30T09:48:02.535407701Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=26 blocks=[0..0] ecn_counts=None [2025-04-30T09:48:02.535410546Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[b8, a3, 8d, 84, 49, 0a, 62, ee, e1, be, 18, 0e, d0, b4, c4, 08, 86, 69, 36, ba] reset_token=[b5, e2, 87, 3c, 17, 9d, d2, 97, 56, 7c, d4, 74, fe, 4f, 6d, e4] [2025-04-30T09:48:02.535420946Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[f8, 9a, 50, e5, 6e, da, 11, 54, aa, 99, ae, 90, 69, 08, 11, 5d, e0, c8, 3d, 0d] reset_token=[0d, 6f, 7c, be, 7d, 79, 16, 9d, 9b, 33, f7, 2c, 0c, 9e, d7, 76] [2025-04-30T09:48:02.535426376Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[0e, cc, ec, 3c, e1, 10, 9a, 0f, cd, b1, 6c, af, 59, 89, 81, 98, e9, 43, 5c, 32] reset_token=[e9, 8d, c5, f4, 61, b5, 46, 0d, c1, 94, ce, 2e, 84, f6, 91, 59] [2025-04-30T09:48:02.535431676Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[3a, d5, 59, 77, 42, 48, df, 03, 38, 4d, e3, b9, 89, a2, e8, 80, 00, be, d6, 6d] reset_token=[20, 44, 0f, 0e, 24, da, a9, 33, d6, 4b, ff, 6a, 5d, bb, 5a, c9] [2025-04-30T09:48:02.535436896Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[a2, aa, 09, ff, 4b, 7d, 15, 2a, 74, 88, 7d, 76, e5, 66, dc, 79, 36, 5a, 78, 2a] reset_token=[11, 37, 6e, c5, dc, ce, 0c, da, bb, e6, 9d, 90, b4, 04, 7a, ec] [2025-04-30T09:48:02.535442145Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[14, ed, 54, e5, e9, 94, 30, 55, 1c, 0b, 52, 4a, 3a, c9, d3, a9, c1, 1d, 7f, 8c] reset_token=[a5, 2b, f2, ab, fa, b3, 7d, 42, 6d, 70, 64, f1, 05, 41, 6b, 60] [2025-04-30T09:48:02.535447385Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[fd, d0, 62, ce, 31, d6, 0d, cb, 41, 05, 58, 21, e8, fd, a1, 00, 81, 5b, 2a, 0d] reset_token=[a9, cd, 28, 22, 6d, 03, 19, a8, 11, 4d, b9, ec, ac, 91, 46, 0b] [2025-04-30T09:48:02.535452986Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm CRYPTO off=0 len=444 [2025-04-30T09:48:02.535455290Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=0 off=0 len=29 fin=false [2025-04-30T09:48:02.535464698Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.865079ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1200 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 1, last_sent_packet: 2, 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: 312, tv_nsec: 322268546 }, next_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, 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:48:02.535475257Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12300 out_len=1200 left=1174 [2025-04-30T09:48:02.535478503Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=3 [2025-04-30T09:48:02.535480888Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=4 off=0 len=32 fin=true [2025-04-30T09:48:02.535485136Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.844641ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1263 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 2, last_sent_packet: 3, 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: 312, tv_nsec: 322411863 }, next_time: Instant { tv_sec: 312, tv_nsec: 322411863 }, 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:48:02.535544256Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 1263 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322268546 } }) [2025-04-30T09:48:02.535550497Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.535555226Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.535560225Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12237 out_len=1200 left=1174 [2025-04-30T09:48:02.535563722Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=8 pn=4 [2025-04-30T09:48:02.535566136Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=0 off=29 len=3 fin=true [2025-04-30T09:48:02.535571757Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.757979ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1297 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 3, last_sent_packet: 4, 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: 312, tv_nsec: 322495739 }, next_time: Instant { tv_sec: 312, tv_nsec: 322495739 }, 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:48:02.535598026Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 34 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322495739 } }) [2025-04-30T09:48:02.535602204Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.535608085Z TRACE quiche_server] got 1248 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.535611461Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.535616991Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1223 pn=1 [2025-04-30T09:48:02.535622291Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=8 off=104 len=153 fin=true [2025-04-30T09:48:02.535625728Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=12 off=0 len=257 fin=true [2025-04-30T09:48:02.535629946Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=16 off=0 len=257 fin=true [2025-04-30T09:48:02.535636928Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=20 off=0 len=257 fin=true [2025-04-30T09:48:02.535640154Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=24 off=0 len=257 fin=true [2025-04-30T09:48:02.535648650Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1248 bytes [2025-04-30T09:48:02.535651446Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 8 is writable with capacity Ok(12203) [2025-04-30T09:48:02.535653990Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 12 is writable with capacity Ok(12203) [2025-04-30T09:48:02.535656284Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 16 is writable with capacity Ok(12203) [2025-04-30T09:48:02.535658699Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 20 is writable with capacity Ok(12203) [2025-04-30T09:48:02.535660943Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 24 is writable with capacity Ok(12203) [2025-04-30T09:48:02.535664961Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 153 bytes [2025-04-30T09:48:02.535667225Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 8 has 153 bytes (fin? true) [2025-04-30T09:48:02.535670932Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/kekjycfcmdulgxtjplbujhqecrbdsefifnkpcflnolpifdbvurpqouwvubwtezughiiikaqdjvcskxnsdjlklqeknsftssidnvjtlsayuduquiqagikcwbppqwimmnyttpubktodsiwawcaetnqfxsqivvbpnedyxutrwnzsgpxktcusbpzvwnqbkoqxdllgkjyiwflzsuezjirjthqypwnrmiwfmjofvuskfukwbtvoamecyxliqtnhvm" on stream 8 [2025-04-30T09:48:02.535690348Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 8 [2025-04-30T09:48:02.535695588Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.535697862Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 12 has 257 bytes (fin? true) [2025-04-30T09:48:02.535700717Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/uzycbjnsfszhqksptjdvonfnhjbcnjumrexepzkiczvmmfaxcgpbrhshmkuhqvpenverhsagbhydwpkcjkffkiecospoylhmkfrdnpkmcqdneuaevtkfzowooghmgytlmchgdzmfpmenctqoqbluwaeigidvevnazcoeysmstnmmzcsgizhlvnhbbifsxernkohalgiadkmdkqgqqrzdtnofeuunbbugritvkaivkucrdpoqrzqbtbspds" on stream 12 [2025-04-30T09:48:02.535714854Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 12 [2025-04-30T09:48:02.535719182Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.535721456Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 16 has 257 bytes (fin? true) [2025-04-30T09:48:02.535724191Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/cnelvioozvtbwdxldwoxmvqxftdelimmcfoahrfthjhxcxgtaszifryfehhxqztqcwljrcoikojvtyevwnyfisiyrtlroykizoclgzowkjtnxmjemeppmwvclffzeqtowpdevrusyvxudpotixxuvufjpzvlvicsgmwchwlhgacekksnhxqoxtgcxpexyuchogfbgobfeyrxsuntymiycmjakmdopraycfnikjmvmeirrcnvofqtjkmopo" on stream 16 [2025-04-30T09:48:02.535737446Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 16 [2025-04-30T09:48:02.535741674Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.535743918Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 20 has 257 bytes (fin? true) [2025-04-30T09:48:02.535746663Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/idwrqvtlwmphphkkpsdnuftkssjlcpywkhbyqrudoinvvosbavmavdrbfkianzymrgwkvykozsclsrkohbkooxtxmjhvvxgisbbegukrbzlgpqkabrhagalfwtymrrvzaoxoceeqvpyjlszobmxllougcaddgezcxccvklnwpirnypzzersmobnvyfghpxmocvyvfutjpnclunhgvrrqwbigwxadwngwiuppynfwabcwczgoppvmwjapew" on stream 20 [2025-04-30T09:48:02.535764005Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 20 [2025-04-30T09:48:02.535768534Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.535770808Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 24 has 257 bytes (fin? true) [2025-04-30T09:48:02.535773623Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/enqpjntzucgulskjygajkblrzrbxynnizcysdkxzygayfmshojgozqnqdznhaeajrwoupwsgturilvtiunhirzvjbxkuvkbakrjewsxvllitzaindujaqyfqputxfkdezimloyayhvrypjeumeukjjszcdshuuleeydfaybnhpzkvnogzhkdjbqcwwykudvksmvxtykjqlwbpdbkdoetdxjjfgkdkwaoueagbjqwwjlrokpfxhwnfxudds" on stream 24 [2025-04-30T09:48:02.535786708Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 24 [2025-04-30T09:48:02.535791557Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.535797468Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12203 out_len=1200 left=1169 [2025-04-30T09:48:02.535801385Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=42 pn=5 [2025-04-30T09:48:02.535803850Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=22 blocks=[0..1] ecn_counts=None [2025-04-30T09:48:02.535806905Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=8 off=0 len=32 fin=true [2025-04-30T09:48:02.535827354Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.502303ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1365 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 4, last_sent_packet: 5, 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: 312, tv_nsec: 322732270 }, next_time: Instant { tv_sec: 312, tv_nsec: 322732270 }, 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:48:02.535861557Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 68 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322732270 } }) [2025-04-30T09:48:02.535866336Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.535870103Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.535874802Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12135 out_len=1200 left=1174 [2025-04-30T09:48:02.535878369Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=6 [2025-04-30T09:48:02.535880803Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=12 off=0 len=32 fin=true [2025-04-30T09:48:02.535887265Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.442501ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1428 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 5, last_sent_packet: 6, 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: 312, tv_nsec: 322810566 }, next_time: Instant { tv_sec: 312, tv_nsec: 322810566 }, 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:48:02.535917942Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322810566 } }) [2025-04-30T09:48:02.535922230Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.535925787Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.535930175Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12072 out_len=1200 left=1174 [2025-04-30T09:48:02.535933511Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=7 [2025-04-30T09:48:02.535935886Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=16 off=0 len=32 fin=true [2025-04-30T09:48:02.535940915Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.388881ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1491 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 6, last_sent_packet: 7, 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: 312, tv_nsec: 322866270 }, next_time: Instant { tv_sec: 312, tv_nsec: 322866270 }, 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:48:02.535965852Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322866270 } }) [2025-04-30T09:48:02.535969889Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.535973315Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.535977293Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12009 out_len=1200 left=1174 [2025-04-30T09:48:02.535982693Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=8 [2025-04-30T09:48:02.535986941Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=20 off=0 len=32 fin=true [2025-04-30T09:48:02.535995637Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.333668ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1554 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 7, last_sent_packet: 8, 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: 312, tv_nsec: 322913789 }, next_time: Instant { tv_sec: 312, tv_nsec: 322913789 }, 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:48:02.536044027Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322913789 } }) [2025-04-30T09:48:02.536049257Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.536053104Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.536058574Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11946 out_len=1200 left=1174 [2025-04-30T09:48:02.536076117Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=9 [2025-04-30T09:48:02.536085214Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=24 off=0 len=32 fin=true [2025-04-30T09:48:02.536095313Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=998.234073ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1617 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 8, last_sent_packet: 9, 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: 312, tv_nsec: 322993667 }, next_time: Instant { tv_sec: 312, tv_nsec: 322993667 }, 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:48:02.536133053Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 322993667 } }) [2025-04-30T09:48:02.536137702Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.536141529Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.536145306Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.536147600Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.536633766Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.536637714Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.536643044Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1227 pn=2 [2025-04-30T09:48:02.536648514Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=28 off=0 len=257 fin=true [2025-04-30T09:48:02.536658492Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=32 off=0 len=257 fin=true [2025-04-30T09:48:02.536661658Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=36 off=0 len=257 fin=true [2025-04-30T09:48:02.536664454Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=40 off=0 len=257 fin=true [2025-04-30T09:48:02.536667609Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=44 off=0 len=161 fin=false [2025-04-30T09:48:02.536676336Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1252 bytes [2025-04-30T09:48:02.536679021Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 28 is writable with capacity Ok(11883) [2025-04-30T09:48:02.536681575Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 32 is writable with capacity Ok(11883) [2025-04-30T09:48:02.536683830Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 36 is writable with capacity Ok(11883) [2025-04-30T09:48:02.536686054Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 40 is writable with capacity Ok(11883) [2025-04-30T09:48:02.536688288Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 44 is writable with capacity Ok(11883) [2025-04-30T09:48:02.536692376Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.536694630Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 28 has 257 bytes (fin? true) [2025-04-30T09:48:02.536698066Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/apncuvchkmoznytbolwujujifnlhmwpdjcrxgkppxpaxlujktvztqonzwxjaevxptpazdbomovmooodywmbkmhzfocnhobgqfrflykxldzqlwmtwmjbzhmmdynekvrfzpfvhcxuktfotwgihjcynxhgcknepzqlrwzcephpnvcvhecemwslxllnlhicpsheqhvjawhogyfmzuvfsogsfpypwkyqquwczseqevptleeiyvxmnlurfrifvjt" on stream 28 [2025-04-30T09:48:02.536717533Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 28 [2025-04-30T09:48:02.536722602Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.536724886Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 32 has 257 bytes (fin? true) [2025-04-30T09:48:02.536727611Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/iexrzddskorkkzgpasjjpohwkifbnucrtgicykbepurejjzmbgmvxldvrdsrcushvzqotlwbmiwqktjzayjaqncbofytscgdqtrkmzcccbrsiiiljgbvepjpcrujucebrxmhjslesgzqjntazhicsrhqamnnwrvwngjbvfyxwwsnkayipwuorxgnafnchuirokhitioslxtbidfurtmrjpyzpnwxuaaakovtcqyfrsbbuegycqjejvjijc" on stream 32 [2025-04-30T09:48:02.536740996Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 32 [2025-04-30T09:48:02.536745214Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.536747478Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 36 has 257 bytes (fin? true) [2025-04-30T09:48:02.536750234Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/sixtnfdstfkmivcamroydicpuqzvciangaoyrvexmrtoakowjhxaddoxbzdvkqtesklhrrlemygsvcvuyamptmiwwirradtvfliojsfsrtixawioblmkhlmhgcyyphxkhonvhgqwjgqtlbccjsdzjqapagipjycnszphisucurdxtuwpxnwqhcavzkzzppvlwmxjaklwvamlqzapnfakxbhpotofeqpysbgkgwgbzkjocpdrnxdyvdvvft" on stream 36 [2025-04-30T09:48:02.536763288Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 36 [2025-04-30T09:48:02.536767546Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.536769810Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 40 has 257 bytes (fin? true) [2025-04-30T09:48:02.536772525Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/ipfwroriqniltigotlcmjxpuhtglmvtejtnekueymbyjjlzlreflogwecpcunqjocogqijwvcavrvztyvkxzwawktglboojmximkylyleqtscracjaadtnkxiaadlqntdbexefvaatgasjclqktfequzmdejbtcmtzxlmcxvkeljtmobsatddyxytjesfezpmwkjwtthsgmmmkdgcnmrxcyxtuismvtpfbmsogzwfqfkrplrwpkgzygfuh" on stream 40 [2025-04-30T09:48:02.536789707Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 40 [2025-04-30T09:48:02.536794135Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 161 bytes [2025-04-30T09:48:02.536796600Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 44 has 161 bytes (fin? false) [2025-04-30T09:48:02.536800447Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.536806138Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11883 out_len=1200 left=1169 [2025-04-30T09:48:02.536810115Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=42 pn=10 [2025-04-30T09:48:02.536812660Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=20 blocks=[0..2] ecn_counts=None [2025-04-30T09:48:02.536815766Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=28 off=0 len=32 fin=true [2025-04-30T09:48:02.536822759Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=997.506977ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1685 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 9, last_sent_packet: 10, 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: 312, tv_nsec: 323741040 }, next_time: Instant { tv_sec: 312, tv_nsec: 323741040 }, 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:48:02.536856622Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 68 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 323741040 } }) [2025-04-30T09:48:02.536863975Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.536867903Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.536872772Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11815 out_len=1200 left=1174 [2025-04-30T09:48:02.536876198Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=11 [2025-04-30T09:48:02.536878613Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=32 off=0 len=32 fin=true [2025-04-30T09:48:02.536883953Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=997.445803ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1748 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 10, last_sent_packet: 11, 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: 312, tv_nsec: 323808416 }, next_time: Instant { tv_sec: 312, tv_nsec: 323808416 }, 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:48:02.536914670Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 323808416 } }) [2025-04-30T09:48:02.536918858Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.536922424Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.536926823Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11752 out_len=1200 left=1174 [2025-04-30T09:48:02.536930139Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=12 [2025-04-30T09:48:02.536932493Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=36 off=0 len=32 fin=true [2025-04-30T09:48:02.536937532Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=997.392244ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1811 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 11, last_sent_packet: 12, 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: 312, tv_nsec: 323862887 }, next_time: Instant { tv_sec: 312, tv_nsec: 323862887 }, 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:48:02.536962198Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 323862887 } }) [2025-04-30T09:48:02.536966006Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.536969432Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.536973349Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11689 out_len=1200 left=1174 [2025-04-30T09:48:02.536976445Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=13 [2025-04-30T09:48:02.536978789Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=40 off=0 len=32 fin=true [2025-04-30T09:48:02.536983508Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=997.346268ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1874 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 12, last_sent_packet: 13, 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: 312, tv_nsec: 323909895 }, next_time: Instant { tv_sec: 312, tv_nsec: 323909895 }, 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:48:02.537012252Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 323909895 } }) [2025-04-30T09:48:02.537016330Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.537019736Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.537022791Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.537024975Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.537672482Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.537680097Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.537685537Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1227 pn=3 [2025-04-30T09:48:02.537690747Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=44 off=161 len=96 fin=true [2025-04-30T09:48:02.537694483Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=48 off=0 len=257 fin=true [2025-04-30T09:48:02.537697729Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=52 off=0 len=257 fin=true [2025-04-30T09:48:02.537700715Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=56 off=0 len=257 fin=true [2025-04-30T09:48:02.537705103Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=60 off=0 len=257 fin=true [2025-04-30T09:48:02.537708059Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=64 off=0 len=58 fin=false [2025-04-30T09:48:02.537717056Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1252 bytes [2025-04-30T09:48:02.537719781Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 44 is writable with capacity Ok(11626) [2025-04-30T09:48:02.537722375Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 48 is writable with capacity Ok(11626) [2025-04-30T09:48:02.537724630Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 52 is writable with capacity Ok(11626) [2025-04-30T09:48:02.537726854Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 56 is writable with capacity Ok(11626) [2025-04-30T09:48:02.537729078Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 60 is writable with capacity Ok(11626) [2025-04-30T09:48:02.537731342Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 64 is writable with capacity Ok(11626) [2025-04-30T09:48:02.537735370Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 96 bytes [2025-04-30T09:48:02.537737654Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 44 has 96 bytes (fin? true) [2025-04-30T09:48:02.537741391Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/huawsdfiidnvakpjwinbzsbaddnikkdiwzusjctxuodjisotzzftaseirfczqfpwleoxvzerbhryazjxnzxwygkdssmwawxqdxgodpfdxfcdfozoaoqfwoeonghuxesizqmxuhmpihnpwtzghvrrlqolpwjkybxefgnqmyhqlbzegipsyogkoqaolqrxywnfcwluweynaiulwahijyvwekuuhgyebpcrohvmdnlnawvilopffdovepowql" on stream 44 [2025-04-30T09:48:02.537760486Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 44 [2025-04-30T09:48:02.537770455Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.537772880Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 48 has 257 bytes (fin? true) [2025-04-30T09:48:02.537775755Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/nqhywbzgnduldazmvcroinnpuyqtljzyqnpxnhgxqmapzbbmvxhmvdrvtszybhebmxbyycvrmhvbrtudtouttaegzkozmrorltopcuvrbdorwkujjwzptrfdarntslytbcedywgtuulbnxxvrcgeauqqmmzegofobhjwtgkkkkdxfaednyjtzahixzcxhebsvojklpbokqpgnhosvyvuqhrsvjghnrnvxdrxuenawsuhiixgnsxzpkmjhc" on stream 48 [2025-04-30T09:48:02.537789420Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 48 [2025-04-30T09:48:02.537793759Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.537796023Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 52 has 257 bytes (fin? true) [2025-04-30T09:48:02.537798658Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/frugqpgswanywmxojpaqxnxmorynrmvajnpierjnftokgufchsztcbsjkijuoxfmoufzvtzmsduhzsslpbpoxlstuscvzhfdwojcvtjpwxlwomhzvsuerfqawleqomwtpibqylvljstkphzfownngepveiqmgafabhzwizouyonksmdifilaphcpdbvvkgkfadxuqorzoyaktqcgseemxwlzmhqcujhbltbktgcgalevmoewstbslmbeaq" on stream 52 [2025-04-30T09:48:02.537811602Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 52 [2025-04-30T09:48:02.537815669Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.537817924Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 56 has 257 bytes (fin? true) [2025-04-30T09:48:02.537820649Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/ctzhnlmmuiapirqqssmucfghgqtbcjicvaqnitssvizjcmtkxmzttmsnjfhokwlynuvvxhxxclujvalgrskxlufmpciklrfnheltosuskqgeozsrtgmefmtpcwyqfwesjjqzfzophdyuzdxzizwqinbihxafchgmsmkavzexrojvabnusaznkvenyblnlcoeandntoukshxnyyiwggzwgekqfnirpbvkkazoracariznguxmloooibayaj" on stream 56 [2025-04-30T09:48:02.537833713Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 56 [2025-04-30T09:48:02.537837931Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.537840185Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 60 has 257 bytes (fin? true) [2025-04-30T09:48:02.537842870Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/rvhoxivatdnpixradrsatjaqpveqgfnefcuorkhobjsuxsxsrurmvzpqxblyppsqrstnsihpxmclrqnqoujuvyuccdihpzninyzewnpnzguoaancoobnihvumqpumpjimxcswsqppvzewiycmdujcnbyezzyqzldabxplltnjxbsbviurfmdwyhgiozluapwnakorplppeedzhwgcxgdlsmnamryfteichceudezqldnnbgdveivnvpjdy" on stream 60 [2025-04-30T09:48:02.537855674Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 60 [2025-04-30T09:48:02.537859872Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 58 bytes [2025-04-30T09:48:02.537862136Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 64 has 58 bytes (fin? false) [2025-04-30T09:48:02.537866053Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.537871794Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11626 out_len=1200 left=1169 [2025-04-30T09:48:02.537875781Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=42 pn=14 [2025-04-30T09:48:02.537878336Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=23 blocks=[0..3] ecn_counts=None [2025-04-30T09:48:02.537881502Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=44 off=0 len=32 fin=true [2025-04-30T09:48:02.537891140Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=996.438516ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1942 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 13, last_sent_packet: 14, 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: 312, tv_nsec: 324806646 }, next_time: Instant { tv_sec: 312, tv_nsec: 324806646 }, 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:48:02.537925604Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 68 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 324806646 } }) [2025-04-30T09:48:02.537930263Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.537934100Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.537938719Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11558 out_len=1200 left=1174 [2025-04-30T09:48:02.537942145Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=15 [2025-04-30T09:48:02.537944560Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=48 off=0 len=32 fin=true [2025-04-30T09:48:02.537949779Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=996.379997ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2005 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 14, last_sent_packet: 15, 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: 312, tv_nsec: 324874563 }, next_time: Instant { tv_sec: 312, tv_nsec: 324874563 }, 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:48:02.537975457Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 324874563 } }) [2025-04-30T09:48:02.537979465Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.537982931Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.537986778Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11495 out_len=1200 left=1174 [2025-04-30T09:48:02.537989964Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=16 [2025-04-30T09:48:02.537996126Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=52 off=0 len=32 fin=true [2025-04-30T09:48:02.538001496Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=996.328311ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2068 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 15, last_sent_packet: 16, 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: 312, tv_nsec: 324923364 }, next_time: Instant { tv_sec: 312, tv_nsec: 324923364 }, 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:48:02.538026953Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 324923364 } }) [2025-04-30T09:48:02.538030921Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.538034437Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.538038695Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11432 out_len=1200 left=1174 [2025-04-30T09:48:02.538041911Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=17 [2025-04-30T09:48:02.538044255Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=56 off=0 len=32 fin=true [2025-04-30T09:48:02.538060145Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=996.269551ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2131 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 16, last_sent_packet: 17, 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: 312, tv_nsec: 324974870 }, next_time: Instant { tv_sec: 312, tv_nsec: 324974870 }, 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:48:02.538114476Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 324974870 } }) [2025-04-30T09:48:02.538119466Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.538123373Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.538128723Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11369 out_len=1200 left=1174 [2025-04-30T09:48:02.538132380Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=37 pn=18 [2025-04-30T09:48:02.538139052Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=60 off=0 len=32 fin=true [2025-04-30T09:48:02.538146225Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=996.183501ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2194 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 17, last_sent_packet: 18, 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: 312, tv_nsec: 325063906 }, next_time: Instant { tv_sec: 312, tv_nsec: 325063906 }, 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:48:02.538172525Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 325063906 } }) [2025-04-30T09:48:02.538176482Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.538180028Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.538183225Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.538185429Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.538695048Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.538698786Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.538703704Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1227 pn=4 [2025-04-30T09:48:02.538709125Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=64 off=58 len=199 fin=true [2025-04-30T09:48:02.538712431Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=68 off=0 len=257 fin=true [2025-04-30T09:48:02.538715426Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=72 off=0 len=257 fin=true [2025-04-30T09:48:02.538718512Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=76 off=0 len=257 fin=true [2025-04-30T09:48:02.538721658Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=80 off=0 len=213 fin=false [2025-04-30T09:48:02.538730184Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1252 bytes [2025-04-30T09:48:02.538732909Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 64 is writable with capacity Ok(11306) [2025-04-30T09:48:02.538735384Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 68 is writable with capacity Ok(11306) [2025-04-30T09:48:02.538737648Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 72 is writable with capacity Ok(11306) [2025-04-30T09:48:02.538739892Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 76 is writable with capacity Ok(11306) [2025-04-30T09:48:02.538742136Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 80 is writable with capacity Ok(11306) [2025-04-30T09:48:02.538746134Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 199 bytes [2025-04-30T09:48:02.538748388Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 64 has 199 bytes (fin? true) [2025-04-30T09:48:02.538756703Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/adxizxdezvfkazrastnbrnpusytpebjbekmuzvlrgcksueghzgbtonvmeizbcoiwllkbyikdaaoxffeheducfagqubyqasvpyctarkvymwldztumwgyrrseuuhcxpubmojgxjhzbanulinxshubfvdhnbjnjhdnqaydtzbivsqggheaeoyhtkyutxcsooklcwumjaytindmrttfcwkqpctwfhbbkdasgugizknhfqwxbvoxdpxvuomcees" on stream 64 [2025-04-30T09:48:02.538775959Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 64 [2025-04-30T09:48:02.538781109Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.538783373Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 68 has 257 bytes (fin? true) [2025-04-30T09:48:02.538786098Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/uqvaxrrstazhgrthfeubdcdgxbtxuofdkhdjihzltaczmjvpgwusotbwcftvjdbjzbymhjbczdgsopztbrxlrhvgdtjphyadcszlxpmsvmyzkoccxuyerqlzsybiycajzcxvpqjbrwtvdcxezhkeqtefsihpgrguwbaakqzfxtgylchxrnsbzckgkbrzmbpngrkgxsjfeccgxyhtklcxdavfzuxpfpefzashfqwyefiukumwllpqniwfdr" on stream 68 [2025-04-30T09:48:02.538799363Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 68 [2025-04-30T09:48:02.538803681Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.538805915Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 72 has 257 bytes (fin? true) [2025-04-30T09:48:02.538808600Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/jzcjdlxvnpcunscgdrgzjwpevtktvvzavercotfxekxhmpssyxvfwoguguaqzidvyzhxkelkfbxxouesbioixmeycujtufenznsjlvgzlcamiuwdhxplsezkohcrtnriqllibjmitneqbmuyuijdupeuihroadrijjbkafbubyypdjiwkevnsbmqkqswlhvyhzrqngtjqzarmfaezrgwcbjzgwnnnwvfixlddpsepyjtwebxqrfzuobrhm" on stream 72 [2025-04-30T09:48:02.538821635Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 72 [2025-04-30T09:48:02.538825892Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.538828167Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 76 has 257 bytes (fin? true) [2025-04-30T09:48:02.538830852Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/aavhdfimdfmravyahfjnasacufjrnaxrawtqrnfbjbvgwlmgailzisbjqsylcyyrutfeezcuxtgsuiwahfddjawoophtreciuozskvhanaisokieixthndebmqeihsavcoygiipsgfypywjvzegpoknxevknqsglgfetopbldtcgplfjfxhqtllbpcuolucpepgvudqllynakoaqnkyyysdkerjwmhbppsuonxllhiftlfmbkeoqsefxad" on stream 76 [2025-04-30T09:48:02.538843896Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 76 [2025-04-30T09:48:02.538848214Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 213 bytes [2025-04-30T09:48:02.538850488Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 80 has 213 bytes (fin? false) [2025-04-30T09:48:02.538854636Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.538860336Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11306 out_len=1200 left=1169 [2025-04-30T09:48:02.538864254Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=43 pn=19 [2025-04-30T09:48:02.538866819Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=19 blocks=[0..4] ecn_counts=None [2025-04-30T09:48:02.538869914Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=64 off=0 len=32 fin=true [2025-04-30T09:48:02.538875856Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=995.453871ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2263 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 18, last_sent_packet: 19, 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: 312, tv_nsec: 325795309 }, next_time: Instant { tv_sec: 312, tv_nsec: 325795309 }, 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:48:02.538914818Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 69 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 325795309 } }) [2025-04-30T09:48:02.538919597Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.538923324Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.538927802Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11237 out_len=1200 left=1174 [2025-04-30T09:48:02.538931289Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=20 [2025-04-30T09:48:02.538933683Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=68 off=0 len=32 fin=true [2025-04-30T09:48:02.538938973Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=995.390773ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2327 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 19, last_sent_packet: 20, 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: 312, tv_nsec: 325863797 }, next_time: Instant { tv_sec: 312, tv_nsec: 325863797 }, 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:48:02.538964210Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 325863797 } }) [2025-04-30T09:48:02.538968117Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.538971584Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.538975982Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11173 out_len=1200 left=1174 [2025-04-30T09:48:02.538979178Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=21 [2025-04-30T09:48:02.538981562Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=72 off=0 len=32 fin=true [2025-04-30T09:48:02.538986452Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=995.343345ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2391 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 20, last_sent_packet: 21, 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: 312, tv_nsec: 325912047 }, next_time: Instant { tv_sec: 312, tv_nsec: 325912047 }, 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:48:02.539017600Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 325912047 } }) [2025-04-30T09:48:02.539022890Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.539026336Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.539030273Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11109 out_len=1200 left=1174 [2025-04-30T09:48:02.539033509Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=22 [2025-04-30T09:48:02.539035864Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=76 off=0 len=32 fin=true [2025-04-30T09:48:02.539040943Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=995.288843ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2455 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 21, last_sent_packet: 22, 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: 312, tv_nsec: 325966779 }, next_time: Instant { tv_sec: 312, tv_nsec: 325966779 }, 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:48:02.539079535Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 325966779 } }) [2025-04-30T09:48:02.539089554Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.539095565Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.539100805Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.539104351Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.539732432Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.539741008Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.539747470Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1227 pn=5 [2025-04-30T09:48:02.539753140Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=80 off=213 len=44 fin=true [2025-04-30T09:48:02.539761837Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=84 off=0 len=257 fin=true [2025-04-30T09:48:02.539765614Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=88 off=0 len=257 fin=true [2025-04-30T09:48:02.539768479Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=92 off=0 len=257 fin=true [2025-04-30T09:48:02.539771715Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=96 off=0 len=257 fin=true [2025-04-30T09:48:02.539774540Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=100 off=0 len=106 fin=false [2025-04-30T09:48:02.539784639Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1252 bytes [2025-04-30T09:48:02.539787484Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 80 is writable with capacity Ok(11045) [2025-04-30T09:48:02.539790169Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 84 is writable with capacity Ok(11045) [2025-04-30T09:48:02.539792434Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 88 is writable with capacity Ok(11045) [2025-04-30T09:48:02.539794678Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 92 is writable with capacity Ok(11045) [2025-04-30T09:48:02.539796952Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 96 is writable with capacity Ok(11045) [2025-04-30T09:48:02.539799166Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 100 is writable with capacity Ok(11045) [2025-04-30T09:48:02.539803434Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 44 bytes [2025-04-30T09:48:02.539805839Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 80 has 44 bytes (fin? true) [2025-04-30T09:48:02.539809726Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/ufalxbglfdwjgotjlssvvtsfinxzrlxrwklrrvisjmospsufquwrtowiwedanqtmdrbucazrnbigfanferocwpanhluimfzefgxdtzvacykhvorfygtsbqvgczslubsjowempiapbegkfxtrkwbtbekxyrbtlynoasetbbwtiibulaidwnulxyjvkddsolblacqwjvbrkfdgyytqfcmwmuxwpggqszialxecjreauuidezozylkyapyngu" on stream 80 [2025-04-30T09:48:02.539829152Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 80 [2025-04-30T09:48:02.539834352Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.539836716Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 84 has 257 bytes (fin? true) [2025-04-30T09:48:02.539839612Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/wqrcealtkwhqrzlowttirwtiambbtfgtodyyfwoeqedeodqmlqbarqecrpstxtttuqwomnmnlaqvrjarhfqyfkmxetjivjdfqhjcgqzjkjtigwbecpwyvfdvfziqtnrkdowieiujzuuilsfnlzjakeenelzefptrunbewgnxfxzykbvpqbzrtywtomubjcragsmuwhjrxrfvzedhkstmuhqblgcyquupehglgnpdwmoapboqgogsbixfih" on stream 84 [2025-04-30T09:48:02.539853367Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 84 [2025-04-30T09:48:02.539857545Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.539859809Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 88 has 257 bytes (fin? true) [2025-04-30T09:48:02.539862564Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/bkvzxmytvvwdmazfffgefptisvajamaaxvjvsgbvvqgqtqdipbunqeiqqsimprthejqeacsykfvjtkqidnnxfxmslknynypsnxejswsrdfgchmxbryjwawlsbxghzgmtjcdkooholkzmjlxqndbpxhwmpkishabqemhijigledjltzetfcetmbewgegydojayyukvonuktxozngdqrzlowcwtsnebxphztlrbkqvieasqnerdbvfnuugnj" on stream 88 [2025-04-30T09:48:02.539875459Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 88 [2025-04-30T09:48:02.539882893Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.539885237Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 92 has 257 bytes (fin? true) [2025-04-30T09:48:02.539887992Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/qfrlysmussvvwbptufebtlavtzxsjhgxowgwvzbcfsftkxvluiouynxfejsecorpusbagsojmonittlcqpuxmifkgxicnirngtjtwpmjwuplcdjhpdprcmpyapyfisxbwzcuwhhtskkqgxxmvbjgymwrecutakjpadscvnocoaanvpuiirahghpsufhtcvudwsmzonhadflhqzikkmvdoawqessbnusoipfkxaqljvnuqdnrpiwzhgiqtc" on stream 92 [2025-04-30T09:48:02.539901076Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 92 [2025-04-30T09:48:02.539905304Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.539907548Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 96 has 257 bytes (fin? true) [2025-04-30T09:48:02.539910213Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/gpwaeosdlugkwakyiaxqwmrpfzgtdnuwrgjeplgfdihcnlerlazrubhhupphbjknznzqrvsaackupizqupqseecrywdxndlojvjmffmrddedujwpbsbbseparvnvzdmmjczwaoflhgtwijfrqligylakgrexkpqzvywngnuzutkivktwhhodogrdervavjnqddcbxbstwuhuwrhmozqwefjqzndfxinfbhmjepdxlmadubgsuihctgrugx" on stream 96 [2025-04-30T09:48:02.539923168Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 96 [2025-04-30T09:48:02.539927415Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 106 bytes [2025-04-30T09:48:02.539929669Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 100 has 106 bytes (fin? false) [2025-04-30T09:48:02.539933787Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.539940219Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11045 out_len=1200 left=1169 [2025-04-30T09:48:02.539944427Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=43 pn=23 [2025-04-30T09:48:02.539946992Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=24 blocks=[0..5] ecn_counts=None [2025-04-30T09:48:02.539950208Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=80 off=0 len=32 fin=true [2025-04-30T09:48:02.539956880Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=994.372776ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2524 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 22, last_sent_packet: 23, 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: 312, tv_nsec: 326874531 }, next_time: Instant { tv_sec: 312, tv_nsec: 326874531 }, 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:48:02.539992717Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 69 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 326874531 } }) [2025-04-30T09:48:02.539997486Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.540002676Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.540017593Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10976 out_len=1200 left=1174 [2025-04-30T09:48:02.540023915Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=24 [2025-04-30T09:48:02.540028153Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=84 off=0 len=32 fin=true [2025-04-30T09:48:02.540037921Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=994.291364ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2588 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 23, last_sent_packet: 24, 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: 312, tv_nsec: 326951384 }, next_time: Instant { tv_sec: 312, tv_nsec: 326951384 }, 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:48:02.540096931Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 326951384 } }) [2025-04-30T09:48:02.540107691Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.540113582Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.540123040Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10912 out_len=1200 left=1174 [2025-04-30T09:48:02.540129572Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=25 [2025-04-30T09:48:02.540133810Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=88 off=0 len=32 fin=true [2025-04-30T09:48:02.540143939Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=994.185276ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2652 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 24, last_sent_packet: 25, 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: 312, tv_nsec: 327055989 }, next_time: Instant { tv_sec: 312, tv_nsec: 327055989 }, 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:48:02.540183603Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 327055989 } }) [2025-04-30T09:48:02.540188502Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.540200795Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.540209601Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10848 out_len=1200 left=1174 [2025-04-30T09:48:02.540216154Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=26 [2025-04-30T09:48:02.540220512Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=92 off=0 len=32 fin=true [2025-04-30T09:48:02.540230069Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=994.099306ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2716 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 25, last_sent_packet: 26, 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: 312, tv_nsec: 327143071 }, next_time: Instant { tv_sec: 312, tv_nsec: 327143071 }, 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:48:02.540269262Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 327143071 } }) [2025-04-30T09:48:02.540273951Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.540279401Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.540287947Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10784 out_len=1200 left=1174 [2025-04-30T09:48:02.540294259Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=27 [2025-04-30T09:48:02.540298617Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=96 off=0 len=32 fin=true [2025-04-30T09:48:02.540307914Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=994.02126ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2780 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 26, last_sent_packet: 27, 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: 312, tv_nsec: 327221567 }, next_time: Instant { tv_sec: 312, tv_nsec: 327221567 }, 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:48:02.540347779Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 327221567 } }) [2025-04-30T09:48:02.540352768Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.540365492Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.540371623Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.540375561Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.540754266Z TRACE quiche_server] got 1251 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.540761590Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.540767231Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1226 pn=6 [2025-04-30T09:48:02.540772711Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=100 off=106 len=151 fin=true [2025-04-30T09:48:02.540776187Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=104 off=0 len=257 fin=true [2025-04-30T09:48:02.540779473Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=108 off=0 len=257 fin=true [2025-04-30T09:48:02.540782399Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=112 off=0 len=257 fin=true [2025-04-30T09:48:02.540788160Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=116 off=0 len=257 fin=true [2025-04-30T09:48:02.540809790Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1251 bytes [2025-04-30T09:48:02.540812675Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 100 is writable with capacity Ok(10720) [2025-04-30T09:48:02.540815250Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 104 is writable with capacity Ok(10720) [2025-04-30T09:48:02.540817504Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 108 is writable with capacity Ok(10720) [2025-04-30T09:48:02.540819699Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 112 is writable with capacity Ok(10720) [2025-04-30T09:48:02.540821913Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 116 is writable with capacity Ok(10720) [2025-04-30T09:48:02.540826321Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 151 bytes [2025-04-30T09:48:02.540828615Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 100 has 151 bytes (fin? true) [2025-04-30T09:48:02.540832512Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/bpgcnnhejrsqczrzcgofpndxpxhvplqyvlgkwzvrojenwexjkunlzdibpocbzptovxhprbzjsfnaonrjyjansimhisilnirpkasxhpugopdtlugkahmtopymvtdkduknnchuwhwmadjeklpifqkbdoggepvitwwcgsjvejpugnvwtwisrccdzclswgqhsiuetzpodxnvvrsolxfqwbcpikhtooxsfyqsmdyxbywybihaslnoxgzkmftmgr" on stream 100 [2025-04-30T09:48:02.540851648Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 100 [2025-04-30T09:48:02.540857008Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.540859252Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 104 has 257 bytes (fin? true) [2025-04-30T09:48:02.540862107Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/nvcbgftevuunfaymdrzirronkwybtqlieuhaoiuaaqfwmyvffmdkmflrrsmskoqzcmfxjoskwkpafbdfdmgpxdkbprtgndtysxjpjckfqbbbznxlztrlypckhdtxkyecfxgkvxoxtmyzcyblhpdeumtnfcainwlgtamzckdnsokzvphsnqejlwejwzsqwmgxsdexbnbmydglcnkmzlkidpleudmpwjwfhbnffaaheomneeffloasttjeyg" on stream 104 [2025-04-30T09:48:02.540875222Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 104 [2025-04-30T09:48:02.540879440Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.540881674Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 108 has 257 bytes (fin? true) [2025-04-30T09:48:02.540887545Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/hiychgipxbumcbirtltzcqsjlrgxbklvhsuayfxcjtesxlkitzrnfnezewzithkvzoqhywthotjrrnluzyjuxuqgjtienxiwpmsqcagehrzvikxhibpgmimtselfauzwburvcvpzjeuaqmtxfykbpztuxfoktcinxolxryiexiuezbgqzrsfbikbhijtbuyygkwgbmyrgcmbjqylogmhbeyjqaahleecdcsdntqparhqqnniaqrozikpyw" on stream 108 [2025-04-30T09:48:02.540900719Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 108 [2025-04-30T09:48:02.540904937Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.540907191Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 112 has 257 bytes (fin? true) [2025-04-30T09:48:02.540909977Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/tgqgysdoroigiuwdgsqnnmhineljtrjnzefcmjjgjxwzfuicqjmjrgumctyyzgozlpzfgisggocvdlytovrojtkvitgpkmztjvcxsthywtxdvbfcbkgziagpwyhaptybswpyinxztanxvaoiqdverecbhbftiyaibthsvaglicbqqqozojwqketuhedssuuuprbfcynrpcugywibaqoeifuklwvyhycuaeoxgaeskiwgqphmjsbxweawti" on stream 112 [2025-04-30T09:48:02.540923011Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 112 [2025-04-30T09:48:02.540927439Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.540929684Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 116 has 257 bytes (fin? true) [2025-04-30T09:48:02.540932409Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/pnubqjkfpfmtldwfvispizqmnxmmsdlqzfqqxweraysgsecpienzekprafytznkfvzgqsrnalvsoittnwcqxwyauzzktoqjkmguhdwzvyfcyhwkpfwmwtknlgeaftpiworpevwoiedzgjbfvjcajspluevqireolhfqsasrgbikyiesuhbymnurfzfaslopkuvztjrownxtlrvljdsnmvnuodppuukxrdhplvgjxwdkuuojcruqteentsg" on stream 116 [2025-04-30T09:48:02.540945353Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 116 [2025-04-30T09:48:02.540950543Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.540957084Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10720 out_len=1200 left=1169 [2025-04-30T09:48:02.540961262Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=43 pn=28 [2025-04-30T09:48:02.540963827Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=23 blocks=[0..6] ecn_counts=None [2025-04-30T09:48:02.540967003Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=100 off=0 len=32 fin=true [2025-04-30T09:48:02.540973796Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=993.35589ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2849 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 27, last_sent_packet: 28, 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: 312, tv_nsec: 327891266 }, next_time: Instant { tv_sec: 312, tv_nsec: 327891266 }, 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:48:02.541009192Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 69 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 327891266 } }) [2025-04-30T09:48:02.541018890Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.541025171Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.541032976Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10651 out_len=1200 left=1174 [2025-04-30T09:48:02.541038677Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=29 [2025-04-30T09:48:02.541042945Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=104 off=0 len=32 fin=true [2025-04-30T09:48:02.541052292Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=993.277013ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2913 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 28, last_sent_packet: 29, 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: 312, tv_nsec: 327967248 }, next_time: Instant { tv_sec: 312, tv_nsec: 327967248 }, 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:48:02.541116532Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 327967248 } }) [2025-04-30T09:48:02.541121922Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.541128203Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.541137030Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10587 out_len=1200 left=1174 [2025-04-30T09:48:02.541143392Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=30 [2025-04-30T09:48:02.541147900Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=108 off=0 len=32 fin=true [2025-04-30T09:48:02.541157879Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=993.171186ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2977 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 29, last_sent_packet: 30, 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: 312, tv_nsec: 328070350 }, next_time: Instant { tv_sec: 312, tv_nsec: 328070350 }, 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:48:02.541197904Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 328070350 } }) [2025-04-30T09:48:02.541208143Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.541214515Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.541222850Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10523 out_len=1200 left=1174 [2025-04-30T09:48:02.541228971Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=31 [2025-04-30T09:48:02.541233189Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=112 off=0 len=32 fin=true [2025-04-30T09:48:02.541242717Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=993.086458ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3041 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 30, last_sent_packet: 31, 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: 312, tv_nsec: 328156390 }, next_time: Instant { tv_sec: 312, tv_nsec: 328156390 }, 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:48:02.541283112Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 328156390 } }) [2025-04-30T09:48:02.541288222Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.541293532Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.541301897Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10459 out_len=1200 left=1174 [2025-04-30T09:48:02.541308279Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=32 [2025-04-30T09:48:02.541312427Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=116 off=0 len=32 fin=true [2025-04-30T09:48:02.541322416Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=993.00687ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3105 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 31, last_sent_packet: 32, 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: 312, tv_nsec: 328235598 }, next_time: Instant { tv_sec: 312, tv_nsec: 328235598 }, 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:48:02.541361729Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 328235598 } }) [2025-04-30T09:48:02.541373791Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.541379592Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.541385553Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.541389380Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.541783976Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.541792562Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.541798132Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1227 pn=7 [2025-04-30T09:48:02.541803783Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=120 off=0 len=257 fin=true [2025-04-30T09:48:02.541807810Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=124 off=0 len=257 fin=true [2025-04-30T09:48:02.541810686Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=128 off=0 len=257 fin=true [2025-04-30T09:48:02.541813441Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=132 off=0 len=257 fin=true [2025-04-30T09:48:02.541816567Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=136 off=0 len=156 fin=false [2025-04-30T09:48:02.541825944Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1252 bytes [2025-04-30T09:48:02.541828659Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 120 is writable with capacity Ok(10395) [2025-04-30T09:48:02.541831204Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 124 is writable with capacity Ok(10395) [2025-04-30T09:48:02.541833458Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 128 is writable with capacity Ok(10395) [2025-04-30T09:48:02.541835662Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 132 is writable with capacity Ok(10395) [2025-04-30T09:48:02.541837876Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 136 is writable with capacity Ok(10395) [2025-04-30T09:48:02.541842084Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.541844348Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 120 has 257 bytes (fin? true) [2025-04-30T09:48:02.541847875Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/iopafjvsxyfckuruaxhxeluwaofnnfjfskdxsprcynhigzvbcomcwddwdfttebcecycqskisvdxszvdqqqysoebbltfirmvspukalhsjpjlzdmdbtxatodedqpmovatehcblaovrnwxvggiondbqjcxrxmyrajpxuprknbgkqzaxjwfolvlulxaeujlsuqtyzavrufackmursgygdeczwmzmakrpxtchzvbtygaazquatdjzgjoxrdeniq" on stream 120 [2025-04-30T09:48:02.541867512Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 120 [2025-04-30T09:48:02.541873042Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.541875346Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 124 has 257 bytes (fin? true) [2025-04-30T09:48:02.541878111Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/oseoltqflzpyzaregtjhakiholilxfnepcboupuedskacbunyhyzwsmacpedzdtkwddeddcwkmcgedfzgapmergrvxmgqburlhjjonxanzwnlsrvynzoqjeumlbmnwllvbheawakakeuvynjmcfwwxmcvnesadkapoorbwpyugdfsvpapfjfsipngxregipsltucojinolkflyqfqqidtcxlwvpmlcgusqzvqdwmhnqysifwhxcifgeoxn" on stream 124 [2025-04-30T09:48:02.541891296Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 124 [2025-04-30T09:48:02.541895524Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.541902457Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 128 has 257 bytes (fin? true) [2025-04-30T09:48:02.541905392Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/ezhedsantefmwhatwsdukybaguzialshxazzdexjzshdhaxslepcruymyqbxfxzohbtkxymsqiueujgujyhqiayxgfnrqyvzpdoefoddysfulyspnngxgzxuoqeyxljttajwciyfpwzdyualymlvbpvczvzqydjxlwzmzfglndwyouahqdncqburydrtuflzmxeccgsbsyfyuyjjggchhexwjurhfpdhlesszaljqmncegderbjcnhbpsj" on stream 128 [2025-04-30T09:48:02.541918627Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 128 [2025-04-30T09:48:02.541923095Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.541925339Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 132 has 257 bytes (fin? true) [2025-04-30T09:48:02.541928024Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/tdhzyrqsydwcjzjkfqyofwlczewfeqpyxtmvhvpcmgewzblhcxxsanmpqrrpfqgqtvsryzxybjtsxmdldhyncxdcmgwedxmsjmbduljamscbwnxnyfzsptgekzelefuijzjaumdbhtaxfcsuxftzbkkesihrqvztfpnqdpewxysxjfnyoodrmbeqryofvzycfslkgeoryxorqenifiqogdewfpayezrmammhznytfyttsxahaiuwneutti" on stream 132 [2025-04-30T09:48:02.541940888Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 132 [2025-04-30T09:48:02.541945016Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 156 bytes [2025-04-30T09:48:02.541947240Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 136 has 156 bytes (fin? false) [2025-04-30T09:48:02.541951558Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.541957990Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10395 out_len=1200 left=1169 [2025-04-30T09:48:02.541962098Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=43 pn=33 [2025-04-30T09:48:02.541964613Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=20 blocks=[0..7] ecn_counts=None [2025-04-30T09:48:02.541967819Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=120 off=0 len=32 fin=true [2025-04-30T09:48:02.541974541Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=992.355125ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3174 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 32, last_sent_packet: 33, 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: 312, tv_nsec: 328892232 }, next_time: Instant { tv_sec: 312, tv_nsec: 328892232 }, 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:48:02.542009727Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 69 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 328892232 } }) [2025-04-30T09:48:02.542015317Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.542021419Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.542028872Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10326 out_len=1200 left=1174 [2025-04-30T09:48:02.542040835Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=34 [2025-04-30T09:48:02.542045283Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=124 off=0 len=32 fin=true [2025-04-30T09:48:02.542057075Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=992.27211ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3238 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 33, last_sent_packet: 34, 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: 312, tv_nsec: 328963154 }, next_time: Instant { tv_sec: 312, tv_nsec: 328963154 }, 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:48:02.542121525Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 328963154 } }) [2025-04-30T09:48:02.542127767Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.542134229Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.542143175Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10262 out_len=1200 left=1174 [2025-04-30T09:48:02.542149658Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=35 [2025-04-30T09:48:02.542154156Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=128 off=0 len=32 fin=true [2025-04-30T09:48:02.542164425Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=992.16492ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3302 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 34, last_sent_packet: 35, 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: 312, tv_nsec: 329076064 }, next_time: Instant { tv_sec: 312, tv_nsec: 329076064 }, 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:48:02.542204600Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 329076064 } }) [2025-04-30T09:48:02.542209509Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.542215590Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.542229867Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10198 out_len=1200 left=1174 [2025-04-30T09:48:02.542236580Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=36 [2025-04-30T09:48:02.542240777Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=132 off=0 len=32 fin=true [2025-04-30T09:48:02.542250706Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=992.07865ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3366 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 35, last_sent_packet: 36, 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: 312, tv_nsec: 329163577 }, next_time: Instant { tv_sec: 312, tv_nsec: 329163577 }, 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:48:02.542289498Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 329163577 } }) [2025-04-30T09:48:02.542294317Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.542300639Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.542306149Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.542309906Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.542763371Z TRACE quiche_server] got 1201 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.542771036Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.542776907Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt ZeroRTT version=1 dcid=8cd77eca39a8d943 scid=2fbc14ad5007ed81 len=1176 pn=8 [2025-04-30T09:48:02.542782397Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=136 off=156 len=101 fin=true [2025-04-30T09:48:02.542785753Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=140 off=0 len=257 fin=true [2025-04-30T09:48:02.542789079Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=144 off=0 len=257 fin=true [2025-04-30T09:48:02.542791995Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=148 off=0 len=257 fin=true [2025-04-30T09:48:02.542795150Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm STREAM id=152 off=0 len=257 fin=true [2025-04-30T09:48:02.542805129Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 1201 bytes [2025-04-30T09:48:02.542807944Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 136 is writable with capacity Ok(10134) [2025-04-30T09:48:02.542810519Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 140 is writable with capacity Ok(10134) [2025-04-30T09:48:02.542812733Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 144 is writable with capacity Ok(10134) [2025-04-30T09:48:02.542814937Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 148 is writable with capacity Ok(10134) [2025-04-30T09:48:02.542817102Z DEBUG quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea response stream 152 is writable with capacity Ok(10134) [2025-04-30T09:48:02.542826679Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 101 bytes [2025-04-30T09:48:02.542829054Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 136 has 101 bytes (fin? true) [2025-04-30T09:48:02.542832911Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/ursbnkfnpoiucxnnhcybzhsbmsdphvicsyuqmsnflmikjdyrbrylcncnwvobvrbvagotayzogsfnzoslsuqcjzuluklqperaczqdoigiooqganyfbthmsflbvtkppujjdplpvrcdpdignonricjjzydvoiqtbihgdyyjsnmqlxqyigfswlxpfxugppemjblxlejaltixfaqixamysudfxfphspshsdfmprvrtxgbugrefhjsypyyljlrbc" on stream 136 [2025-04-30T09:48:02.542853259Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 136 [2025-04-30T09:48:02.542858759Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.542861013Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 140 has 257 bytes (fin? true) [2025-04-30T09:48:02.542863758Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/ocjfdxbamqlkdmvoeybknsyneqktvxuiyapieobkqsaeoahaihhamllcvxiarolwsrsgyyiegciwlugmzdazrpenrywbibpbvnnjuhorjnrslnvceywhcgavvbyzimmqgwlqeodqfccfvuzdmpnnwyfkklnsihaohgltknecfyslrvtgkwvrfuyqvcjoltdkgswpdicacrfqmatissyuebxweveaffhsyfjiwadwxkqhqegdxwsfbaxrbv" on stream 140 [2025-04-30T09:48:02.542877163Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 140 [2025-04-30T09:48:02.542881261Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.542883485Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 144 has 257 bytes (fin? true) [2025-04-30T09:48:02.542886270Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/cjxcmfawyclumynavdivhiymtphgzmysfbsquvccyaeamcdcumafbmtjvidrjezgdbasmdaibvjnpcemxzkkclkgcwedwdneftakhysmwulbskbejvguwusxsykidwqapykmtswfbyjuisxrkqeplwnngkojbjzadcbiqwwmskmbahlzqnlmobhpgvmtkhwdqhymngzspfffbzgizvlpfwfylsshmzehvdmlorlazsqpsplcptcpxzndnp" on stream 144 [2025-04-30T09:48:02.542899425Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 144 [2025-04-30T09:48:02.542914753Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.542917048Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 148 has 257 bytes (fin? true) [2025-04-30T09:48:02.542919853Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/wsbhwzexxuszcjgxmikpggzgjqzruddzcfxtrcxdfyuhvruipaflrhbndeogsfmkpxqdkjhmysyzsklunkyvzhnywpxzytmqebnlchhyybzqcnjuqibspgmnjtzjpovgntvpwnwhfronlhjgrizyrgaawhxvouxxuarpuivqwuynzuqxjippkjsctkajuzyogicavetoqehmhzoynxzdsaxifwdwyfvgfybtxucuiwjezkkvhygudjmflp" on stream 148 [2025-04-30T09:48:02.542933358Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 148 [2025-04-30T09:48:02.542938247Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea received 257 bytes [2025-04-30T09:48:02.542940501Z TRACE quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea stream 152 has 257 bytes (fin? true) [2025-04-30T09:48:02.542943197Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea got GET request for "/www/bwkanaknfxnfkozrdkleyiihjvsuloxfnktoeamqmfcocbgwnxsvtcyrpfbwbpsefmxoalndwtpslrcrwhhtiqsdmuhptlwhyvdqiufiphxiqofodsvrexkfnwjlgsfbddactukfsvtyrjkoganahztxgtusjaadozxmlpsugvcxvhiilcsrigzvyqqbxyiftmetcgzeefymluwzvcyzwtfaurreixhvngxjcscrjzpfetgxazfxbqrzcz" on stream 152 [2025-04-30T09:48:02.542956441Z INFO quiche_apps::common] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea sending response of size 32 on stream 152 [2025-04-30T09:48:02.542961601Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.542974665Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10134 out_len=1200 left=1169 [2025-04-30T09:48:02.542978913Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=43 pn=37 [2025-04-30T09:48:02.542981468Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=24 blocks=[0..8] ecn_counts=None [2025-04-30T09:48:02.542984684Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=136 off=0 len=32 fin=true [2025-04-30T09:48:02.542991587Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=991.33815ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3435 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 36, last_sent_packet: 37, 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: 312, tv_nsec: 329908826 }, next_time: Instant { tv_sec: 312, tv_nsec: 329908826 }, 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:48:02.543027544Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 69 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 329908826 } }) [2025-04-30T09:48:02.543033004Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.543039095Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.543048092Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10065 out_len=1200 left=1174 [2025-04-30T09:48:02.543054183Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=38 [2025-04-30T09:48:02.543058211Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=140 off=0 len=32 fin=true [2025-04-30T09:48:02.543098566Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=991.229948ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3499 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 37, last_sent_packet: 38, 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: 312, tv_nsec: 329981311 }, next_time: Instant { tv_sec: 312, tv_nsec: 329981311 }, 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:48:02.543146345Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 329981311 } }) [2025-04-30T09:48:02.543158458Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.543164729Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.543173426Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10001 out_len=1200 left=1174 [2025-04-30T09:48:02.543179827Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=39 [2025-04-30T09:48:02.543184065Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=144 off=0 len=32 fin=true [2025-04-30T09:48:02.543194455Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=991.1347ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3563 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 38, last_sent_packet: 39, 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: 312, tv_nsec: 330106755 }, next_time: Instant { tv_sec: 312, tv_nsec: 330106755 }, 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:48:02.543233377Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 330106755 } }) [2025-04-30T09:48:02.543238166Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.543243957Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.543252233Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9937 out_len=1200 left=1174 [2025-04-30T09:48:02.543258494Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=40 [2025-04-30T09:48:02.543262582Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=148 off=0 len=32 fin=true [2025-04-30T09:48:02.543272200Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=991.057006ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3627 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 39, last_sent_packet: 40, 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: 312, tv_nsec: 330185983 }, next_time: Instant { tv_sec: 312, tv_nsec: 330185983 }, 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:48:02.543312094Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 330185983 } }) [2025-04-30T09:48:02.543323716Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.543329647Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.543338433Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9873 out_len=1200 left=1174 [2025-04-30T09:48:02.543344514Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=38 pn=41 [2025-04-30T09:48:02.543348572Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm STREAM id=152 off=0 len=32 fin=true [2025-04-30T09:48:02.543358621Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=990.970715ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3691 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 40, last_sent_packet: 41, 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: 312, tv_nsec: 330272033 }, next_time: Instant { tv_sec: 312, tv_nsec: 330272033 }, 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:48:02.543396912Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 64 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 330272033 } }) [2025-04-30T09:48:02.543401481Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.543406891Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.543412672Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.543416448Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.568743147Z TRACE quiche_server] got 413 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.568762975Z TRACE quiche_server] got packet Handshake version=1 dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea scid=2fbc14ad5007ed81 [2025-04-30T09:48:02.568775568Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Handshake version=1 dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea scid=2fbc14ad5007ed81 len=65 pn=0 [2025-04-30T09:48:02.568786899Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=159 blocks=[1..1] ecn_counts=None [2025-04-30T09:48:02.568793421Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 1 [2025-04-30T09:48:02.568799793Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm CRYPTO off=0 len=36 [2025-04-30T09:48:02.568811675Z TRACE quiche::tls] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea set read secret lvl=OneRTT [2025-04-30T09:48:02.568833546Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea dropped epoch 1 state [2025-04-30T09:48:02.568838485Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("P-256") sigalg=None resumed=true 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(2fbc14ad5007ed81), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T09:48:02.568880574Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea dropped epoch 0 state [2025-04-30T09:48:02.568884802Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=290 pn=9 [2025-04-30T09:48:02.568890863Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=0 blocks=[2..11] ecn_counts=None [2025-04-30T09:48:02.568894660Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 2 [2025-04-30T09:48:02.568899459Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 3 [2025-04-30T09:48:02.568902785Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 4 [2025-04-30T09:48:02.568905620Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 5 [2025-04-30T09:48:02.568908766Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 6 [2025-04-30T09:48:02.568911511Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 7 [2025-04-30T09:48:02.568914236Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 8 [2025-04-30T09:48:02.568916921Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 9 [2025-04-30T09:48:02.568919847Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 10 [2025-04-30T09:48:02.568922642Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 11 [2025-04-30T09:48:02.568928243Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[34, f7, c8, 74, f8, 8d, fb, 39] reset_token=[dc, 85, 46, 78, 86, 9e, 38, cb, ff, d7, a6, 5e, 30, f8, cb, d6] [2025-04-30T09:48:02.568936127Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[05, 7b, 56, 5b, 1e, 95, 63, ae] reset_token=[e9, 82, 67, fb, 03, 74, 3f, d4, d9, ae, fe, f8, 7c, 06, 8c, 75] [2025-04-30T09:48:02.568942128Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[19, bd, 08, a1, e8, b0, 9f, 6e] reset_token=[e7, f5, 70, fd, 1d, 96, bf, 80, d5, c6, bd, d9, 50, ca, f6, 97] [2025-04-30T09:48:02.568947669Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[68, 12, 25, 67, 48, f9, 3a, c0] reset_token=[f5, e7, 35, 76, 95, 51, e8, 24, e8, 1e, d3, 5a, 4c, da, 67, 36] [2025-04-30T09:48:02.568953209Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[0a, 90, 16, e3, fb, 7b, b4, 37] reset_token=[df, f1, e7, 90, 14, 8f, 1e, 68, 81, 73, 60, 29, 73, 9f, 0d, f7] [2025-04-30T09:48:02.568958529Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[c7, 69, 85, 9e, d4, db, 16, ef] reset_token=[5f, 63, 9b, 1e, 66, 33, 51, dd, 33, 07, 71, 3d, 76, 4d, 11, bf] [2025-04-30T09:48:02.568963969Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[66, 63, a4, 3c, 59, 99, 77, ab] reset_token=[0a, e9, d2, f4, d1, 32, 72, 25, f1, 8c, 74, 89, de, 2d, ba, 24] [2025-04-30T09:48:02.568969159Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=72 [2025-04-30T09:48:02.568998874Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 413 bytes [2025-04-30T09:48:02.569010035Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.569018260Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=true hs_sent=false cwnd_avail=11557 out_len=1350 left=1319 [2025-04-30T09:48:02.569023761Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=6 pn=42 [2025-04-30T09:48:02.569027087Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm ACK delay=16 blocks=[3..9] ecn_counts=None [2025-04-30T09:48:02.569030673Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm HANDSHAKE_DONE [2025-04-30T09:48:02.569038749Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=94.828515ms latest_rtt=32.014123ms srtt=33.263685ms min_rtt=32.014123ms rttvar=12.89784ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1975 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1551, delivered_time: Instant { tv_sec: 312, tv_nsec: 355822539 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 41, last_sent_packet: 42, largest_acked: 11, rate_sample: RateSample { delivery_rate: 46378, is_app_limited: true, interval: 33.442195ms, delivered: 1551, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 312, tv_nsec: 322268546 }), send_elapsed: 0ns, ack_elapsed: 33.442195ms, rtt: 33.442195ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 507309, last_update: Instant { tv_sec: 312, tv_nsec: 330272033 }, next_time: Instant { tv_sec: 312, tv_nsec: 330272033 }, 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:48:02.569123687Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 32 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 330272033 } }) [2025-04-30T09:48:02.569134397Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.569142382Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.569147922Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.569152070Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.569228730Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.569235081Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.569242195Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=10 [2025-04-30T09:48:02.569249067Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=13 blocks=[2..18] ecn_counts=None [2025-04-30T09:48:02.569253506Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 12 [2025-04-30T09:48:02.569256541Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 13 [2025-04-30T09:48:02.569259276Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 14 [2025-04-30T09:48:02.569262132Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 15 [2025-04-30T09:48:02.569267301Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 16 [2025-04-30T09:48:02.569270147Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 17 [2025-04-30T09:48:02.569272922Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 18 [2025-04-30T09:48:02.569283421Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=12 [2025-04-30T09:48:02.569325359Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.569330740Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.569334126Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.569336891Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.569776611Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.569780448Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.569784816Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=11 [2025-04-30T09:48:02.569789174Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=10 blocks=[2..22] ecn_counts=None [2025-04-30T09:48:02.569792220Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 19 [2025-04-30T09:48:02.569794734Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 20 [2025-04-30T09:48:02.569796929Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 21 [2025-04-30T09:48:02.569799073Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 22 [2025-04-30T09:48:02.569803190Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=12 [2025-04-30T09:48:02.569814832Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.569818288Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.569820833Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.569822967Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.570559971Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.570565791Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.570569959Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=12 [2025-04-30T09:48:02.570574117Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=7 blocks=[2..24] ecn_counts=None [2025-04-30T09:48:02.570577002Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 23 [2025-04-30T09:48:02.570579467Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 24 [2025-04-30T09:48:02.570582342Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=12 [2025-04-30T09:48:02.570590998Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.570594445Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.570596949Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.570599113Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.570829754Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.570833240Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.570837197Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=13 [2025-04-30T09:48:02.570841265Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=7 blocks=[2..27] ecn_counts=None [2025-04-30T09:48:02.570844070Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 25 [2025-04-30T09:48:02.570850562Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 26 [2025-04-30T09:48:02.570852806Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 27 [2025-04-30T09:48:02.570855632Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=12 [2025-04-30T09:48:02.570865420Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.570868927Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.570873385Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12557 out_len=1350 left=1324 [2025-04-30T09:48:02.570877252Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx pkt Short dcid=2fbc14ad5007ed81 key_phase=false len=4 pn=43 [2025-04-30T09:48:02.570879757Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm MAX_STREAMS type=bidi max=125 [2025-04-30T09:48:02.570882392Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea tx frm PADDING len=1 [2025-04-30T09:48:02.570888172Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea timer=64.191981ms latest_rtt=30.553568ms srtt=32.208919ms min_rtt=30.553568ms rttvar=5.500156ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=973 app_limited=true congestion_recovery_start_time=None Rate { delivered: 2583, delivered_time: Instant { tv_sec: 312, tv_nsec: 357775135 }, first_sent_time: Instant { tv_sec: 312, tv_nsec: 322268546 }, end_of_app_limited: 42, last_sent_packet: 43, largest_acked: 27, rate_sample: RateSample { delivery_rate: 77237, is_app_limited: true, interval: 33.442195ms, delivered: 2583, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 312, tv_nsec: 322268546 }), send_elapsed: 0ns, ack_elapsed: 33.442195ms, rtt: 33.442195ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 523923, last_update: Instant { tv_sec: 312, tv_nsec: 357809430 }, next_time: Instant { tv_sec: 312, tv_nsec: 357809430 }, 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:48:02.570929129Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea written 30 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56501, at: Instant { tv_sec: 312, tv_nsec: 357809430 } }) [2025-04-30T09:48:02.570937144Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.570942604Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.570946812Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.570950548Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.571567238Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.571573881Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.571578960Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=14 [2025-04-30T09:48:02.571583989Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=7 blocks=[2..29] ecn_counts=None [2025-04-30T09:48:02.571587366Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 28 [2025-04-30T09:48:02.571590000Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 29 [2025-04-30T09:48:02.571593186Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=12 [2025-04-30T09:48:02.571603826Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.571612442Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.571615087Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.571617251Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.571858701Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.571862338Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.571866446Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=15 [2025-04-30T09:48:02.571870764Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=8 blocks=[2..32] ecn_counts=None [2025-04-30T09:48:02.571873659Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 30 [2025-04-30T09:48:02.571875993Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 31 [2025-04-30T09:48:02.571878238Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 32 [2025-04-30T09:48:02.571881163Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=12 [2025-04-30T09:48:02.571891863Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.571895300Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.571897814Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.571899978Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.572642753Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.572648513Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.572652681Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=16 [2025-04-30T09:48:02.572656869Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=6 blocks=[2..35] ecn_counts=None [2025-04-30T09:48:02.572659745Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 33 [2025-04-30T09:48:02.572662169Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 34 [2025-04-30T09:48:02.572664363Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 35 [2025-04-30T09:48:02.572667198Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=11 [2025-04-30T09:48:02.572677147Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.572680583Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.572683018Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.572685162Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.573501674Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.573507184Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.573511372Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=17 [2025-04-30T09:48:02.573515580Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=10 blocks=[2..37] ecn_counts=None [2025-04-30T09:48:02.573518515Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 36 [2025-04-30T09:48:02.573520839Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 37 [2025-04-30T09:48:02.573523925Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=11 [2025-04-30T09:48:02.573537180Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.573540767Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.573543301Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.573545485Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.573660239Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.573663776Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.573667954Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=34 pn=18 [2025-04-30T09:48:02.573672181Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=6 blocks=[2..39] ecn_counts=None [2025-04-30T09:48:02.573675057Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 38 [2025-04-30T09:48:02.573677381Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 39 [2025-04-30T09:48:02.573680156Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm PADDING len=11 [2025-04-30T09:48:02.573688311Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 55 bytes [2025-04-30T09:48:02.573691648Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.573694032Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.573696206Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.573842519Z TRACE quiche_server] got 47 bytes from [::ffff:193.167.0.100]:56501 to [::]:443 [2025-04-30T09:48:02.573846045Z TRACE quiche_server] got packet Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false [2025-04-30T09:48:02.573850043Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx pkt Short dcid=3f5c1c44cc6fe7cb1037095906e522c6b4683bea key_phase=false len=26 pn=19 [2025-04-30T09:48:02.573854672Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm ACK delay=7 blocks=[2..41] ecn_counts=None [2025-04-30T09:48:02.573857457Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 40 [2025-04-30T09:48:02.573859731Z TRACE quiche::recovery::congestion::recovery] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea packet newly acked 41 [2025-04-30T09:48:02.573862907Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea rx frm APPLICATION_CLOSE err=0 reason=[] [2025-04-30T09:48:02.573872826Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea processed 47 bytes [2025-04-30T09:48:02.573876302Z TRACE quiche_server] recv() would block [2025-04-30T09:48:02.573878496Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.573880650Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.691051431Z TRACE quiche_server] timed out [2025-04-30T09:48:02.691107686Z TRACE quiche] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea draining timeout expired [2025-04-30T09:48:02.691150566Z TRACE quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea done writing [2025-04-30T09:48:02.691154543Z TRACE quiche_server] Collecting garbage [2025-04-30T09:48:02.691158300Z INFO quiche_server] 3f5c1c44cc6fe7cb1037095906e522c6b4683bea connection collected recv=22 sent=44 lost=0 retrans=0 sent_bytes=3753 recv_bytes=12167 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:56501 validation_state=Validated active=true recv=22 sent=44 lost=0 retrans=0 rtt=31.282123ms min_rtt=Some(30.499057ms) rttvar=1.896081ms cwnd=13500 sent_bytes=3753 recv_bytes=12167 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=104478]