[2025-04-30T09:47:33.774574536Z INFO quiche_server] listening on [::]:443 [2025-04-30T09:47:33.774596497Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T09:47:33.774603039Z TRACE quiche_server] GSO detected: false [2025-04-30T09:47:34.580244466Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:50635 to [::]:443 [2025-04-30T09:47:34.580279421Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:47:34.580286915Z WARN quiche_server] Doing version negotiation [2025-04-30T09:47:34.580378095Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:50635 to [::]:443 [2025-04-30T09:47:34.580387693Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:47:34.580393915Z WARN quiche_server] Doing version negotiation [2025-04-30T09:47:34.580426045Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:50635 to [::]:443 [2025-04-30T09:47:34.580432957Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T09:47:34.580437947Z WARN quiche_server] Doing version negotiation [2025-04-30T09:47:34.580463394Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.802230606Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.802254892Z TRACE quiche_server] got packet Initial version=1 dcid=a6743ad04b676bc6 scid=2b56a9f816c5f55d token= [2025-04-30T09:47:34.802264680Z WARN quiche_server] Doing stateless retry [2025-04-30T09:47:34.802323039Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.834279333Z TRACE quiche_server] got 1252 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.834304159Z TRACE quiche_server] got packet Initial version=1 dcid=0665bec5d634db7ed399691c482fe9541701adbd scid=2b56a9f816c5f55d token=71756963686500000000000000000000ffffc1a70064a6743ad04b676bc6 [2025-04-30T09:47:34.834314348Z DEBUG quiche_server] New connection: dcid=0665bec5d634db7ed399691c482fe9541701adbd scid=0665bec5d634db7ed399691c482fe9541701adbd [2025-04-30T09:47:34.834542533Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Initial version=1 dcid=0665bec5d634db7ed399691c482fe9541701adbd scid=2b56a9f816c5f55d token=71756963686500000000000000000000ffffc1a70064a6743ad04b676bc6 len=1184 pn=80921 [2025-04-30T09:47:34.834557752Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm CRYPTO off=0 len=285 [2025-04-30T09:47:34.834584401Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T09:47:34.834588960Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T09:47:34.834702571Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd write message lvl=Initial len=123 [2025-04-30T09:47:34.834735824Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd set write secret lvl=Handshake [2025-04-30T09:47:34.834804542Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd write message lvl=Handshake len=720 [2025-04-30T09:47:34.834808068Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd set write secret lvl=OneRTT [2025-04-30T09:47:34.834815722Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd set read secret lvl=Handshake [2025-04-30T09:47:34.834839487Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=875 [2025-04-30T09:47:34.834862179Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 1252 bytes [2025-04-30T09:47:34.834883719Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.834896954Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Initial version=1 dcid=2b56a9f816c5f55d scid=0665bec5d634db7ed399691c482fe9541701adbd len=135 pn=0 [2025-04-30T09:47:34.834901172Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm ACK delay=46 blocks=[80921..80921] ecn_counts=None [2025-04-30T09:47:34.834906431Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm CRYPTO off=0 len=123 [2025-04-30T09:47:34.834924886Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=998.960997ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=190 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 284, tv_nsec: 621825194 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 621825194 }, 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: 284, tv_nsec: 621825194 }, next_time: Instant { tv_sec: 284, tv_nsec: 621825194 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.834949041Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Handshake version=1 dcid=2b56a9f816c5f55d scid=0665bec5d634db7ed399691c482fe9541701adbd len=724 pn=1 [2025-04-30T09:47:34.834952528Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm CRYPTO off=0 len=720 [2025-04-30T09:47:34.834959330Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=998.926974ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=968 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 284, tv_nsec: 621825194 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 621825194 }, 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: 284, tv_nsec: 621825194 }, next_time: Instant { tv_sec: 284, tv_nsec: 621825194 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.835022718Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:37814, at: Instant { tv_sec: 284, tv_nsec: 621825194 } }) [2025-04-30T09:47:34.835033548Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.835041383Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.835048857Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.835053516Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.867206207Z TRACE quiche_server] got 412 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.867230001Z TRACE quiche_server] got packet Handshake version=1 dcid=0665bec5d634db7ed399691c482fe9541701adbd scid=2b56a9f816c5f55d [2025-04-30T09:47:34.867243326Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Handshake version=1 dcid=0665bec5d634db7ed399691c482fe9541701adbd scid=2b56a9f816c5f55d len=64 pn=0 [2025-04-30T09:47:34.867254587Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm ACK delay=39 blocks=[1..1] ecn_counts=None [2025-04-30T09:47:34.867262882Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 1 [2025-04-30T09:47:34.867273232Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm CRYPTO off=0 len=36 [2025-04-30T09:47:34.867310321Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd set read secret lvl=OneRTT [2025-04-30T09:47:34.867362178Z TRACE quiche::tls] 0665bec5d634db7ed399691c482fe9541701adbd write message lvl=OneRTT len=396 [2025-04-30T09:47:34.867374240Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd dropped epoch 1 state [2025-04-30T09:47:34.867378989Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("P-256") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 180000, stateless_reset_token: None, max_udp_payload_size: 1440, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 2097152, initial_max_stream_data_bidi_remote: 65635, initial_max_stream_data_uni: 65535, initial_max_streams_bidi: 512, initial_max_streams_uni: 512, ack_delay_exponent: 3, max_ack_delay: 10, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(2b56a9f816c5f55d), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T09:47:34.867411670Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd dropped epoch 0 state [2025-04-30T09:47:34.867416128Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=290 pn=0 [2025-04-30T09:47:34.867424283Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[bb, 76, e3, d1, 11, 13, 3d, 24] reset_token=[4e, cc, 86, 94, 68, 84, 78, c2, 16, 83, 70, bf, 5e, 2d, 4b, 0d] [2025-04-30T09:47:34.867432408Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[19, 07, 74, 5b, 52, b2, 40, 9d] reset_token=[cb, 26, 0c, 85, 21, 6e, ce, 1c, af, 37, 3c, 8a, 3f, b5, 3b, 95] [2025-04-30T09:47:34.867438329Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[1c, ce, 03, be, 76, 2f, c2, f9] reset_token=[e7, d4, 26, df, 25, 4f, d8, 48, 5c, 01, f6, 53, 02, dc, 0a, c0] [2025-04-30T09:47:34.867443920Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[1d, 0d, 18, 09, 13, c8, 58, 07] reset_token=[86, f4, 64, 12, f4, 60, eb, 6d, a1, 4b, 01, e7, 32, 88, be, 4c] [2025-04-30T09:47:34.867450191Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[a8, 4c, ee, c2, 8d, 3e, 90, 3f] reset_token=[70, 9d, da, 8d, 1c, 75, b7, ce, 32, d0, 0e, 9b, c8, eb, 1b, 08] [2025-04-30T09:47:34.867455792Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[dd, c6, ba, 52, 2e, b3, bd, 25] reset_token=[fd, b0, 96, 72, 87, a4, 4c, 5e, 7f, 79, 29, bf, 55, 80, 19, 2a] [2025-04-30T09:47:34.867461262Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[fe, cd, be, 61, 34, 6c, ae, da] reset_token=[1a, ff, 1f, 33, 2b, 26, fb, b5, 10, 40, 8a, 2f, 57, 67, f5, ac] [2025-04-30T09:47:34.867466171Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=77 [2025-04-30T09:47:34.867476761Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 412 bytes [2025-04-30T09:47:34.867486178Z TRACE quiche_server] got 183 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.867490627Z TRACE quiche_server] got packet Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false [2025-04-30T09:47:34.867496328Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=162 pn=1 [2025-04-30T09:47:34.867501758Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm STREAM id=0 off=0 len=17 fin=true [2025-04-30T09:47:34.867506877Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=125 [2025-04-30T09:47:34.867516605Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 183 bytes [2025-04-30T09:47:34.867519351Z DEBUG quiche_apps::common] 0665bec5d634db7ed399691c482fe9541701adbd response stream 0 is writable with capacity Ok(13500) [2025-04-30T09:47:34.867525803Z TRACE quiche_apps::common] 0665bec5d634db7ed399691c482fe9541701adbd received 17 bytes [2025-04-30T09:47:34.867528297Z TRACE quiche_apps::common] 0665bec5d634db7ed399691c482fe9541701adbd stream 0 has 17 bytes (fin? true) [2025-04-30T09:47:34.867532916Z INFO quiche_apps::common] 0665bec5d634db7ed399691c482fe9541701adbd got GET request for "/www/zrbfacgzil" on stream 0 [2025-04-30T09:47:34.867562300Z INFO quiche_apps::common] 0665bec5d634db7ed399691c482fe9541701adbd sending response of size 10240 on stream 0 [2025-04-30T09:47:34.867570115Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.867577569Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319 [2025-04-30T09:47:34.867586586Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=2 [2025-04-30T09:47:34.867589481Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm ACK delay=10 blocks=[0..1] ecn_counts=None [2025-04-30T09:47:34.867592807Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[89, 72, 49, 97, 33, 1c, 43, 1b, 41, ea, df, 88, 90, 63, 0a, d1, ae, 9a, 5e, 19] reset_token=[8f, d2, c8, e7, 94, c6, 41, 01, fa, 71, 62, c8, fb, 98, 8f, 89] [2025-04-30T09:47:34.867598468Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[7d, f4, 60, 18, 9f, 1b, e3, b3, 21, 66, dd, 3a, 0e, e7, 7c, 01, 95, d1, 56, f0] reset_token=[d5, 2e, 8d, 2b, d8, da, 2b, 82, 3e, bf, ad, 26, cb, 10, 14, ee] [2025-04-30T09:47:34.867603537Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[29, 4a, f7, 77, cf, 72, 34, d3, 4b, 24, 24, d0, 8a, 1a, 62, f8, 34, 82, 7b, ed] reset_token=[01, 18, b1, 1e, 00, ce, e3, 63, eb, 0d, 10, b0, 0f, 6d, 2a, bf] [2025-04-30T09:47:34.867608707Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[d6, 9c, ef, 12, 6e, 98, 93, 12, 7e, 98, 6f, f5, 6c, 18, 94, 53, ef, b5, 61, a3] reset_token=[a6, 1b, fa, 1e, e5, 68, 9d, 57, ee, 49, 71, 30, 9c, ea, 2d, 63] [2025-04-30T09:47:34.867613496Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[bb, 3e, 01, 7f, 9d, 05, 16, 9f, 75, c4, 80, 32, 11, b8, 8b, 5b, e7, fa, 20, 7b] reset_token=[20, 1d, e3, 83, cf, 05, 50, dc, fd, 7e, c7, e3, 33, 46, a8, f2] [2025-04-30T09:47:34.867618485Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[48, b7, 61, d1, 8c, 8c, 0d, b7, 47, 7b, 46, cf, dd, bb, ff, 4a, 6f, 87, 53, 59] reset_token=[ef, ed, 1b, 1a, ca, 06, f2, 34, d7, 5f, 2c, b6, 87, f1, 10, 25] [2025-04-30T09:47:34.867623424Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[05, 8b, b5, 41, 9a, ff, d3, a5, 99, 7b, 0b, b9, 62, ec, b0, 0a, ec, 5b, 8f, 36] reset_token=[df, 1a, a9, c9, eb, 02, cf, 96, b3, f3, b7, 78, b1, db, cf, 1b] [2025-04-30T09:47:34.867628354Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm HANDSHAKE_DONE [2025-04-30T09:47:34.867630598Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm CRYPTO off=0 len=396 [2025-04-30T09:47:34.867632882Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=0 len=633 fin=false [2025-04-30T09:47:34.867645365Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=106.98418ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867665162Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324 [2025-04-30T09:47:34.867668759Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=3 [2025-04-30T09:47:34.867671314Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=633 len=1318 fin=false [2025-04-30T09:47:34.867676293Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.044562ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867686111Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1324 [2025-04-30T09:47:34.867689097Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=4 [2025-04-30T09:47:34.867691471Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=1951 len=1318 fin=false [2025-04-30T09:47:34.867716187Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.025777ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867729522Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1324 [2025-04-30T09:47:34.867733029Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=5 [2025-04-30T09:47:34.867735413Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=3269 len=1318 fin=false [2025-04-30T09:47:34.867740072Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.045665ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867749179Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1324 [2025-04-30T09:47:34.867752054Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=6 [2025-04-30T09:47:34.867754358Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=4587 len=1318 fin=false [2025-04-30T09:47:34.867758857Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.046898ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867770508Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=6750 out_len=1350 left=1324 [2025-04-30T09:47:34.867773454Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=7 [2025-04-30T09:47:34.867775798Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=5905 len=1318 fin=false [2025-04-30T09:47:34.867780026Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.047017ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867788883Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5400 out_len=1350 left=1324 [2025-04-30T09:47:34.867791748Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=8 [2025-04-30T09:47:34.867794043Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=7223 len=1318 fin=false [2025-04-30T09:47:34.867798150Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.047357ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867806996Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4050 out_len=1350 left=1324 [2025-04-30T09:47:34.867809852Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=1324 pn=9 [2025-04-30T09:47:34.867812156Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=8541 len=1318 fin=false [2025-04-30T09:47:34.867818758Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.044843ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.867827755Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1324 [2025-04-30T09:47:34.867830641Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx pkt Short dcid=2b56a9f816c5f55d key_phase=false len=387 pn=10 [2025-04-30T09:47:34.867833015Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd tx frm STREAM id=0 off=9859 len=381 fin=true [2025-04-30T09:47:34.867837283Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd timer=107.047037ms latest_rtt=32.352543ms srtt=32.352543ms min_rtt=32.352543ms rttvar=16.176271ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11213 app_limited=true congestion_recovery_start_time=None Rate { delivered: 778, delivered_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, first_sent_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 24047, is_app_limited: true, interval: 32.352543ms, delivered: 778, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 284, tv_nsec: 621825194 }), send_elapsed: 0ns, ack_elapsed: 32.352543ms, rtt: 32.352543ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 521597, last_update: Instant { tv_sec: 284, tv_nsec: 654510939 }, next_time: Instant { tv_sec: 284, tv_nsec: 654510939 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(0) last_round_min_rtt=18446744073709551615.999999999s current_round_min_rtt=18446744073709551615.999999999s css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=0 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } [2025-04-30T09:47:34.868050430Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd written 11213 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:37814, at: Instant { tv_sec: 284, tv_nsec: 654510939 } }) [2025-04-30T09:47:34.868061711Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.868098290Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.868103329Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.868107036Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.899617316Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.899635309Z TRACE quiche_server] got packet Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false [2025-04-30T09:47:34.899645708Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=34 pn=2 [2025-04-30T09:47:34.899663031Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm ACK delay=21 blocks=[2..2] ecn_counts=None [2025-04-30T09:47:34.899669312Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 2 [2025-04-30T09:47:34.899676676Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=12 [2025-04-30T09:47:34.899696012Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 55 bytes [2025-04-30T09:47:34.899702364Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.899706902Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.899710028Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.901611773Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.901625248Z TRACE quiche_server] got packet Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false [2025-04-30T09:47:34.901632341Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=34 pn=3 [2025-04-30T09:47:34.901639214Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm ACK delay=3 blocks=[2..4] ecn_counts=None [2025-04-30T09:47:34.901643362Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 3 [2025-04-30T09:47:34.901646007Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 4 [2025-04-30T09:47:34.901649754Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=12 [2025-04-30T09:47:34.901662407Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 55 bytes [2025-04-30T09:47:34.901667166Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.901670162Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.901672496Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.903764165Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.903774574Z TRACE quiche_server] got packet Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false [2025-04-30T09:47:34.903780245Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=34 pn=4 [2025-04-30T09:47:34.903785344Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm ACK delay=2 blocks=[2..6] ecn_counts=None [2025-04-30T09:47:34.903788811Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 5 [2025-04-30T09:47:34.903791135Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 6 [2025-04-30T09:47:34.903794381Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=12 [2025-04-30T09:47:34.903804550Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 55 bytes [2025-04-30T09:47:34.903808508Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.903811333Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.903813517Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.905970117Z TRACE quiche_server] got 55 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.905979895Z TRACE quiche_server] got packet Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false [2025-04-30T09:47:34.905985134Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=34 pn=5 [2025-04-30T09:47:34.905990134Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm ACK delay=3 blocks=[2..8] ecn_counts=None [2025-04-30T09:47:34.905993490Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 7 [2025-04-30T09:47:34.906002176Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 8 [2025-04-30T09:47:34.906005583Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm PADDING len=12 [2025-04-30T09:47:34.906015070Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 55 bytes [2025-04-30T09:47:34.906019088Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.906021963Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.906024167Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:34.907471375Z TRACE quiche_server] got 46 bytes from [::ffff:193.167.0.100]:37814 to [::]:443 [2025-04-30T09:47:34.907480421Z TRACE quiche_server] got packet Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false [2025-04-30T09:47:34.907485731Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx pkt Short dcid=0665bec5d634db7ed399691c482fe9541701adbd key_phase=false len=25 pn=6 [2025-04-30T09:47:34.907490731Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm ACK delay=5 blocks=[2..10] ecn_counts=None [2025-04-30T09:47:34.907494117Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 9 [2025-04-30T09:47:34.907496592Z TRACE quiche::recovery::congestion::recovery] 0665bec5d634db7ed399691c482fe9541701adbd packet newly acked 10 [2025-04-30T09:47:34.907500278Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd rx frm APPLICATION_CLOSE err=0 reason=[] [2025-04-30T09:47:34.907513333Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd processed 46 bytes [2025-04-30T09:47:34.907517360Z TRACE quiche_server] recv() would block [2025-04-30T09:47:34.907519705Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:34.907521849Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:35.096764308Z TRACE quiche_server] timed out [2025-04-30T09:47:35.096796908Z TRACE quiche] 0665bec5d634db7ed399691c482fe9541701adbd draining timeout expired [2025-04-30T09:47:35.096847673Z TRACE quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd done writing [2025-04-30T09:47:35.096851751Z TRACE quiche_server] Collecting garbage [2025-04-30T09:47:35.096856259Z INFO quiche_server] 0665bec5d634db7ed399691c482fe9541701adbd connection collected recv=9 sent=11 lost=0 retrans=0 sent_bytes=12181 recv_bytes=2113 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:37814 validation_state=Validated active=true recv=9 sent=11 lost=0 retrans=0 rtt=34.440156ms min_rtt=Some(32.070684ms) rttvar=7.120923ms cwnd=13500 sent_bytes=12181 recv_bytes=2113 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=349633]