[2025-09-12T02:36:10.169089383Z INFO quiche_server] listening on [::]:443 [2025-09-12T02:36:10.169113739Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-09-12T02:36:10.169120241Z TRACE quiche_server] GSO detected: false [2025-09-12T02:36:10.488167191Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:44563 to [::]:443 [2025-09-12T02:36:10.488208949Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-09-12T02:36:10.488216673Z WARN quiche_server] Doing version negotiation [2025-09-12T02:36:10.488293337Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.208881433Z TRACE quiche_server] got 1280 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.208910087Z TRACE quiche_server] got packet Initial version=1 dcid=2853ea863e5dbf9dfea447a5 scid= token= [2025-09-12T02:36:11.208926578Z WARN quiche_server] Doing stateless retry [2025-09-12T02:36:11.208977473Z TRACE quiche_server] got 1280 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.208985999Z TRACE quiche_server] got packet Initial version=1 dcid=2853ea863e5dbf9dfea447a5 scid= token= [2025-09-12T02:36:11.208994075Z WARN quiche_server] Doing stateless retry [2025-09-12T02:36:11.209031224Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.240792215Z TRACE quiche_server] got 1280 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.240808245Z TRACE quiche_server] got packet Initial version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= token=71756963686500000000000000000000ffffc1a700642853ea863e5dbf9dfea447a5 [2025-09-12T02:36:11.240819537Z DEBUG quiche_server] New connection: dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df [2025-09-12T02:36:11.240993032Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Initial version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= token=71756963686500000000000000000000ffffc1a700642853ea863e5dbf9dfea447a5 len=1216 pn=2 [2025-09-12T02:36:11.241007700Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm CRYPTO off=0 len=21 [2025-09-12T02:36:11.241021045Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm CRYPTO off=67 len=1169 [2025-09-12T02:36:11.241045190Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 1280 bytes [2025-09-12T02:36:11.241054548Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.241065699Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Initial version=1 dcid= scid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df len=5 pn=0 [2025-09-12T02:36:11.241069586Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm ACK delay=11 blocks=[2..2] ecn_counts=None [2025-09-12T02:36:11.241081048Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=none latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=0 app_limited=false congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 349, tv_nsec: 898685258 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 898685258 }, end_of_app_limited: 0, last_sent_packet: 0, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 349, tv_nsec: 898685258 }, next_time: Instant { tv_sec: 349, tv_nsec: 898685258 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=None 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-09-12T02:36:11.241134498Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:50995, at: Instant { tv_sec: 349, tv_nsec: 898685258 } }) [2025-09-12T02:36:11.241156540Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.241164434Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.241171999Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.241177068Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.241757148Z TRACE quiche_server] got 1280 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.241767698Z TRACE quiche_server] got packet Initial version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= token=71756963686500000000000000000000ffffc1a700642853ea863e5dbf9dfea447a5 [2025-09-12T02:36:11.241776665Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Initial version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= token=71756963686500000000000000000000ffffc1a700642853ea863e5dbf9dfea447a5 len=1216 pn=3 [2025-09-12T02:36:11.241787004Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm PADDING len=871 [2025-09-12T02:36:11.241790000Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm CRYPTO off=1236 len=270 [2025-09-12T02:36:11.241795090Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm CRYPTO off=63 len=4 [2025-09-12T02:36:11.241798556Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm CRYPTO off=21 len=42 [2025-09-12T02:36:11.241820107Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-09-12T02:36:11.241823423Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-09-12T02:36:11.241908363Z TRACE quiche::tls] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df write message lvl=Initial len=90 [2025-09-12T02:36:11.241933510Z TRACE quiche::tls] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df set write secret lvl=Handshake [2025-09-12T02:36:11.241996157Z TRACE quiche::tls] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df write message lvl=Handshake len=724 [2025-09-12T02:36:11.241998973Z TRACE quiche::tls] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df set write secret lvl=OneRTT [2025-09-12T02:36:11.242005064Z TRACE quiche::tls] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df set read secret lvl=Handshake [2025-09-12T02:36:11.242021756Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 1280 bytes [2025-09-12T02:36:11.242029731Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.242038557Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Initial version=1 dcid= scid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df len=99 pn=1 [2025-09-12T02:36:11.242041513Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm ACK delay=32 blocks=[2..3] ecn_counts=None [2025-09-12T02:36:11.242044879Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm CRYPTO off=0 len=90 [2025-09-12T02:36:11.242052283Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=998.979461ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=146 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 349, tv_nsec: 899659789 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 899659789 }, end_of_app_limited: 1, last_sent_packet: 1, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 349, tv_nsec: 899659789 }, next_time: Instant { tv_sec: 349, tv_nsec: 899659789 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.242073132Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Handshake version=1 dcid= scid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df len=728 pn=2 [2025-09-12T02:36:11.242075947Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm CRYPTO off=0 len=724 [2025-09-12T02:36:11.242081277Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=998.950547ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=920 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 349, tv_nsec: 899659789 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 899659789 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 0, rate_sample: RateSample { bandwidth: 0.00 Kbps, 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: 349, tv_nsec: 899659789 }, next_time: Instant { tv_sec: 349, tv_nsec: 899659789 }, max_datagram_size: 1350, last_packet_size: None, iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.242118437Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:50995, at: Instant { tv_sec: 349, tv_nsec: 899659789 } }) [2025-09-12T02:36:11.242126783Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.242132213Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.242138355Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.242142071Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.275097727Z TRACE quiche_server] got 1280 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.275108878Z TRACE quiche_server] got packet Initial version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= token=71756963686500000000000000000000ffffc1a700642853ea863e5dbf9dfea447a5 [2025-09-12T02:36:11.275116622Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Initial version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= token=71756963686500000000000000000000ffffc1a700642853ea863e5dbf9dfea447a5 len=1130 pn=4 [2025-09-12T02:36:11.275124277Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm ACK delay=0 blocks=[0..1] ecn_counts=None [2025-09-12T02:36:11.275128625Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 0 [2025-09-12T02:36:11.275131220Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 1 [2025-09-12T02:36:11.275138103Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm PADDING len=1107 [2025-09-12T02:36:11.275149945Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Handshake version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= len=57 pn=0 [2025-09-12T02:36:11.275154273Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm CRYPTO off=0 len=36 [2025-09-12T02:36:11.275164041Z TRACE quiche::tls] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df set read secret lvl=OneRTT [2025-09-12T02:36:11.275176435Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df dropped epoch 1 state [2025-09-12T02:36:11.275179891Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df 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: 1452, initial_max_data: 786432, initial_max_stream_data_bidi_local: 524288, initial_max_stream_data_bidi_remote: 524288, initial_max_stream_data_uni: 524288, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 26, disable_active_migration: false, active_conn_id_limit: 4, initial_source_connection_id: Some(), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-09-12T02:36:11.275200349Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df dropped epoch 0 state [2025-09-12T02:36:11.275203235Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 1280 bytes [2025-09-12T02:36:11.275209196Z TRACE quiche_server] got 52 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.275212332Z TRACE quiche_server] got packet Handshake version=1 dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df scid= [2025-09-12T02:36:11.275216410Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df dropped invalid packet [2025-09-12T02:36:11.275218834Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 52 bytes [2025-09-12T02:36:11.275222441Z TRACE quiche_server] got 58 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.275225136Z TRACE quiche_server] got packet Short dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df key_phase=false [2025-09-12T02:36:11.275228933Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Short dcid=98fbf035c5cccad1355b7c76c5d5a69d786ac0df key_phase=false len=37 pn=0 [2025-09-12T02:36:11.275233251Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm STREAM id=0 off=0 len=17 fin=true [2025-09-12T02:36:11.275239162Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 58 bytes [2025-09-12T02:36:11.275241818Z DEBUG quiche_apps::common] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df response stream 0 is writable with capacity Ok(13500) [2025-09-12T02:36:11.275247177Z TRACE quiche_apps::common] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df received 17 bytes [2025-09-12T02:36:11.275249582Z TRACE quiche_apps::common] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df stream 0 has 17 bytes (fin? true) [2025-09-12T02:36:11.275253540Z INFO quiche_apps::common] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df got GET request for "/www/xbqbvjvzrm" on stream 0 [2025-09-12T02:36:11.275273197Z INFO quiche_apps::common] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df sending response of size 10240 on stream 0 [2025-09-12T02:36:11.275280580Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.275290008Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=3 [2025-09-12T02:36:11.275293004Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm ACK delay=7 blocks=[0..0] ecn_counts=None [2025-09-12T02:36:11.275295999Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[af, 7c, 28, e3, 93, 48, 5e, 36, 5f, 91, 45, 15, 50, 15, 9b, bd, b7, 15, 36, b1] reset_token=[0c, 99, 54, c4, 94, 17, f8, d1, 66, b6, fb, 65, 1a, 78, 50, b7] [2025-09-12T02:36:11.275302381Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[36, 44, 86, 8c, 86, 0d, 15, a4, de, a7, 7c, 10, a0, 46, e8, 1b, c5, d7, de, 44] reset_token=[b0, 84, ca, f0, 69, b6, cd, 52, 96, 31, 08, dd, 39, 2d, 91, bc] [2025-09-12T02:36:11.275307932Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[86, c2, 97, 92, 15, 59, 91, 31, 30, fb, e3, 3b, 7a, 73, c1, 54, fe, e9, 69, 01] reset_token=[7e, 6c, 4d, 6c, 64, c2, c7, 6a, f1, 2a, 0b, 09, 56, ab, b9, ab] [2025-09-12T02:36:11.275313372Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm HANDSHAKE_DONE [2025-09-12T02:36:11.275315606Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=0 len=1201 fin=false [2025-09-12T02:36:11.275326046Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.205901ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275346314Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=4 [2025-09-12T02:36:11.275349079Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=1201 len=1326 fin=false [2025-09-12T02:36:11.275354118Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.238884ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275365470Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=5 [2025-09-12T02:36:11.275367915Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=2527 len=1326 fin=false [2025-09-12T02:36:11.275372112Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.241068ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275417057Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=6 [2025-09-12T02:36:11.275419922Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=3853 len=1326 fin=false [2025-09-12T02:36:11.275425072Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.238543ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275435502Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=7 [2025-09-12T02:36:11.275437956Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=5179 len=1326 fin=false [2025-09-12T02:36:11.275442635Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.240807ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275453024Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=8 [2025-09-12T02:36:11.275455479Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=6505 len=1326 fin=false [2025-09-12T02:36:11.275459577Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.241308ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275472731Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1332 pn=9 [2025-09-12T02:36:11.275475236Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=7831 len=1326 fin=false [2025-09-12T02:36:11.275493100Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.227513ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275504371Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=1089 pn=10 [2025-09-12T02:36:11.275506885Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm STREAM id=0 off=9157 len=1083 fin=true [2025-09-12T02:36:11.275511494Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=125.240516ms latest_rtt=33.083115ms srtt=33.083115ms min_rtt=33.083115ms rttvar=16.541557ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10557 app_limited=true congestion_recovery_start_time=None Rate { delivered: 146, delivered_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { bandwidth: 35.30 Kbps, is_app_limited: true, interval: 33.083115ms, delivered: 146, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 899659789 }), send_elapsed: 0ns, ack_elapsed: 33.083115ms, rtt: 33.083115ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 510078, last_update: Instant { tv_sec: 349, tv_nsec: 932910689 }, next_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.275632732Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df written 10557 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:50995, at: Instant { tv_sec: 349, tv_nsec: 932910689 } }) [2025-09-12T02:36:11.275641699Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.275647991Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.275653080Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.275656106Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.307244893Z TRACE quiche_server] got 46 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.307258007Z TRACE quiche_server] got packet Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false [2025-09-12T02:36:11.307265251Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false len=25 pn=1 [2025-09-12T02:36:11.307271042Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df path ID 0 now see SCID with seq num 1 [2025-09-12T02:36:11.307275079Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm ACK delay=16 blocks=[3..3] ecn_counts=None [2025-09-12T02:36:11.307279067Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 3 [2025-09-12T02:36:11.307283525Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm RETIRE_CONNECTION_ID seq_num=0 [2025-09-12T02:36:11.307295838Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 46 bytes [2025-09-12T02:36:11.307299115Z INFO quiche_server] Retiring source CID 98fbf035c5cccad1355b7c76c5d5a69d786ac0df [2025-09-12T02:36:11.307306017Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.307313712Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx pkt Short dcid= key_phase=false len=45 pn=11 [2025-09-12T02:36:11.307316808Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm ACK delay=5 blocks=[1..1] ecn_counts=None [2025-09-12T02:36:11.307319814Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=1 conn_id=[f4, 28, cc, 04, 0d, 21, c3, 89, 9b, c2, df, 72, 33, 7a, 59, 0f, 8a, d1, b8, 6c] reset_token=[af, 6a, 98, 27, 2c, 45, 02, 1a, 12, c9, 63, 24, 57, ad, a9, 73] [2025-09-12T02:36:11.307331115Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df timer=109.648988ms latest_rtt=31.980874ms srtt=32.945334ms min_rtt=31.980874ms rttvar=12.681727ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9270 app_limited=true congestion_recovery_start_time=None Rate { delivered: 1496, delivered_time: Instant { tv_sec: 349, tv_nsec: 964891563 }, first_sent_time: Instant { tv_sec: 349, tv_nsec: 932910689 }, end_of_app_limited: 4, last_sent_packet: 11, largest_acked: 3, rate_sample: RateSample { bandwidth: 337.70 Kbps, is_app_limited: true, interval: 31.980874ms, delivered: 1350, prior_delivered: 146, prior_time: Some(Instant { tv_sec: 349, tv_nsec: 932910689 }), send_elapsed: 0ns, ack_elapsed: 31.980874ms, rtt: 31.980874ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 512212, last_update: Instant { tv_sec: 349, tv_nsec: 964935986 }, next_time: Instant { tv_sec: 349, tv_nsec: 964935986 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(1) 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-09-12T02:36:11.307387701Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df written 63 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:50995, at: Instant { tv_sec: 349, tv_nsec: 964935986 } }) [2025-09-12T02:36:11.307406697Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.307412888Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.307418539Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.307421905Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.309298752Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.309311285Z TRACE quiche_server] got packet Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false [2025-09-12T02:36:11.309317136Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false len=23 pn=2 [2025-09-12T02:36:11.309322837Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm ACK delay=5 blocks=[3..5] ecn_counts=None [2025-09-12T02:36:11.309328598Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 4 [2025-09-12T02:36:11.309332505Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 5 [2025-09-12T02:36:11.309347023Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 44 bytes [2025-09-12T02:36:11.309351541Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.309354978Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.309357412Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.311566523Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.311579387Z TRACE quiche_server] got packet Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false [2025-09-12T02:36:11.311586521Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false len=23 pn=3 [2025-09-12T02:36:11.311593724Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm ACK delay=5 blocks=[3..7] ecn_counts=None [2025-09-12T02:36:11.311598183Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 6 [2025-09-12T02:36:11.311601299Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 7 [2025-09-12T02:36:11.311615375Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 44 bytes [2025-09-12T02:36:11.311620655Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.311624993Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.311628129Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.313704809Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.313718615Z TRACE quiche_server] got packet Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false [2025-09-12T02:36:11.313725258Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false len=23 pn=4 [2025-09-12T02:36:11.313731279Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm ACK delay=5 blocks=[3..9] ecn_counts=None [2025-09-12T02:36:11.313735066Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 8 [2025-09-12T02:36:11.313737601Z TRACE quiche::recovery::congestion::recovery] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df packet newly acked 9 [2025-09-12T02:36:11.313749233Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 44 bytes [2025-09-12T02:36:11.313753731Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.313757268Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.313759803Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.314643997Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:50995 to [::]:443 [2025-09-12T02:36:11.314660588Z TRACE quiche_server] got packet Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false [2025-09-12T02:36:11.314678211Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx pkt Short dcid=af7c28e393485e365f91451550159bbdb71536b1 key_phase=false len=21 pn=5 [2025-09-12T02:36:11.314686747Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df rx frm APPLICATION_CLOSE err=0 reason=[] [2025-09-12T02:36:11.314696786Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df processed 42 bytes [2025-09-12T02:36:11.314702637Z TRACE quiche_server] recv() would block [2025-09-12T02:36:11.314705973Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.314709369Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.505938690Z TRACE quiche_server] timed out [2025-09-12T02:36:11.505965270Z TRACE quiche] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df draining timeout expired [2025-09-12T02:36:11.506006187Z TRACE quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df done writing [2025-09-12T02:36:11.506012389Z TRACE quiche_server] Collecting garbage [2025-09-12T02:36:11.506019392Z INFO quiche_server] 98fbf035c5cccad1355b7c76c5d5a69d786ac0df connection collected recv=10 sent=12 lost=0 retrans=0 sent_bytes=11592 recv_bytes=4118 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:50995 validation_state=Validated active=true recv=10 sent=12 lost=0 retrans=0 rtt=34.090398ms min_rtt=Some(31.980874ms) rttvar=7.326502ms cwnd=13500 sent_bytes=11592 recv_bytes=4118 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=245829]