[2025-04-30T10:15:19.313698961Z INFO quiche_server] listening on [::]:443 [2025-04-30T10:15:19.313722796Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T10:15:19.313729228Z TRACE quiche_server] GSO detected: false [2025-04-30T10:15:20.126062700Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:45706 to [::]:443 [2025-04-30T10:15:20.126098306Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:15:20.126105931Z WARN quiche_server] Doing version negotiation [2025-04-30T10:15:20.126204024Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:45706 to [::]:443 [2025-04-30T10:15:20.126210396Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:15:20.126215796Z WARN quiche_server] Doing version negotiation [2025-04-30T10:15:20.126248538Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:45706 to [::]:443 [2025-04-30T10:15:20.126255982Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:15:20.126260219Z WARN quiche_server] Doing version negotiation [2025-04-30T10:15:20.126283443Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.402610323Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:56929 to [::]:443 [2025-04-30T10:15:20.402631703Z TRACE quiche_server] got packet Initial version=1 dcid=f280e39a27cd4bb24bd5bca635e943f521ac scid=403467921ab8c8009d179c341487779eca token= [2025-04-30T10:15:20.402640290Z DEBUG quiche_server] New connection: dcid=f280e39a27cd4bb24bd5bca635e943f521ac scid=4e633b3cc1fed1848c5f266c22b2100bd539a113 [2025-04-30T10:15:20.402808574Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx pkt Initial version=1 dcid=f280e39a27cd4bb24bd5bca635e943f521ac scid=403467921ab8c8009d179c341487779eca token= len=1153 pn=863696426 [2025-04-30T10:15:20.402821819Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm CRYPTO off=0 len=263 [2025-04-30T10:15:20.402872524Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T10:15:20.402877343Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T10:15:20.402959507Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 write message lvl=Initial len=90 [2025-04-30T10:15:20.402984985Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 set write secret lvl=Handshake [2025-04-30T10:15:20.403048243Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 write message lvl=Handshake len=707 [2025-04-30T10:15:20.403051329Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 set write secret lvl=OneRTT [2025-04-30T10:15:20.403057500Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 set read secret lvl=Handshake [2025-04-30T10:15:20.403075654Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm PADDING len=866 [2025-04-30T10:15:20.403095903Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 processed 1200 bytes [2025-04-30T10:15:20.403111672Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.403123554Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx pkt Initial version=1 dcid=403467921ab8c8009d179c341487779eca scid=4e633b3cc1fed1848c5f266c22b2100bd539a113 len=102 pn=0 [2025-04-30T10:15:20.403126910Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm ACK delay=41 blocks=[863696426..863696426] ecn_counts=None [2025-04-30T10:15:20.403131469Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm CRYPTO off=0 len=90 [2025-04-30T10:15:20.403140626Z TRACE quiche::recovery::congestion::recovery] 4e633b3cc1fed1848c5f266c22b2100bd539a113 timer=998.972769ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=166 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 628267939 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 628267939 }, 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: 410, tv_nsec: 628267939 }, next_time: Instant { tv_sec: 410, tv_nsec: 628267939 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.403169060Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx pkt Handshake version=1 dcid=403467921ab8c8009d179c341487779eca scid=4e633b3cc1fed1848c5f266c22b2100bd539a113 len=711 pn=1 [2025-04-30T10:15:20.403171955Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm CRYPTO off=0 len=707 [2025-04-30T10:15:20.403177415Z TRACE quiche::recovery::congestion::recovery] 4e633b3cc1fed1848c5f266c22b2100bd539a113 timer=998.936371ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=940 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 628267939 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 628267939 }, 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: 410, tv_nsec: 628267939 }, next_time: Instant { tv_sec: 410, tv_nsec: 628267939 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.403221237Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56929, at: Instant { tv_sec: 410, tv_nsec: 628267939 } }) [2025-04-30T10:15:20.403227329Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.403232979Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.403238399Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.403241906Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.437291656Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:56929 to [::]:443 [2025-04-30T10:15:20.437305953Z TRACE quiche_server] got packet Initial version=1 dcid=4e633b3cc1fed1848c5f266c22b2100bd539a113 scid=403467921ab8c8009d179c341487779eca token= [2025-04-30T10:15:20.437315621Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx pkt Initial version=1 dcid=4e633b3cc1fed1848c5f266c22b2100bd539a113 scid=403467921ab8c8009d179c341487779eca token= len=22 pn=863696427 [2025-04-30T10:15:20.437323466Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm ACK delay=0 blocks=[0..0] ecn_counts=None [2025-04-30T10:15:20.437328556Z TRACE quiche::recovery::congestion::recovery] 4e633b3cc1fed1848c5f266c22b2100bd539a113 packet newly acked 0 [2025-04-30T10:15:20.437346319Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx pkt Handshake version=1 dcid=4e633b3cc1fed1848c5f266c22b2100bd539a113 scid=403467921ab8c8009d179c341487779eca len=64 pn=863696426 [2025-04-30T10:15:20.437352160Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm ACK delay=0 blocks=[1..1] ecn_counts=None [2025-04-30T10:15:20.437355526Z TRACE quiche::recovery::congestion::recovery] 4e633b3cc1fed1848c5f266c22b2100bd539a113 packet newly acked 1 [2025-04-30T10:15:20.437366246Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm CRYPTO off=0 len=36 [2025-04-30T10:15:20.437378579Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 set read secret lvl=OneRTT [2025-04-30T10:15:20.437413384Z TRACE quiche::tls] 4e633b3cc1fed1848c5f266c22b2100bd539a113 write message lvl=OneRTT len=444 [2025-04-30T10:15:20.437421429Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 dropped epoch 1 state [2025-04-30T10:15:20.437425497Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 25165824, initial_max_stream_data_bidi_local: 16777216, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 16777216, initial_max_streams_bidi: 0, initial_max_streams_uni: 0, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 7, initial_source_connection_id: Some(403467921ab8c8009d179c341487779eca), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T10:15:20.437446166Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 dropped epoch 0 state [2025-04-30T10:15:20.437449963Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx pkt Short dcid=4e633b3cc1fed1848c5f266c22b2100bd539a113 key_phase=false len=996 pn=863696426 [2025-04-30T10:15:20.437457036Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[5b, 77, a3, bd, c1, 13, 30, 59, 90, 93, 69, 12, a4, 43, 72, 21, ec] reset_token=[c3, de, ee, d5, 6f, f6, d9, 51, 3c, df, c0, f1, 67, 7b, ea, 35] [2025-04-30T10:15:20.437465622Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[c8, ce, 37, 89, 6c, 68, 52, 8c, 9a, f1, 96, b2, 32, 65, 22, 6b, 5a] reset_token=[09, 74, 4e, 45, 57, 9b, 96, 9a, e0, fa, a5, f2, 5c, 2b, 58, c7] [2025-04-30T10:15:20.437472104Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[06, e8, 38, e1, 4e, fd, b0, 1e, b8, c2, c1, 50, cc, fb, 79, e4, ae] reset_token=[f2, ae, 3b, ae, 54, 83, d9, bd, aa, 81, 4c, 39, 3a, 10, 82, 13] [2025-04-30T10:15:20.437478897Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[09, fe, ae, 9a, 5f, 8a, cf, 65, c3, e6, 9d, db, 8f, a3, ff, bc, a6] reset_token=[d7, 17, 8b, 3e, cc, 53, 60, d3, 9d, ab, 96, 4f, ea, c9, 6e, 47] [2025-04-30T10:15:20.437485530Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[74, da, b0, 2e, 45, 31, 91, 6d, 48, b8, 5f, 8d, 74, ef, f2, 5f, a7] reset_token=[1a, f6, 33, 8b, 7a, d1, 77, ce, a1, 17, 12, 74, dd, 46, 08, a4] [2025-04-30T10:15:20.437491881Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[67, b8, fa, 95, 57, 7e, 99, 5a, ad, 2e, f4, ec, b2, ca, b8, 1d, 88] reset_token=[39, 2f, 1f, 8d, 13, a9, dc, 27, ff, 6f, ad, 08, 36, 90, 5d, d9] [2025-04-30T10:15:20.437498233Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[52, 83, 05, 03, 8b, 69, 90, 08, 21, 44, 02, a9, 62, 43, f6, 8b, a7] reset_token=[dd, ce, 39, 4e, 1a, 37, 71, 42, 88, 17, 8a, 57, 18, 92, df, 57] [2025-04-30T10:15:20.437503653Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm STREAM id=0 off=0 len=257 fin=true [2025-04-30T10:15:20.437510486Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm PADDING len=456 [2025-04-30T10:15:20.437521206Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 processed 1200 bytes [2025-04-30T10:15:20.437531185Z DEBUG quiche_apps::common] 4e633b3cc1fed1848c5f266c22b2100bd539a113 response stream 0 is writable with capacity Ok(13500) [2025-04-30T10:15:20.437543338Z TRACE quiche_apps::common] 4e633b3cc1fed1848c5f266c22b2100bd539a113 received 257 bytes [2025-04-30T10:15:20.437546594Z TRACE quiche_apps::common] 4e633b3cc1fed1848c5f266c22b2100bd539a113 stream 0 has 257 bytes (fin? true) [2025-04-30T10:15:20.437551904Z INFO quiche_apps::common] 4e633b3cc1fed1848c5f266c22b2100bd539a113 got GET request for "/www/nvtgcqrsjacvvzahskljywlwufzsmgzljuotgwxdbxbdkgtzdepyaqcdffgmryoyxnjvzmkospfgchlnxbhkuqqsswzxzlozexwplxxegrveflynhotcllhnhsqkyintyfxkzhztbbfgnzrozndglmmlrbtaueuroikcbuubqnypjwieywcukumqcvxlxayoyggqrrvmaqrpiinnguhrzwtaivmdbwdgvsquhdvcafceskzblrqflaaakd" on stream 0 [2025-04-30T10:15:20.437578924Z INFO quiche_apps::common] 4e633b3cc1fed1848c5f266c22b2100bd539a113 sending response of size 32 on stream 0 [2025-04-30T10:15:20.437587080Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.437595004Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307 [2025-04-30T10:15:20.437604252Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx pkt Short dcid=403467921ab8c8009d179c341487779eca key_phase=false len=734 pn=2 [2025-04-30T10:15:20.437607939Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm ACK delay=18 blocks=[863696426..863696426] ecn_counts=None [2025-04-30T10:15:20.437611826Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[14, db, 33, 8e, 94, ae, a5, 18, b1, 42, 7e, d6, f2, 32, 17, 3f, ad, 55, 66, e7] reset_token=[34, 19, fb, 7a, 64, af, 89, eb, 15, e1, 65, 9b, a0, 24, 20, 7a] [2025-04-30T10:15:20.437618338Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[36, fc, 50, d1, 89, 75, 5c, 4b, 99, 46, 19, 30, 38, 61, 4e, 9f, 39, 6a, be, 3a] reset_token=[51, 2a, a1, 41, 3a, 3b, cc, 8a, 8a, f4, b7, fe, 05, b2, e1, d2] [2025-04-30T10:15:20.437624490Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[0c, 27, 24, b0, 50, 80, 72, 85, 29, 0e, fb, 5b, cd, de, 12, e7, b4, 21, 24, 48] reset_token=[ac, 4c, 62, 7e, c2, 91, 48, 82, d5, 84, 89, 65, fa, 29, 1e, 89] [2025-04-30T10:15:20.437630601Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[d0, 13, 38, 37, 7f, 27, 75, 23, 78, 3b, b6, bf, d8, 57, 5d, 5a, 8b, b3, ec, 78] reset_token=[79, 5d, e2, ff, 59, 37, a2, a1, c8, 83, e9, 33, a7, 34, a0, 24] [2025-04-30T10:15:20.437636652Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[de, 48, 8a, 7c, 4a, d0, 7f, 04, 01, be, ca, b2, 49, 40, a9, fd, c6, f1, bf, 6a] reset_token=[4f, 8d, 32, db, d8, 58, aa, 35, ed, dd, f4, 0d, ee, 91, 29, 07] [2025-04-30T10:15:20.437643034Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[77, 47, db, d8, 86, c5, bf, ae, 92, dd, f0, 98, bd, 63, dd, f8, 55, 22, 45, a2] reset_token=[e2, a1, 94, 04, 6c, 45, f1, 29, c0, e6, 93, eb, 7a, 61, 5e, b1] [2025-04-30T10:15:20.437649296Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm HANDSHAKE_DONE [2025-04-30T10:15:20.437652091Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm CRYPTO off=0 len=444 [2025-04-30T10:15:20.437655007Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 tx frm STREAM id=0 off=0 len=32 fin=true [2025-04-30T10:15:20.437668542Z TRACE quiche::recovery::congestion::recovery] 4e633b3cc1fed1848c5f266c22b2100bd539a113 timer=110.455667ms latest_rtt=34.231651ms srtt=34.203449ms min_rtt=34.199421ms rttvar=12.832839ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=769 app_limited=true congestion_recovery_start_time=None Rate { delivered: 940, delivered_time: Instant { tv_sec: 410, tv_nsec: 662743837 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 662743837 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27485, is_app_limited: true, interval: 34.199421ms, delivered: 940, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 410, tv_nsec: 628267939 }), send_elapsed: 0ns, ack_elapsed: 34.199421ms, rtt: 34.199421ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 493371, last_update: Instant { tv_sec: 410, tv_nsec: 662743837 }, next_time: Instant { tv_sec: 410, tv_nsec: 662743837 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.437725058Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 written 769 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:56929, at: Instant { tv_sec: 410, tv_nsec: 662743837 } }) [2025-04-30T10:15:20.437731751Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.437738483Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.437744604Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.437749083Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.469424150Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:56929 to [::]:443 [2025-04-30T10:15:20.469443206Z TRACE quiche_server] got packet Short dcid=4e633b3cc1fed1848c5f266c22b2100bd539a113 key_phase=false [2025-04-30T10:15:20.469454617Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx pkt Short dcid=4e633b3cc1fed1848c5f266c22b2100bd539a113 key_phase=false len=21 pn=863696427 [2025-04-30T10:15:20.469464846Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[] [2025-04-30T10:15:20.469479975Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 processed 42 bytes [2025-04-30T10:15:20.469485976Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.469488621Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.469491115Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.547506903Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.547529756Z TRACE quiche_server] got packet Initial version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 token= [2025-04-30T10:15:20.547540175Z DEBUG quiche_server] New connection: dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=cf84eada515af6d9158a570d79e72e0b7cad06c7 [2025-04-30T10:15:20.547678895Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Initial version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 token= len=530 pn=2011563900 [2025-04-30T10:15:20.547693262Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm CRYPTO off=0 len=506 [2025-04-30T10:15:20.547721234Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T10:15:20.547725733Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T10:15:20.547890371Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 write message lvl=Initial len=96 [2025-04-30T10:15:20.547910479Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 set write secret lvl=Handshake [2025-04-30T10:15:20.547940194Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 write message lvl=Handshake len=162 [2025-04-30T10:15:20.547943330Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 set write secret lvl=OneRTT [2025-04-30T10:15:20.547971062Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 write message lvl=OneRTT len=444 [2025-04-30T10:15:20.547974969Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 set read secret lvl=ZeroRTT [2025-04-30T10:15:20.547989156Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 set read secret lvl=Handshake [2025-04-30T10:15:20.548018030Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=577 pn=2011563900 [2025-04-30T10:15:20.548025755Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=0 off=0 len=257 fin=true [2025-04-30T10:15:20.548031225Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=4 off=0 len=257 fin=true [2025-04-30T10:15:20.548034882Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=8 off=0 len=32 fin=false [2025-04-30T10:15:20.548044079Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.548048838Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 0 is writable with capacity Ok(13500) [2025-04-30T10:15:20.548052735Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 4 is writable with capacity Ok(13500) [2025-04-30T10:15:20.548055591Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 8 is writable with capacity Ok(13500) [2025-04-30T10:15:20.548061942Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.548065068Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 0 has 257 bytes (fin? true) [2025-04-30T10:15:20.548070268Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/msxcksjwtdcontiauhwdmqrxcjzzannihnofxyayjtxbpezftlenfobxkegxfzyurczqpnedlgmahyxukbmxiaobsrbnnmevdvzxvryirupzpmbrpxufhjzjqvvdpefccepfhvndaiwnpnutgactyqikxembvnmmwzbinctbjjurqqhpdmqfydgbhjvfqffiascawiiemiegrfvdvphmbhhpivydaveyrurrnetqinaaakywcagglckpgt" on stream 0 [2025-04-30T10:15:20.548096016Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 0 [2025-04-30T10:15:20.548103470Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.548106355Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 4 has 257 bytes (fin? true) [2025-04-30T10:15:20.548109922Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/qpczriypstcdgujxqrpcxqexpzwxlekxfytdigtzyjacmanfaalxtjoalgcfofqonkptpkafxgefseptjtqpeqfphtdzdikprcptpczcpjpntzgccgjvjtlojppgjbtsybuihmuvfxxgxgknqpnohbttwrnpmecuszldbvzzqueojwwvtgettkaykzjohpjssnxwosedzbdgyalccbsilnketjyknncrunryumsjgkbstcqalqtrujinna" on stream 4 [2025-04-30T10:15:20.548127295Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 4 [2025-04-30T10:15:20.548132835Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 32 bytes [2025-04-30T10:15:20.548135710Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 8 has 32 bytes (fin? false) [2025-04-30T10:15:20.548153704Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.548157161Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.548171848Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Initial version=1 dcid=e9d35722637a9ad4dc9726e98d9c7083d8 scid=cf84eada515af6d9158a570d79e72e0b7cad06c7 len=112 pn=0 [2025-04-30T10:15:20.548175625Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=63 blocks=[2011563900..2011563900] ecn_counts=None [2025-04-30T10:15:20.548180605Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm CRYPTO off=0 len=96 [2025-04-30T10:15:20.548191755Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.967449ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=176 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773313948 }, next_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548216692Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Handshake version=1 dcid=e9d35722637a9ad4dc9726e98d9c7083d8 scid=cf84eada515af6d9158a570d79e72e0b7cad06c7 len=166 pn=1 [2025-04-30T10:15:20.548219457Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm CRYPTO off=0 len=162 [2025-04-30T10:15:20.548224717Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.935028ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=405 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773313948 }, next_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548234916Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=13095 out_len=795 left=748 [2025-04-30T10:15:20.548242460Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=760 pn=2 [2025-04-30T10:15:20.548245155Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=27 blocks=[2011563900..2011563900] ecn_counts=None [2025-04-30T10:15:20.548248011Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[f8, 27, 7f, 72, b7, 96, a3, 38, 1a, 1b, e2, e5, fe, 67, 14, 04, 9c, 3e, a7, 01] reset_token=[f1, 17, 88, 9a, 74, 7a, 8f, 00, 72, 0a, b8, 51, 58, 69, 6c, c4] [2025-04-30T10:15:20.548254663Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[27, a3, 61, 10, e2, d5, 57, ae, f2, 7f, 5a, 8d, 77, 69, 6c, d6, bf, 3b, 46, f3] reset_token=[22, a0, 8f, 73, 93, e2, 5c, 2e, 17, 4c, 06, 48, 3b, 88, b6, 54] [2025-04-30T10:15:20.548260023Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[16, 75, fc, 08, 11, 6a, fe, ac, ee, 21, ab, 4d, af, 7b, 2d, 96, b7, db, cc, ba] reset_token=[d3, ec, 01, e6, be, d3, 20, fd, 49, 53, f8, 86, bf, ab, 13, 27] [2025-04-30T10:15:20.548265263Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[26, 69, a8, b2, fa, df, 89, 37, b9, 05, 29, 72, 4d, fa, 27, 9a, ae, 53, 13, 3b] reset_token=[2b, d0, d0, ba, d8, bd, aa, 0c, 32, a5, d0, 2a, 5c, 0b, 84, 61] [2025-04-30T10:15:20.548273418Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[b6, 48, 69, 2c, 95, 2f, 27, 0a, e3, 35, 75, d3, 0d, c8, 84, 2e, 8c, 2a, 98, c3] reset_token=[f9, 25, a3, aa, f7, 87, c3, a5, 68, 54, d4, 2b, f2, 10, d9, 9a] [2025-04-30T10:15:20.548278538Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[be, 08, 35, 78, 21, 74, 02, 13, b6, 06, 54, 41, b5, a0, 33, a9, a7, ab, ac, 9d] reset_token=[cd, d9, 4a, 6d, 99, a6, 35, 94, f7, ab, 7e, 15, d5, 20, 0d, 5b] [2025-04-30T10:15:20.548283637Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm CRYPTO off=0 len=444 [2025-04-30T10:15:20.548285942Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=0 off=0 len=32 fin=true [2025-04-30T10:15:20.548288406Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm PADDING len=23 [2025-04-30T10:15:20.548297764Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.862011ms 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: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773313948 }, next_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548308684Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12300 out_len=1200 left=1165 [2025-04-30T10:15:20.548311850Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=3 [2025-04-30T10:15:20.548314265Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=4 off=0 len=32 fin=true [2025-04-30T10:15:20.548318543Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.841283ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1272 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773460082 }, next_time: Instant { tv_sec: 410, tv_nsec: 773460082 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548374417Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 1272 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 773313948 } }) [2025-04-30T10:15:20.548389916Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548394104Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548400366Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.548404384Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.548409934Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.548414002Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548417268Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548451962Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.548459847Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.548469125Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563901 [2025-04-30T10:15:20.548478663Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=8 off=32 len=225 fin=true [2025-04-30T10:15:20.548484313Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=12 off=0 len=257 fin=true [2025-04-30T10:15:20.548490955Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=16 off=0 len=257 fin=true [2025-04-30T10:15:20.548494873Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=20 off=0 len=257 fin=true [2025-04-30T10:15:20.548498169Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=24 off=0 len=117 fin=false [2025-04-30T10:15:20.548508599Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.548511444Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 8 is writable with capacity Ok(12228) [2025-04-30T10:15:20.548514099Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 12 is writable with capacity Ok(12228) [2025-04-30T10:15:20.548516403Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 16 is writable with capacity Ok(12228) [2025-04-30T10:15:20.548518607Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 20 is writable with capacity Ok(12228) [2025-04-30T10:15:20.548520851Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 24 is writable with capacity Ok(12228) [2025-04-30T10:15:20.548525090Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 225 bytes [2025-04-30T10:15:20.548527374Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 8 has 225 bytes (fin? true) [2025-04-30T10:15:20.548531311Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/eiervgfuoietkxrkzhhhyhxubylueskyhnotjqegskqkzidifwkmydobdsmwaapxxzrbtsbcraxlbemfxzppmeydiiddrxifgjyqcpxrnhdhmvkasyblwflysdwjlqotlczisyltziyqwroeitetcteceeqvxwfqrlkltnkaahnrvsfhixvpobkpwjollivsjinfskowmzfuowcirlprybajrtnoohcjtgnbfdvadzkwsxcarrakuzrlew" on stream 8 [2025-04-30T10:15:20.548551098Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 8 [2025-04-30T10:15:20.548556428Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.548558793Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 12 has 257 bytes (fin? true) [2025-04-30T10:15:20.548561678Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/keodouwgxsherjvypygjvxikrkvwmzcucxeegnzoqcbfycsqmiotmcjfxiynqbzftgujgbpthaywnnzxcurmcbzmtjidhskorcisnikustxpzhyirllpeoxaagxbsjtgnnftnxcegvwdwmfsjhocnjylweyqztafwzfshdmstqtussjbvgarfgpdmiijeicfyadtsfapzjxhpxbhkeeloixxztnutimdfytcmxsyqquaagcohfwyqgeurx" on stream 12 [2025-04-30T10:15:20.548580984Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 12 [2025-04-30T10:15:20.548585472Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.548587747Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 16 has 257 bytes (fin? true) [2025-04-30T10:15:20.548590502Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/fcyoibuzmekbtrjkbdssanbainwohlmwvgjmtgrcehqqyxunzqxgtiqbajcoeenxvmyzgwchjohgifskefocwqwwubtcadfzmyenztmhkatsvhtnvweqnjtliypjtzdsdgyjqvsrcnfaslimlwairghksjoqzajcyjezpnjuwlmjyybxtdygvjngievgztyytglljcxjmaumtzprvoekdfvlficmuuqctkjwnsutnsybpntzdoctdjkffe" on stream 16 [2025-04-30T10:15:20.548603666Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 16 [2025-04-30T10:15:20.548608145Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.548610419Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 20 has 257 bytes (fin? true) [2025-04-30T10:15:20.548613215Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/mkslcmknsntqydvciucxliqdrgkfkyubnlgzawmwmtvpdysqcqktaibcdokubyovtrcskiqydyemeenmobspchlifpfvbejmwgoyzvdbxcdeqzodsjtozlkfwxvzyvmtfwcowtgkojlpbzskmwjqkokugaovhgwgmpzxcbkksoriiapqqaswnsvjsazduvsvxqbzkgkwduntfpdiymjfrqjsnbaeehhrlrilcyjszmdybzuujgnrgmgdtq" on stream 20 [2025-04-30T10:15:20.548626189Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 20 [2025-04-30T10:15:20.548630717Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 117 bytes [2025-04-30T10:15:20.548633001Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 24 has 117 bytes (fin? false) [2025-04-30T10:15:20.548637219Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.548639654Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.548646497Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12228 out_len=1200 left=1153 [2025-04-30T10:15:20.548650705Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=49 pn=4 [2025-04-30T10:15:20.548653290Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=22 blocks=[2011563900..2011563901] ecn_counts=None [2025-04-30T10:15:20.548656496Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=8 off=0 len=32 fin=true [2025-04-30T10:15:20.548663509Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.496197ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1356 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773795700 }, next_time: Instant { tv_sec: 410, tv_nsec: 773795700 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548700027Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 84 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 773795700 } }) [2025-04-30T10:15:20.548711679Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548715155Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548721207Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.548724913Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.548733269Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12144 out_len=1200 left=1165 [2025-04-30T10:15:20.548739381Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=5 [2025-04-30T10:15:20.548743829Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=12 off=0 len=32 fin=true [2025-04-30T10:15:20.548771380Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.388084ms 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: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773882162 }, next_time: Instant { tv_sec: 410, tv_nsec: 773882162 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548805645Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 773882162 } }) [2025-04-30T10:15:20.548810504Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548813750Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548819671Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.548823939Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.548832936Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12072 out_len=1200 left=1165 [2025-04-30T10:15:20.548839167Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=6 [2025-04-30T10:15:20.548843526Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=16 off=0 len=32 fin=true [2025-04-30T10:15:20.548870967Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.288568ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1500 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 773981168 }, next_time: Instant { tv_sec: 410, tv_nsec: 773981168 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548911974Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 773981168 } }) [2025-04-30T10:15:20.548916913Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548918987Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.548925349Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.548929086Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.548937632Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=12000 out_len=1200 left=1165 [2025-04-30T10:15:20.548944034Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=7 [2025-04-30T10:15:20.548948462Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=20 off=0 len=32 fin=true [2025-04-30T10:15:20.548958401Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=998.200984ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1572 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 774086354 }, next_time: Instant { tv_sec: 410, tv_nsec: 774086354 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.548994268Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 774086354 } }) [2025-04-30T10:15:20.548998886Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549002022Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549007603Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.549011220Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.549016910Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.549020958Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549024444Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549416138Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.549425175Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.549434091Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563902 [2025-04-30T10:15:20.549440463Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=24 off=117 len=140 fin=true [2025-04-30T10:15:20.549449049Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=28 off=0 len=257 fin=true [2025-04-30T10:15:20.549453297Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=32 off=0 len=257 fin=true [2025-04-30T10:15:20.549456253Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=36 off=0 len=257 fin=true [2025-04-30T10:15:20.549459188Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=40 off=0 len=201 fin=false [2025-04-30T10:15:20.549469939Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.549472804Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 24 is writable with capacity Ok(11928) [2025-04-30T10:15:20.549475469Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 28 is writable with capacity Ok(11928) [2025-04-30T10:15:20.549477733Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 32 is writable with capacity Ok(11928) [2025-04-30T10:15:20.549479947Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 36 is writable with capacity Ok(11928) [2025-04-30T10:15:20.549482141Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 40 is writable with capacity Ok(11928) [2025-04-30T10:15:20.549487752Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 140 bytes [2025-04-30T10:15:20.549492110Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 24 has 140 bytes (fin? true) [2025-04-30T10:15:20.549498281Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/xskpvukwotiymvwdeoqcwbcavnopewgrpmncoxwwscksmwzezkonzwcyqbpyqeilkeyyniopcxwfrbhzzuudzimgwcsswwqrnrxfntfxwginmbfgscajflkapajgsxebcwzfebicqbahjrdpwxuqzgvrpabxkcbjnkfhhymgszfkgoyolxbwlgabsbhjthctgzcrgdimhtymsleotiyrjspnvwdpbgxzkhkxqyiedgxiydtyapjzsdirul" on stream 24 [2025-04-30T10:15:20.549526545Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 24 [2025-04-30T10:15:20.549533758Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.549536132Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 28 has 257 bytes (fin? true) [2025-04-30T10:15:20.549539148Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/gnszjdgirhyowoocgbyapgzfflhpktgiezmljxyqsrycksqluwjettojjoppqdqzyrebjhdtesqtoivitabidakzplvxulbjxqawoplhjlhwqmukgxifuesztuefnyqjqaeawttkaabsbbegfpblrhmqtufnrlchooywetrinbvzpzrjidhzflmztwygrvzglgdtmkthqxkvhlwtnejwbkoipsmevjjjpahiyubcqqqubogkvhkduslaom" on stream 28 [2025-04-30T10:15:20.549553725Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 28 [2025-04-30T10:15:20.549558284Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.549560568Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 32 has 257 bytes (fin? true) [2025-04-30T10:15:20.549563263Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/khtnafvdihsvahcfndqqmzhbijditiygywnvestdvymkcqlpldtlgbcxpxpwmwjgkabhsbyzrylxnpuwmwqmyrogdaysbxkddegamupnyovbxymedmheszrldmxjypmvlijdnvcqyqthwevzrivlgpodakzmqcqdhdkqtwfyrkqotfxhjenlcirwpvygtajvdhmjmwkskajecqxrulvoqukuhlffjlsndybrvusbpjrpouzyvhgotjswqw" on stream 32 [2025-04-30T10:15:20.549577630Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 32 [2025-04-30T10:15:20.549585324Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.549589392Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 36 has 257 bytes (fin? true) [2025-04-30T10:15:20.549594021Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/cvvrsrmwnbmrxigujwulshfyjsucqdhzhcvlysjlbqmargwwkxchfetyurufmbpzzvshtrqyfjemkhgekxtoxkdxczpoytmzjqyspzjyybnmchkbevzblzkpbhwxzxfmazzfidgybkjbxsbfjdvzcuhwagtcyynvqpcpmdkfjhcmbpajbftgifcxdambyagyjvyutkjnfbpmernvixxhfajjtqkkcadmgqsterlfqwtxjnojgwzbffaxsm" on stream 36 [2025-04-30T10:15:20.549622003Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 36 [2025-04-30T10:15:20.549628556Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 201 bytes [2025-04-30T10:15:20.549630880Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 40 has 201 bytes (fin? false) [2025-04-30T10:15:20.549635288Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.549637803Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.549644766Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11928 out_len=1200 left=1153 [2025-04-30T10:15:20.549649184Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=49 pn=8 [2025-04-30T10:15:20.549651749Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=26 blocks=[2011563900..2011563902] ecn_counts=None [2025-04-30T10:15:20.549655065Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=24 off=0 len=32 fin=true [2025-04-30T10:15:20.549664934Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=997.494371ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1656 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 774793789 }, next_time: Instant { tv_sec: 410, tv_nsec: 774793789 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.549713955Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 84 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 774793789 } }) [2025-04-30T10:15:20.549721279Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549724736Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549730296Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.549734323Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.549743000Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11844 out_len=1200 left=1165 [2025-04-30T10:15:20.549749582Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=9 [2025-04-30T10:15:20.549754010Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=28 off=0 len=32 fin=true [2025-04-30T10:15:20.549764340Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=997.395095ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1728 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 774891702 }, next_time: Instant { tv_sec: 410, tv_nsec: 774891702 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.549806318Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 774891702 } }) [2025-04-30T10:15:20.549811278Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549815165Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549821447Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.549825254Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.549833980Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11772 out_len=1200 left=1165 [2025-04-30T10:15:20.549840302Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=10 [2025-04-30T10:15:20.549844670Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=32 off=0 len=32 fin=true [2025-04-30T10:15:20.549883753Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=997.27475ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 774982683 }, next_time: Instant { tv_sec: 410, tv_nsec: 774982683 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.549925521Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 774982683 } }) [2025-04-30T10:15:20.549930651Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549933937Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.549940239Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.549943686Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.549952542Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11700 out_len=1200 left=1165 [2025-04-30T10:15:20.549958944Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=11 [2025-04-30T10:15:20.549963182Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=36 off=0 len=32 fin=true [2025-04-30T10:15:20.549979954Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=997.179201ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1872 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 775101044 }, next_time: Instant { tv_sec: 410, tv_nsec: 775101044 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.550018556Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 775101044 } }) [2025-04-30T10:15:20.550023385Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550026971Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550033403Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.550037090Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.550042821Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.550046728Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550050365Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550396473Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.550404789Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.550410870Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563903 [2025-04-30T10:15:20.550417042Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=40 off=201 len=56 fin=true [2025-04-30T10:15:20.550420679Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=44 off=0 len=257 fin=true [2025-04-30T10:15:20.550424065Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=48 off=0 len=257 fin=true [2025-04-30T10:15:20.550426940Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=52 off=0 len=257 fin=true [2025-04-30T10:15:20.550430337Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=56 off=0 len=257 fin=true [2025-04-30T10:15:20.550434805Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=60 off=0 len=26 fin=false [2025-04-30T10:15:20.550445365Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.550448210Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 40 is writable with capacity Ok(11628) [2025-04-30T10:15:20.550450735Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 44 is writable with capacity Ok(11628) [2025-04-30T10:15:20.550452969Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 48 is writable with capacity Ok(11628) [2025-04-30T10:15:20.550455183Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 52 is writable with capacity Ok(11628) [2025-04-30T10:15:20.550462266Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 56 is writable with capacity Ok(11628) [2025-04-30T10:15:20.550464611Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 60 is writable with capacity Ok(11628) [2025-04-30T10:15:20.550469049Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 56 bytes [2025-04-30T10:15:20.550471343Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 40 has 56 bytes (fin? true) [2025-04-30T10:15:20.550475191Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/ywvuapoqiwpffoawnrkzhvsidvauqvakzssfjxzxvkkekiqszsvocouxscvkfrycgxgrhyrmaziptblyfbngmxibkjlownytcngdziaaytigypaxxvpcfpotlyhxvbdrowhnvtkjfyblqfnzuofsjjwhsgxhjoylewtcsjnofdvppulqllhjnogfjgisrsxyvwjkhkuztqvxngycdoizqadyysbblmsrbkaaogcaumchgaqfuqrzmvagry" on stream 40 [2025-04-30T10:15:20.550494346Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 40 [2025-04-30T10:15:20.550499656Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.550501941Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 44 has 257 bytes (fin? true) [2025-04-30T10:15:20.550504706Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/fnraseziexsoxeamksyvlvhqpikdbkqfmriwalfgaecujekjyyaedrwciiujbcjzdinjwyxccccvqcwtfmbshfjwujaibmnzwcgdbwofhltfenwvpllcdtserjyfssczwivlinszjqjxoiyfkzjyiwdmrrcabshyujkhlwhpuxeikklvrlnegtavoghanvnwrmkgvuwuflhuagtyfjynrprvadnpebgkrjisriumojqttmkocmitdeqftn" on stream 44 [2025-04-30T10:15:20.550518131Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 44 [2025-04-30T10:15:20.550522439Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.550524703Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 48 has 257 bytes (fin? true) [2025-04-30T10:15:20.550527318Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/ksngoqcigardrsqeqzrxhchigueezbhyojifsuexadsnsnrbyogyeunhcmjsolsabvfgoszfzcgkhubvuaprkinznmqiphxyqdrrloydjifgcaistcbjfwpllcrpasrhemsdjdamyezofgrfydjpqpvtnbzgceogzwoehyhicszmxdykmnbeffhapsavgxamljyqqdnaciygiyflsumsxfuxyixfslelvbyeefeqbbujejkygkwuurably" on stream 48 [2025-04-30T10:15:20.550544420Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 48 [2025-04-30T10:15:20.550548808Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.550551073Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 52 has 257 bytes (fin? true) [2025-04-30T10:15:20.550553778Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/sitrusyqhwvjzmqvdlkocjtpudbuveieuttwehpwixvyfrdpkrjbqchrzaqakqyezedzzucgtjrxprqbslcrmpiozxvvwqspdfmrzolytdhftprgofpctweipwvznaakkrrdphlvvriibnztzxezceosseqvmjkosddamqkrtgctktxmeciqjmqvfikgadtocwbmngananuwzzjatqlbdydgsnzjnmkppfmjzonngpinjbrssdpbufqbqo" on stream 52 [2025-04-30T10:15:20.550566882Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 52 [2025-04-30T10:15:20.550571180Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.550573425Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 56 has 257 bytes (fin? true) [2025-04-30T10:15:20.550576130Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/qiahgvvdgugxnkvkwaotclmlojpgiicogjwngxsvjrvkuuzrjcemkblotvfvijmxqqkfgzbngevodrxoxodzwudlwcneyjzmmnfpsbmikxqthbbtjhdqbrjuhdxjtjkbmokoyunauykxgrbotpraalbrfooidoclpwifdvpxkoajaeyaofbviddsmxmwmhkrvtseblhagjoalgwafutzvrygloqhvqgsaipjszjvoactbtcglnkdvgpiqx" on stream 56 [2025-04-30T10:15:20.550592711Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 56 [2025-04-30T10:15:20.550597039Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 26 bytes [2025-04-30T10:15:20.550599293Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 60 has 26 bytes (fin? false) [2025-04-30T10:15:20.550603381Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.550605775Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.550612237Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11628 out_len=1200 left=1153 [2025-04-30T10:15:20.550616455Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=49 pn=12 [2025-04-30T10:15:20.550619030Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=25 blocks=[2011563900..2011563903] ecn_counts=None [2025-04-30T10:15:20.550622206Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=40 off=0 len=32 fin=true [2025-04-30T10:15:20.550628998Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=996.530706ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1956 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 775761661 }, next_time: Instant { tv_sec: 410, tv_nsec: 775761661 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.550664445Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 84 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 775761661 } }) [2025-04-30T10:15:20.550669995Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550673221Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550679243Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.550683070Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.550690804Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11544 out_len=1200 left=1165 [2025-04-30T10:15:20.550696705Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=13 [2025-04-30T10:15:20.550700983Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=44 off=0 len=32 fin=true [2025-04-30T10:15:20.550710591Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=996.448623ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2028 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 775840198 }, next_time: Instant { tv_sec: 410, tv_nsec: 775840198 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.550755976Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 775840198 } }) [2025-04-30T10:15:20.550761877Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550765464Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550771616Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.550775473Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.550784279Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11472 out_len=1200 left=1165 [2025-04-30T10:15:20.550790792Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=14 [2025-04-30T10:15:20.550795109Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=48 off=0 len=32 fin=true [2025-04-30T10:15:20.550805078Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=996.354286ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 775932992 }, next_time: Instant { tv_sec: 410, tv_nsec: 775932992 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.550842138Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 775932992 } }) [2025-04-30T10:15:20.550861324Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550869238Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550875300Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.550878997Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.550887673Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11400 out_len=1200 left=1165 [2025-04-30T10:15:20.550894015Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=15 [2025-04-30T10:15:20.550898403Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=52 off=0 len=32 fin=true [2025-04-30T10:15:20.550908652Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=996.250662ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2172 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 776035975 }, next_time: Instant { tv_sec: 410, tv_nsec: 776035975 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.550950761Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 776035975 } }) [2025-04-30T10:15:20.550956342Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550959698Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.550965589Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.550969276Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.550978443Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11328 out_len=1200 left=1165 [2025-04-30T10:15:20.550984544Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=37 pn=16 [2025-04-30T10:15:20.550988612Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=56 off=0 len=32 fin=true [2025-04-30T10:15:20.550998601Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=996.160493ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2244 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 776126905 }, next_time: Instant { tv_sec: 410, tv_nsec: 776126905 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.551036211Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 72 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 776126905 } }) [2025-04-30T10:15:20.551041942Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551045799Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551051349Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.551055187Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.551060807Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.551064624Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551068211Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551381006Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.551388701Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.551394702Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563904 [2025-04-30T10:15:20.551400874Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=60 off=26 len=231 fin=true [2025-04-30T10:15:20.551404350Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=64 off=0 len=257 fin=true [2025-04-30T10:15:20.551407747Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=68 off=0 len=257 fin=true [2025-04-30T10:15:20.551410492Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=72 off=0 len=257 fin=true [2025-04-30T10:15:20.551413758Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=76 off=0 len=107 fin=false [2025-04-30T10:15:20.551436380Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.551439376Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 60 is writable with capacity Ok(11256) [2025-04-30T10:15:20.551441961Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 64 is writable with capacity Ok(11256) [2025-04-30T10:15:20.551444185Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 68 is writable with capacity Ok(11256) [2025-04-30T10:15:20.551446489Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 72 is writable with capacity Ok(11256) [2025-04-30T10:15:20.551448703Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 76 is writable with capacity Ok(11256) [2025-04-30T10:15:20.551453072Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 231 bytes [2025-04-30T10:15:20.551455346Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 60 has 231 bytes (fin? true) [2025-04-30T10:15:20.551459193Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/osfgdsvsgrhbejrttccjsnqnlgozxxjaibwrhjrnegcwrslushgbprfydlvuedqnjriftnmmuhmngppebdpdyeqoctikdpxzheptzkxekghzjdjomlxvwpkprypkytiebqlynshmderfzejkmpxiuixmljrijfgcwanurabzadnhllyifvcuossuqfkecewihubfioocinxtbxlohtxwkgcrivczabsglelzwgvyzghlrczctefnntnqpm" on stream 60 [2025-04-30T10:15:20.551478379Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 60 [2025-04-30T10:15:20.551483669Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.551485963Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 64 has 257 bytes (fin? true) [2025-04-30T10:15:20.551488798Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/ekntojeysxjelfggwenvjgypvhzsqqncedxblzitqufueuctvhjvlqucayixmkjampbxsbsjbigdupfhghvqfqebabjvzkekbedygtxbcyjcjgzztwvlrhgmtztvtfglgymomjtgopsqqckxdixudfpcyxyoawakvhlcwxbtatqzsjhoyjcorvzxxfgltbgzipavxaibfnkhhikkgbzkyldnjtshszxclzngueomxyihsbktcpawthlnxa" on stream 64 [2025-04-30T10:15:20.551502344Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 64 [2025-04-30T10:15:20.551506702Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.551508956Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 68 has 257 bytes (fin? true) [2025-04-30T10:15:20.551511591Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/tpmjspgjnagxrshynayslrglasfqkbuxplzkkljwnibfnfcusklawyuweiwuufpjqbczruwspljoxjxddphqbecmjdopjfnhkpltbciaskikwcmconnslawfsbucwfwcgvamnsfewenafpcdtzgqwkyrhysskvqjgqhrohldknjnybvsnutnvovjucwlkxlwxftzrfswgczttxunthtbigmlvyyoeyoynrzoeqqqjxzqqlwagqjprcpuca" on stream 68 [2025-04-30T10:15:20.551527731Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 68 [2025-04-30T10:15:20.551532270Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.551534564Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 72 has 257 bytes (fin? true) [2025-04-30T10:15:20.551537209Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/nvivlwdoldkheolfvuctwhlnemvbbsfxsscbgdhpbcqjfhdzjcjinsmyyjxcnxrtqjnlcxgossrwxyjsqaybsclkvuxonpsskcpndvlpfntvzlkcxoiklowsatrpjojjiqoqdpuqlnjearvmmokqrzfqnkirniwuyxplephcbjiqzswwvdwgptxlninbrusfdvulswvgpgarhrwhsodjwqxtblpwfmuiagsaxsnkmqjwedxsnsvcgprpvu" on stream 72 [2025-04-30T10:15:20.551550033Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 72 [2025-04-30T10:15:20.551554321Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 107 bytes [2025-04-30T10:15:20.551556575Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 76 has 107 bytes (fin? false) [2025-04-30T10:15:20.551560593Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.551562977Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.551569289Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11256 out_len=1200 left=1153 [2025-04-30T10:15:20.551573417Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=49 pn=17 [2025-04-30T10:15:20.551575951Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=21 blocks=[2011563900..2011563904] ecn_counts=None [2025-04-30T10:15:20.551579107Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=60 off=0 len=32 fin=true [2025-04-30T10:15:20.551586121Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=995.573605ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2328 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 776718853 }, next_time: Instant { tv_sec: 410, tv_nsec: 776718853 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.551621687Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 84 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 776718853 } }) [2025-04-30T10:15:20.551628309Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551632137Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551638198Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.551641875Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.551650201Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11172 out_len=1200 left=1165 [2025-04-30T10:15:20.551663115Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=18 [2025-04-30T10:15:20.551667533Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=64 off=0 len=32 fin=true [2025-04-30T10:15:20.551678914Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=995.48028ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2401 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 776799153 }, next_time: Instant { tv_sec: 410, tv_nsec: 776799153 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.551714421Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 776799153 } }) [2025-04-30T10:15:20.551720512Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551724469Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551730320Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.551734178Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.551743104Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11099 out_len=1200 left=1165 [2025-04-30T10:15:20.551749627Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=19 [2025-04-30T10:15:20.551753604Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=68 off=0 len=32 fin=true [2025-04-30T10:15:20.551763262Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=995.396173ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2474 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 776891617 }, next_time: Instant { tv_sec: 410, tv_nsec: 776891617 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.551799430Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 776891617 } }) [2025-04-30T10:15:20.551811953Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551815961Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551821501Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.551825198Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.551834015Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=11026 out_len=1200 left=1165 [2025-04-30T10:15:20.551840477Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=20 [2025-04-30T10:15:20.551844695Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=72 off=0 len=32 fin=true [2025-04-30T10:15:20.551879640Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=995.279795ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2547 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 776982547 }, next_time: Instant { tv_sec: 410, tv_nsec: 776982547 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.551913013Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 776982547 } }) [2025-04-30T10:15:20.551918343Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551922130Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551927890Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.551931878Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.551937899Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.551941796Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.551945223Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552364318Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.552371922Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.552378394Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563905 [2025-04-30T10:15:20.552384415Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=76 off=107 len=150 fin=true [2025-04-30T10:15:20.552387942Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=80 off=0 len=257 fin=true [2025-04-30T10:15:20.552391238Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=84 off=0 len=257 fin=true [2025-04-30T10:15:20.552394093Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=88 off=0 len=257 fin=true [2025-04-30T10:15:20.552397149Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=92 off=0 len=186 fin=false [2025-04-30T10:15:20.552407478Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.552415293Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 76 is writable with capacity Ok(10953) [2025-04-30T10:15:20.552417988Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 80 is writable with capacity Ok(10953) [2025-04-30T10:15:20.552420202Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 84 is writable with capacity Ok(10953) [2025-04-30T10:15:20.552422426Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 88 is writable with capacity Ok(10953) [2025-04-30T10:15:20.552424640Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 92 is writable with capacity Ok(10953) [2025-04-30T10:15:20.552428969Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 150 bytes [2025-04-30T10:15:20.552431243Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 76 has 150 bytes (fin? true) [2025-04-30T10:15:20.552435040Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/mytaktgcamjwmccjinxgryznruelthmtozqltuummwmhsgauhzntvmqeinaiozliseovgnaeocyowywiwgaghaynwmsboxczlbxardxtddssxegllsyqiobvuvrtibouwksethokoudfjiimdmadiqyjpoyywunqmadkifjrcgiajirnrslyfmtmcodtuxwrvagrouwdjioorcicnzwdxgqeyfksguuyepfsoagdksxkdzqxcavjjqhmkz" on stream 76 [2025-04-30T10:15:20.552453875Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 76 [2025-04-30T10:15:20.552459135Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.552461429Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 80 has 257 bytes (fin? true) [2025-04-30T10:15:20.552464134Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/msmsnmlzddjqcqbjymnvffmuwmvgthdtlstoutdxcxwaacwmcrjgnblwuejdgtcojqswayzbvxdzhmlnbdieqfhfbraftufopehgvjvopqqxcfrsuehjxuiyvlfjofsarlcreqeazogsymfvgxaxebprhybbydnetrntuqhingqurywgfgxowsfocvgdliozrylesgmtahlvagwiridfpkhokkiltgyfcmtvseajuuptfvxmyecdzvnoqf" on stream 80 [2025-04-30T10:15:20.552477379Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 80 [2025-04-30T10:15:20.552481858Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.552484122Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 84 has 257 bytes (fin? true) [2025-04-30T10:15:20.552486847Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/pursxgeryxqybhvxaazbprpaurahpyvwxofxgkewokjehzurqkayheebpgorceosztyrjenrggdircbkkedwfcscffxkmbmskktxlebmhfexwmbsxhidzednvrzvdlehsyaxywjptmbmjewddqfojhjbhplqupnliqpgbmtwbgwcdqapfgjplofewrufudkhlqizrftzvrhafsbiorxdndakwlhihwxlqqublnngjyhfikplaachhoaupg" on stream 84 [2025-04-30T10:15:20.552500082Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 84 [2025-04-30T10:15:20.552504420Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.552506684Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 88 has 257 bytes (fin? true) [2025-04-30T10:15:20.552509329Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/jbxlvgdxfhbvhuxihnrfgkmdyxvwwmrhasrhbpvhltdgoderbaxpfqvjnhvzgosvjxgpwrbraesmwzrsahjxadyphriyusprbcfnhccmexgwasxedsjsbjunqobvjyxajxiokwojlagrcpjxeilutlzorayjcdbolrznakfmpfmqlbxrmmcdsreepzkqqhhkqtfttnszallvewhsbksufpotxypfleduhmbiklnyogixqtnfugctpoadbf" on stream 88 [2025-04-30T10:15:20.552522403Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 88 [2025-04-30T10:15:20.552526622Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 186 bytes [2025-04-30T10:15:20.552528886Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 92 has 186 bytes (fin? false) [2025-04-30T10:15:20.552535929Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.552538413Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.552544856Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10953 out_len=1200 left=1153 [2025-04-30T10:15:20.552548983Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=50 pn=21 [2025-04-30T10:15:20.552551528Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=20 blocks=[2011563900..2011563905] ecn_counts=None [2025-04-30T10:15:20.552554704Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=76 off=0 len=32 fin=true [2025-04-30T10:15:20.552561306Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=994.598429ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2632 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 777694450 }, next_time: Instant { tv_sec: 410, tv_nsec: 777694450 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.552596182Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 85 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 777694450 } }) [2025-04-30T10:15:20.552602393Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552606050Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552611661Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.552615197Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.552622751Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10868 out_len=1200 left=1165 [2025-04-30T10:15:20.552628682Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=22 [2025-04-30T10:15:20.552632790Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=80 off=0 len=32 fin=true [2025-04-30T10:15:20.552642358Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=994.516766ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2705 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 777772195 }, next_time: Instant { tv_sec: 410, tv_nsec: 777772195 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.552687012Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 777772195 } }) [2025-04-30T10:15:20.552695237Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552699024Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552705126Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.552708873Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.552717319Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10795 out_len=1200 left=1165 [2025-04-30T10:15:20.552723400Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=23 [2025-04-30T10:15:20.552727618Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=84 off=0 len=32 fin=true [2025-04-30T10:15:20.552737416Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=994.421698ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2778 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 777866041 }, next_time: Instant { tv_sec: 410, tv_nsec: 777866041 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.552773474Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 777866041 } }) [2025-04-30T10:15:20.552779134Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552782631Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552788271Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.552792289Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.552800695Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10722 out_len=1200 left=1165 [2025-04-30T10:15:20.552806716Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=24 [2025-04-30T10:15:20.552810774Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=88 off=0 len=32 fin=true [2025-04-30T10:15:20.552820331Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=994.339013ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2851 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 777949357 }, next_time: Instant { tv_sec: 410, tv_nsec: 777949357 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.552877038Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 777949357 } }) [2025-04-30T10:15:20.552888349Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552891685Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552897696Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.552901684Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.552907755Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.552911873Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.552915459Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553348080Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.553356305Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.553362416Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563906 [2025-04-30T10:15:20.553368478Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=92 off=186 len=71 fin=true [2025-04-30T10:15:20.553372024Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=96 off=0 len=257 fin=true [2025-04-30T10:15:20.553375461Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=100 off=0 len=257 fin=true [2025-04-30T10:15:20.553378256Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=104 off=0 len=257 fin=true [2025-04-30T10:15:20.553381342Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=108 off=0 len=257 fin=true [2025-04-30T10:15:20.553384147Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=112 off=0 len=4 fin=false [2025-04-30T10:15:20.553397151Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.553399977Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 92 is writable with capacity Ok(10649) [2025-04-30T10:15:20.553402562Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 96 is writable with capacity Ok(10649) [2025-04-30T10:15:20.553404755Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 100 is writable with capacity Ok(10649) [2025-04-30T10:15:20.553407000Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 104 is writable with capacity Ok(10649) [2025-04-30T10:15:20.553409154Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 108 is writable with capacity Ok(10649) [2025-04-30T10:15:20.553411328Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 112 is writable with capacity Ok(10649) [2025-04-30T10:15:20.553415576Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 71 bytes [2025-04-30T10:15:20.553417910Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 92 has 71 bytes (fin? true) [2025-04-30T10:15:20.553426877Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/savpjmffiefkysmkjmmtcihtokyoiqhmqlirmdheexbkmwlbwannkmawflqqvtkunfpojnuwrkebwqngwipmgkslqnqxglyoxijpmpwesqxrjdpferwzywbozgzadqwhxlzuafbbtnfnmwftrxxpxhdgfffvqqvfpvgdndxssgyhxgjcrftyzrpiipgagobadzexymqtrstlmkvdgylhqqvbcxbauztzzzaqziuqofdwqafhmpgzgnhrfr" on stream 92 [2025-04-30T10:15:20.553445913Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 92 [2025-04-30T10:15:20.553451162Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.553453457Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 96 has 257 bytes (fin? true) [2025-04-30T10:15:20.553456402Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/umvleodymfwrmhkhtxzslvecgcgfvdvxlfigisapqglmerisyethrrzgmfjxfvrrpnbzuvnyjbioyupcwrzvekvqklmbhogssyvaphfwomjzokuqfgqcqmrwnunhtjpvnevxwmxqxlttdwynaemwgspytsneecalxzgzehdolugpvtovnnrevfpfqmvapgcodolvoivpbstdjaydihjvkvtpbvbjxhilmfsdliynebyuqioyocrdsxjdrp" on stream 96 [2025-04-30T10:15:20.553469727Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 96 [2025-04-30T10:15:20.553474075Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.553476360Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 100 has 257 bytes (fin? true) [2025-04-30T10:15:20.553479035Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/gihupidmzatalbgozviivftolonaaesfzutkqawfmmtslctkrttuwtsmskecvhtqegzsevopbliopgkemiowvwbabrispdkromiguthkvwaxsielkllirwwkhzqnpieqrpnuxexebwbggufpudbmrsmshjthxrmqxnfwcesbqkvbgjdhyhqvlwminduvbnhrztildiepfnrnnyfdomfkmmcysaunlpplnqfbybbthyxixqzmlyumycyquj" on stream 100 [2025-04-30T10:15:20.553492249Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 100 [2025-04-30T10:15:20.553506706Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.553509161Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 104 has 257 bytes (fin? true) [2025-04-30T10:15:20.553511876Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/zhjwjjdmlooewjzfolzoubeufmikotgrsxibahberiazwjrqpnygqmamzniicyempiefmiagldcszceunaufzcthlifspxxuvgitctvjgseuzbcysbhcphehrmqcaxstpthufmnjskosmtoqjapvcnjhqclawyqsvhovylbwepqimujcfqrvomdvjrcwhgzianyjcbqhhalqrvtdkbjnyyteoquscofepxshwozpzsfseyprxskyxfzkwd" on stream 104 [2025-04-30T10:15:20.553525532Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 104 [2025-04-30T10:15:20.553529970Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.553532234Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 108 has 257 bytes (fin? true) [2025-04-30T10:15:20.553534889Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/ssduiohrcmhqwtufmlsbxhilzufozjpdiewqjpmiwamiwlmzhliakgyurksvymwrfpdmiersrvkbnnnwrbsgoibgslawbacfhtahstdojodhgokcvhcwjjwksmmexlwsyufqxdnunuejgpnggpijenxgnzjgajdxkjzlrbmtgipzpuktntjjrshdkqqrkzwvppxwxtqnsmyszkzavveowioxjgmqqgvvypdvckhepgpzlfkhulgctaetei" on stream 108 [2025-04-30T10:15:20.553547773Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 108 [2025-04-30T10:15:20.553552131Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 4 bytes [2025-04-30T10:15:20.553554426Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 112 has 4 bytes (fin? false) [2025-04-30T10:15:20.553558594Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.553561008Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.553574163Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10649 out_len=1200 left=1153 [2025-04-30T10:15:20.553578411Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=50 pn=25 [2025-04-30T10:15:20.553580945Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=26 blocks=[2011563900..2011563906] ecn_counts=None [2025-04-30T10:15:20.553584151Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=92 off=0 len=32 fin=true [2025-04-30T10:15:20.553591115Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=993.56858ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2936 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 778723647 }, next_time: Instant { tv_sec: 410, tv_nsec: 778723647 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.553626882Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 85 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 778723647 } }) [2025-04-30T10:15:20.553632402Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553635848Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553641799Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.553645526Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.553653161Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10564 out_len=1200 left=1165 [2025-04-30T10:15:20.553659162Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=26 [2025-04-30T10:15:20.553663650Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=96 off=0 len=32 fin=true [2025-04-30T10:15:20.553673228Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=993.486056ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3009 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 778802615 }, next_time: Instant { tv_sec: 410, tv_nsec: 778802615 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.553717942Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 778802615 } }) [2025-04-30T10:15:20.553723132Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553727059Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553733060Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.553736797Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.553745554Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10491 out_len=1200 left=1165 [2025-04-30T10:15:20.553752126Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=27 [2025-04-30T10:15:20.553756574Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=100 off=0 len=32 fin=true [2025-04-30T10:15:20.553766403Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=993.392962ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3082 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 778894316 }, next_time: Instant { tv_sec: 410, tv_nsec: 778894316 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.553803813Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 778894316 } }) [2025-04-30T10:15:20.553808632Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553811928Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553818129Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.553821806Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.553830242Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10418 out_len=1200 left=1165 [2025-04-30T10:15:20.553836554Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=28 [2025-04-30T10:15:20.553840682Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=104 off=0 len=32 fin=true [2025-04-30T10:15:20.553871600Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=993.287565ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3155 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 778979005 }, next_time: Instant { tv_sec: 410, tv_nsec: 778979005 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.553918117Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 778979005 } }) [2025-04-30T10:15:20.553923226Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553926913Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.553933035Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.553936662Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.553945799Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10345 out_len=1200 left=1165 [2025-04-30T10:15:20.553952240Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=29 [2025-04-30T10:15:20.553956468Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=108 off=0 len=32 fin=true [2025-04-30T10:15:20.553966487Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=993.192777ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3228 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 779094261 }, next_time: Instant { tv_sec: 410, tv_nsec: 779094261 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.554004839Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 779094261 } }) [2025-04-30T10:15:20.554009668Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554011752Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554015479Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.554017593Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.554022612Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.554026530Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554029886Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554342511Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.554349815Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.554355786Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563907 [2025-04-30T10:15:20.554361737Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=112 off=4 len=253 fin=true [2025-04-30T10:15:20.554369983Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=116 off=0 len=257 fin=true [2025-04-30T10:15:20.554373479Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=120 off=0 len=257 fin=true [2025-04-30T10:15:20.554376265Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=124 off=0 len=257 fin=true [2025-04-30T10:15:20.554379681Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=128 off=0 len=84 fin=false [2025-04-30T10:15:20.554389870Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.554392665Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 112 is writable with capacity Ok(10272) [2025-04-30T10:15:20.554395140Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 116 is writable with capacity Ok(10272) [2025-04-30T10:15:20.554397364Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 120 is writable with capacity Ok(10272) [2025-04-30T10:15:20.554399558Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 124 is writable with capacity Ok(10272) [2025-04-30T10:15:20.554401742Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 128 is writable with capacity Ok(10272) [2025-04-30T10:15:20.554405990Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 253 bytes [2025-04-30T10:15:20.554408274Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 112 has 253 bytes (fin? true) [2025-04-30T10:15:20.554412182Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/ekbexjqbqtysyogmruvnlhjpzcpznxyqprhvkmgjweaakqcdkikopehdjeimmgbhygdhesrsjvsmweescqfklshelxheexzofckpsqsqavqmjiapugjardtpxuuuqzbjdpwevahavxbhefdellqlqzgtyxbcvpodvuecowpayzccrdurtkrdhqxgxrujqjlqdtwylseaojrmtuqbshpckcybblmulgfxomyhpnpeuuqsdilnwzpikltbjd" on stream 112 [2025-04-30T10:15:20.554431137Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 112 [2025-04-30T10:15:20.554436347Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.554438661Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 116 has 257 bytes (fin? true) [2025-04-30T10:15:20.554441387Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/ymebavpitzrexivgrzjgrubmiorleblndbmymofqplzzmpcgnwyoyzewfrfqyqpptbajmsktzmucabinhecnkslczupuiypezlhmtgkqkjcbmuvycejgxjqhwobaxiozltztrmopyycslqfdwejhdcabnxugalkzknznbjqhxfpedyaanowhyiwunavdkasztqcrkrsvwvuwvorkjyqdusvjpgxqabeadxmdslzhgllazpioedylnztwem" on stream 116 [2025-04-30T10:15:20.554454611Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 116 [2025-04-30T10:15:20.554459040Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.554461324Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 120 has 257 bytes (fin? true) [2025-04-30T10:15:20.554464009Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/csnndmhpwoqscowdudleoirnmhksogodvijpcabbjimbwhsptddhhsswvioznlodmnytzoevuzdowzoeexutsutbtdkcuezoyuncrebbkjtqmfiypttdlzqdkynkkdzlxygmqiaofukzslumvsmdaqingmyzpoxoccoudshqvvlpzlxpkseeqsyvittjgwwbdpkkufxodolqwjkvdmircumbjthekrbymfpugpnsgeksvkzswnudmzjbhb" on stream 120 [2025-04-30T10:15:20.554477203Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 120 [2025-04-30T10:15:20.554481471Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.554483706Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 124 has 257 bytes (fin? true) [2025-04-30T10:15:20.554489967Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/uvmkgstpojiurywvuukvuadppoupiknyqnzlqttjvhdwjchyxtlunggktqofwxqyzigrpreoctyeuwmgivrzfmeoinryqkunwhhklymjrvsgwqxvbblmitfsmrcvwkononivnldkbbdvfxofbrzioujuoinbqydzzrfmgssbklpfhjdkfqbuftedzbrcjysnfinlmbfwifkaclasidjdwodfrquohddlfxosbjkglswwfqwsedbqubuesz" on stream 124 [2025-04-30T10:15:20.554503913Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 124 [2025-04-30T10:15:20.554508192Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 84 bytes [2025-04-30T10:15:20.554510506Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 128 has 84 bytes (fin? false) [2025-04-30T10:15:20.554514654Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.554517008Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.554523430Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10272 out_len=1200 left=1153 [2025-04-30T10:15:20.554527508Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=50 pn=30 [2025-04-30T10:15:20.554530033Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=20 blocks=[2011563900..2011563907] ecn_counts=None [2025-04-30T10:15:20.554533268Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=112 off=0 len=32 fin=true [2025-04-30T10:15:20.554539791Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=992.619924ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3313 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 779672914 }, next_time: Instant { tv_sec: 410, tv_nsec: 779672914 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.554575337Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 85 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 779672914 } }) [2025-04-30T10:15:20.554580176Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554584043Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554590165Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.554594052Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.554601607Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10187 out_len=1200 left=1165 [2025-04-30T10:15:20.554607638Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=31 [2025-04-30T10:15:20.554611866Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=116 off=0 len=32 fin=true [2025-04-30T10:15:20.554621273Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=992.537931ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3386 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 779751091 }, next_time: Instant { tv_sec: 410, tv_nsec: 779751091 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.554666488Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 779751091 } }) [2025-04-30T10:15:20.554671567Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554675224Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554681216Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.554684872Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.554693899Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10114 out_len=1200 left=1165 [2025-04-30T10:15:20.554700021Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=32 [2025-04-30T10:15:20.554704008Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=120 off=0 len=32 fin=true [2025-04-30T10:15:20.554713777Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=992.445708ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3459 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 779842261 }, next_time: Instant { tv_sec: 410, tv_nsec: 779842261 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.554750926Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 779842261 } }) [2025-04-30T10:15:20.554755595Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554759202Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554765123Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.554769060Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.554777686Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=10041 out_len=1200 left=1165 [2025-04-30T10:15:20.554783768Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=33 [2025-04-30T10:15:20.554794227Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=124 off=0 len=32 fin=true [2025-04-30T10:15:20.554804046Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=992.354988ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3532 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 779926569 }, next_time: Instant { tv_sec: 410, tv_nsec: 779926569 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.554839742Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 779926569 } }) [2025-04-30T10:15:20.554844361Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554864719Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554875128Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.554879176Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.554885167Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.554888954Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.554892351Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555322666Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.555329710Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.555335611Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=1154 pn=2011563908 [2025-04-30T10:15:20.555341702Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=128 off=84 len=173 fin=true [2025-04-30T10:15:20.555345159Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=132 off=0 len=257 fin=true [2025-04-30T10:15:20.555348595Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=136 off=0 len=257 fin=true [2025-04-30T10:15:20.555351480Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=140 off=0 len=257 fin=true [2025-04-30T10:15:20.555354706Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=144 off=0 len=163 fin=false [2025-04-30T10:15:20.555364905Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.555367681Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 128 is writable with capacity Ok(9968) [2025-04-30T10:15:20.555370206Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 132 is writable with capacity Ok(9968) [2025-04-30T10:15:20.555372440Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 136 is writable with capacity Ok(9968) [2025-04-30T10:15:20.555374644Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 140 is writable with capacity Ok(9968) [2025-04-30T10:15:20.555381827Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 144 is writable with capacity Ok(9968) [2025-04-30T10:15:20.555386245Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 173 bytes [2025-04-30T10:15:20.555388510Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 128 has 173 bytes (fin? true) [2025-04-30T10:15:20.555392287Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/jbdnweymnndeuzpjfvgyisupuajatliwxbemziihbryfpmgrztrpyosxpqmxgbsijsszdjwlmtffkpviumeqgzgfdodwtjnjsxjmsjwisfwcsimnofxunjlngotivbwlhvdvcjqivsmagozritdfnkkztmvnpykumbzmzfllexmnljvhkyljztahjzpvzdldaqbueaiugxznvlatannxvxkhddgjqfmezpeyztihbuqtpprmsfhpdiuezs" on stream 128 [2025-04-30T10:15:20.555411423Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 128 [2025-04-30T10:15:20.555416482Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.555418736Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 132 has 257 bytes (fin? true) [2025-04-30T10:15:20.555421562Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/hzymuxvfdnwabcsrgayevbveygcguqdhgbcfjvyjjllrhpgcwujilscklxxeayihagnltsigidyhjucbbbxnrncjhcbqiffljzyxzxorvuujvrqppnjxryfdhozfmrjsokuhstqtnxhowrxsrdjkukeyegseebzjwveylahoptleklctkykvylncloxqlmqhthkfxolpmouurteqmlrsigropsfuzdcybgqmrcuspmdotwoqoyxydphaob" on stream 132 [2025-04-30T10:15:20.555434867Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 132 [2025-04-30T10:15:20.555439255Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.555441499Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 136 has 257 bytes (fin? true) [2025-04-30T10:15:20.555444214Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/wqubtfrpmmkwypeakbdtqgygnuvwlhavyxujrehjfgctonnusgguhhacovxayynpytmfxcaldkocbotzmhrjrnhchnmikrwiqxhzozrdbpirdtifqckvjzgqytvawprufpwvblvckojvmtjfhzbiznhuadhnvigwutvulnylscsdqekrbbeptzxrwtlbvgxzjwlirudayccyudkcxumrqvamctzwcsharelovkqwejnqyvsndrilvjvpcy" on stream 136 [2025-04-30T10:15:20.555457459Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 136 [2025-04-30T10:15:20.555461777Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.555464061Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 140 has 257 bytes (fin? true) [2025-04-30T10:15:20.555466666Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/wishqmujorvhtwslwnwfmbnwmavcygrsjllzifsbsuepeaqoxoyknzayojsdgccwhvvtucvqziispvctqwnhfotoqcldvygricuthzudiigmvmxffbhijunimwqzlkktdofltmsmuesoqnbfxanldyruewmgtfqwsukabybmhxofnwtdwfegcmkipobahqpaxhbgeiidltshjspxynrhiipmxebiqdaoihcqzpuvpczooopuipwpopxvuf" on stream 140 [2025-04-30T10:15:20.555479610Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 140 [2025-04-30T10:15:20.555483788Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 163 bytes [2025-04-30T10:15:20.555486042Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 144 has 163 bytes (fin? false) [2025-04-30T10:15:20.555490000Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.555492344Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.555498676Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9968 out_len=1200 left=1153 [2025-04-30T10:15:20.555502774Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=50 pn=34 [2025-04-30T10:15:20.555508745Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=20 blocks=[2011563900..2011563908] ecn_counts=None [2025-04-30T10:15:20.555511921Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=128 off=0 len=32 fin=true [2025-04-30T10:15:20.555520727Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=991.638978ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3617 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 780648250 }, next_time: Instant { tv_sec: 410, tv_nsec: 780648250 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.555555943Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 85 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 780648250 } }) [2025-04-30T10:15:20.555560652Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555564229Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555570230Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.555573837Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.555581872Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9883 out_len=1200 left=1165 [2025-04-30T10:15:20.555588143Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=35 [2025-04-30T10:15:20.555592622Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=132 off=0 len=32 fin=true [2025-04-30T10:15:20.555619132Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=991.539862ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3690 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 780731246 }, next_time: Instant { tv_sec: 410, tv_nsec: 780731246 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.555654728Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 780731246 } }) [2025-04-30T10:15:20.555659507Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555668584Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555674676Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.555678372Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.555687710Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9810 out_len=1200 left=1165 [2025-04-30T10:15:20.555694042Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=36 [2025-04-30T10:15:20.555698169Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=136 off=0 len=32 fin=true [2025-04-30T10:15:20.555708389Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=991.450786ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3763 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 780835831 }, next_time: Instant { tv_sec: 410, tv_nsec: 780835831 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.555744747Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 780835831 } }) [2025-04-30T10:15:20.555749496Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555753042Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555759103Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.555762881Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.555770886Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9737 out_len=1200 left=1165 [2025-04-30T10:15:20.555777328Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=37 [2025-04-30T10:15:20.555781465Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=140 off=0 len=32 fin=true [2025-04-30T10:15:20.555790502Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=991.368782ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3836 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 780919889 }, next_time: Instant { tv_sec: 410, tv_nsec: 780919889 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.555834415Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 780919889 } }) [2025-04-30T10:15:20.555839364Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555842820Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555867967Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.555876353Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.555882885Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.555886562Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555889738Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.555923351Z TRACE quiche_server] got 691 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.555931056Z TRACE quiche_server] got packet ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 [2025-04-30T10:15:20.555940413Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt ZeroRTT version=1 dcid=047cc2c68c361320dac79f86b6d4e0f7d990 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=645 pn=2011563909 [2025-04-30T10:15:20.555948088Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=144 off=163 len=94 fin=true [2025-04-30T10:15:20.555951955Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=148 off=0 len=257 fin=true [2025-04-30T10:15:20.555955171Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm STREAM id=152 off=0 len=257 fin=true [2025-04-30T10:15:20.555965400Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 691 bytes [2025-04-30T10:15:20.555968155Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 144 is writable with capacity Ok(9664) [2025-04-30T10:15:20.555970820Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 148 is writable with capacity Ok(9664) [2025-04-30T10:15:20.555973084Z DEBUG quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 response stream 152 is writable with capacity Ok(9664) [2025-04-30T10:15:20.555977212Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 94 bytes [2025-04-30T10:15:20.555979496Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 144 has 94 bytes (fin? true) [2025-04-30T10:15:20.555983414Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/abvzwfrmrlpcgckkeibnzsfnnjtvmglakzumgfzkevcjxxhlcffqoccsujwfpclyvsdqpelsmpzcedknemjhkhxeiyseiqkfnipxmqezxsldplypluxwpcfrwnmgefwzixhxvjcgqmoqlhiwtnuisfgfzjnngblkeoxcowyexgueuzteaxvttgcsukvvyfllamzsgxaocfroiipxdqnitdknrymvqzqwavixvhbhtmkoeteqdqevjzorka" on stream 144 [2025-04-30T10:15:20.556003090Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 144 [2025-04-30T10:15:20.556008380Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.556010665Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 148 has 257 bytes (fin? true) [2025-04-30T10:15:20.556013400Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/iqtvsgfhipjenbawsmstzoekswsgnrruzmnowthrmexraqsqalsmhbgqghyhdzunfhqgdgbddckooefqsxajhcbkcoqkpcfzvhdchjfplmnbdsnzfcbrbhrygfnaxjadkguwkopzbcnhuuedfksnmkzuqvujmlvymirhljhipnkndcqwttkdekxhgjxpjxlcaqxtxkxooboftnbitpcyuyukhwfhzxazhwnlvqcrjbwtmvvhwqkbzlnqto" on stream 148 [2025-04-30T10:15:20.556026765Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 148 [2025-04-30T10:15:20.556031003Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 received 257 bytes [2025-04-30T10:15:20.556038336Z TRACE quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 stream 152 has 257 bytes (fin? true) [2025-04-30T10:15:20.556041212Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 got GET request for "/www/mnymxppmvubzphmcolcrmsagqhuxckcftrhbfrpowyemykfailfaaentohnooimavvzmuywoiicykzgbwbiznjprcszwuohazrxzsvyomqyyvunpavensztqyuvhcqiosuunojfyoamlbhkhozmntjzomapjabjgdoxfflqrwiwfvyltfkutejrdpjimljbbuzhtzdtfpgjcvxaelbxfnufnkqeawzjezligiomatngbnoytucvtwrwkrr" on stream 152 [2025-04-30T10:15:20.556054427Z INFO quiche_apps::common] cf84eada515af6d9158a570d79e72e0b7cad06c7 sending response of size 32 on stream 152 [2025-04-30T10:15:20.556059806Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.556062261Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.556068573Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9664 out_len=1200 left=1153 [2025-04-30T10:15:20.556072751Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=50 pn=38 [2025-04-30T10:15:20.556075255Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=16 blocks=[2011563900..2011563909] ecn_counts=None [2025-04-30T10:15:20.556078421Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=144 off=0 len=32 fin=true [2025-04-30T10:15:20.556085044Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=991.074681ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3921 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 781218127 }, next_time: Instant { tv_sec: 410, tv_nsec: 781218127 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.556120340Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 85 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 781218127 } }) [2025-04-30T10:15:20.556125049Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556128876Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556135288Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.556139215Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.556147110Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9579 out_len=1200 left=1165 [2025-04-30T10:15:20.556153212Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=39 [2025-04-30T10:15:20.556157549Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=148 off=0 len=32 fin=true [2025-04-30T10:15:20.556166877Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=990.992317ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3994 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 781296414 }, next_time: Instant { tv_sec: 410, tv_nsec: 781296414 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.556213033Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 781296414 } }) [2025-04-30T10:15:20.556218143Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556221970Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556228102Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.556231999Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.556240755Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=false hs_sent=false cwnd_avail=9506 out_len=1200 left=1165 [2025-04-30T10:15:20.556246586Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=38 pn=40 [2025-04-30T10:15:20.556250894Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm STREAM id=152 off=0 len=32 fin=true [2025-04-30T10:15:20.556260803Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=990.898561ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4067 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, 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: 410, tv_nsec: 781389458 }, next_time: Instant { tv_sec: 410, tv_nsec: 781389458 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.556299896Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 73 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 781389458 } }) [2025-04-30T10:15:20.556304755Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556308071Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556314002Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.556317289Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.556323450Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.556327227Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.556330433Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.583457863Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.583470687Z TRACE quiche_server] got packet Initial version=1 dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 scid=e9d35722637a9ad4dc9726e98d9c7083d8 token= [2025-04-30T10:15:20.583487178Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Initial version=1 dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 scid=e9d35722637a9ad4dc9726e98d9c7083d8 token= len=22 pn=2011563901 [2025-04-30T10:15:20.583494402Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=0 blocks=[0..0] ecn_counts=None [2025-04-30T10:15:20.583498630Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 0 [2025-04-30T10:15:20.583511935Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Handshake version=1 dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 scid=e9d35722637a9ad4dc9726e98d9c7083d8 len=64 pn=2011563900 [2025-04-30T10:15:20.583516653Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=0 blocks=[1..1] ecn_counts=None [2025-04-30T10:15:20.583519429Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 1 [2025-04-30T10:15:20.583522475Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm CRYPTO off=0 len=36 [2025-04-30T10:15:20.583528175Z TRACE quiche::tls] cf84eada515af6d9158a570d79e72e0b7cad06c7 set read secret lvl=OneRTT [2025-04-30T10:15:20.583540709Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 dropped epoch 1 state [2025-04-30T10:15:20.583543975Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=None resumed=true TransportParams { original_destination_connection_id: None, max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 25165824, initial_max_stream_data_bidi_local: 16777216, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 16777216, initial_max_streams_bidi: 0, initial_max_streams_uni: 0, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 7, initial_source_connection_id: Some(e9d35722637a9ad4dc9726e98d9c7083d8), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T10:15:20.583560175Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 dropped epoch 0 state [2025-04-30T10:15:20.583563020Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=996 pn=2011563910 [2025-04-30T10:15:20.583567539Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=11 blocks=[2..11] ecn_counts=None [2025-04-30T10:15:20.583570324Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 2 [2025-04-30T10:15:20.583573510Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 3 [2025-04-30T10:15:20.583576085Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 4 [2025-04-30T10:15:20.583578389Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 5 [2025-04-30T10:15:20.583580844Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 6 [2025-04-30T10:15:20.583582988Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 7 [2025-04-30T10:15:20.583585072Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 8 [2025-04-30T10:15:20.583587266Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 9 [2025-04-30T10:15:20.583589470Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 10 [2025-04-30T10:15:20.583591594Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 11 [2025-04-30T10:15:20.583600060Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[2b, 7f, 18, 2d, fc, db, a4, 81, 15, 5f, d7, 47, 91, 68, 87, 29, d5] reset_token=[77, cd, aa, 35, a8, 84, 15, ee, eb, a7, e8, 68, e9, 5f, ca, f6] [2025-04-30T10:15:20.583606642Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[c6, ee, 5c, 18, 25, a2, 35, a3, 5f, 46, e9, 4d, 68, 33, 83, e3, e5] reset_token=[f9, 59, 7f, b4, d3, 36, 4b, 62, 5c, 63, 12, ab, 01, d8, 20, f3] [2025-04-30T10:15:20.583611952Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[82, c7, 50, ad, 92, 62, f6, e7, 59, 62, 2c, fe, bd, 05, e7, ac, e9] reset_token=[24, 95, 6f, 98, 40, 59, cd, a9, 26, e5, 55, 44, aa, c6, f1, cc] [2025-04-30T10:15:20.583617222Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[1e, 89, 2c, f3, 21, 93, 55, e9, 17, 37, 32, aa, cf, 78, 18, 1a, ef] reset_token=[0f, 27, e6, ad, 07, 9d, 76, 6b, f4, f2, ce, aa, 9e, 02, 73, e7] [2025-04-30T10:15:20.583622462Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[6c, 59, 89, 5c, 7c, 78, 5c, 03, ee, 86, ec, e0, 37, f0, ba, c9, 0e] reset_token=[cc, d8, c5, 0f, 11, a3, 88, b7, 29, 6c, c6, ad, ac, c0, a3, bf] [2025-04-30T10:15:20.583627692Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[e2, 00, dc, 45, d4, 5e, 6f, 0d, 5c, 08, 12, 82, 9d, 34, ce, dd, 69] reset_token=[04, 1f, df, 86, f4, 1b, 2e, 85, 5b, 4e, a6, 2e, 64, ed, 4a, dd] [2025-04-30T10:15:20.583632811Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[b0, 03, 32, 26, 2c, 38, 19, e7, cb, 5e, d9, 8d, 56, b9, 80, 21, 54] reset_token=[c7, 5c, 9f, e9, 36, e3, c4, 24, 26, 49, 74, fe, d6, 7d, 2a, 4d] [2025-04-30T10:15:20.583639263Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm PADDING len=715 [2025-04-30T10:15:20.583669940Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 1200 bytes [2025-04-30T10:15:20.583676523Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.583679819Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.583684037Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563911 [2025-04-30T10:15:20.583688094Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=8 blocks=[2..21] ecn_counts=None [2025-04-30T10:15:20.583692653Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 12 [2025-04-30T10:15:20.583697402Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 13 [2025-04-30T10:15:20.583701109Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 14 [2025-04-30T10:15:20.583705237Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 15 [2025-04-30T10:15:20.583711408Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 16 [2025-04-30T10:15:20.583715225Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 17 [2025-04-30T10:15:20.583719083Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 18 [2025-04-30T10:15:20.583723541Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 19 [2025-04-30T10:15:20.583727138Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 20 [2025-04-30T10:15:20.583735694Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 21 [2025-04-30T10:15:20.583764007Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.583770970Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.583774276Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.583779035Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563912 [2025-04-30T10:15:20.583784004Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=6 blocks=[2..24] ecn_counts=None [2025-04-30T10:15:20.583787040Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 22 [2025-04-30T10:15:20.583789324Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 23 [2025-04-30T10:15:20.583791478Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 24 [2025-04-30T10:15:20.583799734Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.583803190Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.583805565Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.583811726Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=12284 out_len=1350 left=1303 [2025-04-30T10:15:20.583815333Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=13 pn=41 [2025-04-30T10:15:20.583817857Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm ACK delay=4 blocks=[2011563906..2011563912] ecn_counts=None [2025-04-30T10:15:20.583820533Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm HANDSHAKE_DONE [2025-04-30T10:15:20.583825983Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=89.088516ms latest_rtt=30.982778ms srtt=34.163793ms min_rtt=30.982778ms rttvar=7.485837ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1264 app_limited=true congestion_recovery_start_time=None Rate { delivered: 2851, delivered_time: Instant { tv_sec: 410, tv_nsec: 808932135 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, end_of_app_limited: 40, last_sent_packet: 41, largest_acked: 24, rate_sample: RateSample { delivery_rate: 80706, is_app_limited: true, interval: 35.32565ms, delivered: 2851, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 410, tv_nsec: 773313948 }), send_elapsed: 0ns, ack_elapsed: 35.32565ms, rtt: 35.32565ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 493943, last_update: Instant { tv_sec: 410, tv_nsec: 808961601 }, next_time: Instant { tv_sec: 410, tv_nsec: 808961601 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.583880615Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 48 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 808961601 } }) [2025-04-30T10:15:20.583889171Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.583893259Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.583899861Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.583903518Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.583914368Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.583918256Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.583921912Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.584307434Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.584314347Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.584319948Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563913 [2025-04-30T10:15:20.584325688Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=6 blocks=[2..27] ecn_counts=None [2025-04-30T10:15:20.584329185Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 25 [2025-04-30T10:15:20.584331710Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 26 [2025-04-30T10:15:20.584333924Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 27 [2025-04-30T10:15:20.584346848Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.584351016Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.584353300Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.584358009Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12467 out_len=1350 left=1315 [2025-04-30T10:15:20.584361756Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx pkt Short dcid=e9d35722637a9ad4dc9726e98d9c7083d8 key_phase=false len=4 pn=42 [2025-04-30T10:15:20.584364271Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm MAX_STREAMS type=bidi max=126 [2025-04-30T10:15:20.584366745Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 tx frm PADDING len=1 [2025-04-30T10:15:20.584373017Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 timer=84.740487ms latest_rtt=30.578542ms srtt=33.715635ms min_rtt=30.578542ms rttvar=6.510689ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1072 app_limited=true congestion_recovery_start_time=None Rate { delivered: 3082, delivered_time: Instant { tv_sec: 410, tv_nsec: 809472858 }, first_sent_time: Instant { tv_sec: 410, tv_nsec: 773313948 }, end_of_app_limited: 41, last_sent_packet: 42, largest_acked: 27, rate_sample: RateSample { delivery_rate: 87245, is_app_limited: true, interval: 35.32565ms, delivered: 3082, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 410, tv_nsec: 773313948 }), send_elapsed: 0ns, ack_elapsed: 35.32565ms, rtt: 35.32565ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 500509, last_update: Instant { tv_sec: 410, tv_nsec: 808961601 }, next_time: Instant { tv_sec: 410, tv_nsec: 808961601 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T10:15:20.584407481Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 written 39 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:39624, at: Instant { tv_sec: 410, tv_nsec: 808961601 } }) [2025-04-30T10:15:20.584412301Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.584415496Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.584421177Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.584425034Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.584429422Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.584439712Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.584443699Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.584568262Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.584575506Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.584580946Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563914 [2025-04-30T10:15:20.584586326Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=6 blocks=[2..29] ecn_counts=None [2025-04-30T10:15:20.584589703Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 28 [2025-04-30T10:15:20.584592067Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 29 [2025-04-30T10:15:20.584602998Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.584607005Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.584609279Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.584611964Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.584614148Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.584616182Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.585247164Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.585256481Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.585261420Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563915 [2025-04-30T10:15:20.585266570Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=6 blocks=[2..32] ecn_counts=None [2025-04-30T10:15:20.585269806Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 30 [2025-04-30T10:15:20.585272211Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 31 [2025-04-30T10:15:20.585274425Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 32 [2025-04-30T10:15:20.585286678Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.585290665Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.585293059Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.585295655Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.585297808Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.585299802Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.586235123Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.586244070Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.586248959Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563916 [2025-04-30T10:15:20.586254089Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=6 blocks=[2..36] ecn_counts=None [2025-04-30T10:15:20.586257475Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 33 [2025-04-30T10:15:20.586259900Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 34 [2025-04-30T10:15:20.586262194Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 35 [2025-04-30T10:15:20.586264368Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 36 [2025-04-30T10:15:20.586284115Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.586288403Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.586290767Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.586293403Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.586295576Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.586297570Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.586695766Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.586702529Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.586707518Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=22 pn=2011563917 [2025-04-30T10:15:20.586712728Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=6 blocks=[2..39] ecn_counts=None [2025-04-30T10:15:20.586716034Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 37 [2025-04-30T10:15:20.586718468Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 38 [2025-04-30T10:15:20.586720783Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 39 [2025-04-30T10:15:20.586732144Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 43 bytes [2025-04-30T10:15:20.586736011Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.586738295Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.586740950Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.586743134Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.586745218Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.592000147Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.592010897Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.592017079Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=23 pn=2011563918 [2025-04-30T10:15:20.592023350Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm ACK delay=642 blocks=[2..40] ecn_counts=None [2025-04-30T10:15:20.592027418Z TRACE quiche::recovery::congestion::recovery] cf84eada515af6d9158a570d79e72e0b7cad06c7 packet newly acked 40 [2025-04-30T10:15:20.592038919Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 44 bytes [2025-04-30T10:15:20.592043668Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.592046503Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.592049700Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.592052365Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.592054899Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.614381504Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:39624 to [::]:443 [2025-04-30T10:15:20.614400540Z TRACE quiche_server] got packet Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false [2025-04-30T10:15:20.614414105Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx pkt Short dcid=cf84eada515af6d9158a570d79e72e0b7cad06c7 key_phase=false len=21 pn=2011563919 [2025-04-30T10:15:20.614425717Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[] [2025-04-30T10:15:20.614460842Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 processed 42 bytes [2025-04-30T10:15:20.614472955Z TRACE quiche_server] recv() would block [2025-04-30T10:15:20.614476993Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.614480089Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.614483094Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.614485889Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.726627630Z TRACE quiche_server] timed out [2025-04-30T10:15:20.726660101Z TRACE quiche] 4e633b3cc1fed1848c5f266c22b2100bd539a113 draining timeout expired [2025-04-30T10:15:20.726719442Z TRACE quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 done writing [2025-04-30T10:15:20.726725363Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.726729801Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.726735532Z INFO quiche_server] 4e633b3cc1fed1848c5f266c22b2100bd539a113 connection collected recv=5 sent=3 lost=0 retrans=0 sent_bytes=1709 recv_bytes=2442 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:56929 validation_state=Validated active=true recv=5 sent=3 lost=0 retrans=0 rtt=34.203449ms min_rtt=Some(34.199421ms) rttvar=12.832839ms cwnd=13500 sent_bytes=1709 recv_bytes=2442 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=27485] [2025-04-30T10:15:20.726773914Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.750871462Z TRACE quiche_server] timed out [2025-04-30T10:15:20.750884156Z TRACE quiche] cf84eada515af6d9158a570d79e72e0b7cad06c7 draining timeout expired [2025-04-30T10:15:20.750917709Z TRACE quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 done writing [2025-04-30T10:15:20.750922898Z TRACE quiche_server] Collecting garbage [2025-04-30T10:15:20.750927467Z INFO quiche_server] cf84eada515af6d9158a570d79e72e0b7cad06c7 connection collected recv=23 sent=43 lost=0 retrans=0 sent_bytes=4154 recv_bytes=13078 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:39624 validation_state=Validated active=true recv=23 sent=43 lost=0 retrans=0 rtt=32.193523ms min_rtt=Some(30.564164ms) rttvar=3.261161ms cwnd=13500 sent_bytes=4154 recv_bytes=13078 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=115128]