[2025-04-30T10:14:52.594005559Z INFO quiche_server] listening on [::]:443 [2025-04-30T10:14:52.594033311Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE [2025-04-30T10:14:52.594040875Z TRACE quiche_server] GSO detected: false [2025-04-30T10:14:53.374053654Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:37775 to [::]:443 [2025-04-30T10:14:53.374091214Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:14:53.374099891Z WARN quiche_server] Doing version negotiation [2025-04-30T10:14:53.374214275Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:37775 to [::]:443 [2025-04-30T10:14:53.374222861Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:14:53.374226808Z WARN quiche_server] Doing version negotiation [2025-04-30T10:14:53.374249321Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:37775 to [::]:443 [2025-04-30T10:14:53.374256654Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token= [2025-04-30T10:14:53.374261954Z WARN quiche_server] Doing version negotiation [2025-04-30T10:14:53.374294645Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.696984840Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.697006881Z TRACE quiche_server] got packet Initial version=1 dcid=0cedf8f2ec053c1442133725d7364196d617 scid=1b104131fb6e5f5f004e3ea98ec40d279a token= [2025-04-30T10:14:53.697016209Z WARN quiche_server] Doing stateless retry [2025-04-30T10:14:53.697070220Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.729028155Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.729054394Z TRACE quiche_server] got packet Initial version=1 dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 scid=1b104131fb6e5f5f004e3ea98ec40d279a token=71756963686500000000000000000000ffffc1a700640cedf8f2ec053c1442133725d7364196d617 [2025-04-30T10:14:53.729068210Z DEBUG quiche_server] New connection: dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 scid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 [2025-04-30T10:14:53.729303451Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Initial version=1 dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 scid=1b104131fb6e5f5f004e3ea98ec40d279a token=71756963686500000000000000000000ffffc1a700640cedf8f2ec053c1442133725d7364196d617 len=1111 pn=1426644399 [2025-04-30T10:14:53.729319621Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm CRYPTO off=0 len=263 [2025-04-30T10:14:53.729348675Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3") [2025-04-30T10:14:53.729353344Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop") [2025-04-30T10:14:53.729453231Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 write message lvl=Initial len=90 [2025-04-30T10:14:53.729487585Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 set write secret lvl=Handshake [2025-04-30T10:14:53.729562516Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 write message lvl=Handshake len=730 [2025-04-30T10:14:53.729566202Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 set write secret lvl=OneRTT [2025-04-30T10:14:53.729573877Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 set read secret lvl=Handshake [2025-04-30T10:14:53.729594876Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm PADDING len=824 [2025-04-30T10:14:53.729618340Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 1200 bytes [2025-04-30T10:14:53.729637476Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.729651923Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Initial version=1 dcid=1b104131fb6e5f5f004e3ea98ec40d279a scid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 len=106 pn=0 [2025-04-30T10:14:53.729655900Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm ACK delay=45 blocks=[1426644399..1426644399] ecn_counts=None [2025-04-30T10:14:53.729669626Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm CRYPTO off=0 len=90 [2025-04-30T10:14:53.729680456Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=998.958963ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=170 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 383, tv_nsec: 954794263 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 954794263 }, 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: 383, tv_nsec: 954794263 }, next_time: Instant { tv_sec: 383, tv_nsec: 954794263 }, 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:14:53.729705032Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Handshake version=1 dcid=1b104131fb6e5f5f004e3ea98ec40d279a scid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 len=734 pn=1 [2025-04-30T10:14:53.729708479Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm CRYPTO off=0 len=730 [2025-04-30T10:14:53.729715061Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=998.924909ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=967 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 383, tv_nsec: 954794263 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 954794263 }, 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: 383, tv_nsec: 954794263 }, next_time: Instant { tv_sec: 383, tv_nsec: 954794263 }, 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:14:53.729777097Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:45898, at: Instant { tv_sec: 383, tv_nsec: 954794263 } }) [2025-04-30T10:14:53.729784120Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.729789590Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.729794059Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.729796954Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.764173951Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.764198337Z TRACE quiche_server] got packet Initial version=1 dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 scid=1b104131fb6e5f5f004e3ea98ec40d279a token=71756963686500000000000000000000ffffc1a700640cedf8f2ec053c1442133725d7364196d617 [2025-04-30T10:14:53.764214978Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Initial version=1 dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 scid=1b104131fb6e5f5f004e3ea98ec40d279a token=71756963686500000000000000000000ffffc1a700640cedf8f2ec053c1442133725d7364196d617 len=22 pn=1426644400 [2025-04-30T10:14:53.764236338Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm ACK delay=0 blocks=[0..0] ecn_counts=None [2025-04-30T10:14:53.764243982Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 0 [2025-04-30T10:14:53.764270001Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Handshake version=1 dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 scid=1b104131fb6e5f5f004e3ea98ec40d279a len=64 pn=1426644398 [2025-04-30T10:14:53.764276653Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm ACK delay=0 blocks=[1..1] ecn_counts=None [2025-04-30T10:14:53.764280150Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 1 [2025-04-30T10:14:53.764284007Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm CRYPTO off=0 len=36 [2025-04-30T10:14:53.764302512Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 set read secret lvl=OneRTT [2025-04-30T10:14:53.764340673Z TRACE quiche::tls] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 write message lvl=OneRTT len=396 [2025-04-30T10:14:53.764350722Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 dropped epoch 1 state [2025-04-30T10:14:53.764355090Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 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(1b104131fb6e5f5f004e3ea98ec40d279a), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None } [2025-04-30T10:14:53.764377693Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 dropped epoch 0 state [2025-04-30T10:14:53.764381419Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=956 pn=1426644398 [2025-04-30T10:14:53.764389334Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[8f, 2c, 82, 3d, ee, f0, 24, 33, 75, 4b, ac, 22, c4, 44, fa, 2e, bb] reset_token=[bc, 68, 68, 42, 08, c7, fd, a3, 6a, be, 82, 1a, b1, 08, d2, a1] [2025-04-30T10:14:53.764398281Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[25, ac, 60, 84, 4e, 47, e6, 06, 95, 04, 66, be, c6, f7, 72, b1, 71] reset_token=[f8, 8f, 33, 5b, 6b, 42, 9c, 15, 36, 38, 1a, 8c, f7, d3, 75, 71] [2025-04-30T10:14:53.764404813Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[b1, 0b, 63, 8a, 66, 70, ce, 05, a8, 12, aa, 8e, 25, ac, ec, 85, 98] reset_token=[3a, 37, 74, b6, 14, a1, 56, 6b, 16, 70, e2, 7b, 3c, b4, 57, 38] [2025-04-30T10:14:53.764410955Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[7b, 52, ac, 88, 49, c9, f6, fe, 5c, a5, a1, 7a, 66, 3d, e6, ec, c2] reset_token=[80, 4c, 5c, 5a, 35, 72, 45, 63, df, 60, 66, 51, db, c0, d7, f4] [2025-04-30T10:14:53.764418008Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c3, e2, 84, 08, b7, d5, ed, df, 57, e7, aa, 90, 5c, a7, 8c, ac, c8] reset_token=[cc, c8, 8c, e9, ae, 95, db, 37, 8c, fe, b5, e7, 54, 6f, a4, 85] [2025-04-30T10:14:53.764424580Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[f2, e6, d6, 84, 99, d0, 28, 51, 79, 26, 30, 25, 81, 4a, 2f, c8, 5b] reset_token=[8e, 24, ed, 69, 0d, 86, b3, 9f, a3, b5, a0, 09, d4, 67, 5e, 3a] [2025-04-30T10:14:53.764435791Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[5f, ce, 8b, 63, 96, 89, ef, 6c, 1a, 77, 05, 72, 78, 6c, 3d, 7e, 28] reset_token=[af, 73, 78, 7c, b1, 41, 93, 3c, 2a, 38, 56, dd, 4e, 40, 5c, 77] [2025-04-30T10:14:53.764441111Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm STREAM id=0 off=0 len=17 fin=true [2025-04-30T10:14:53.764448555Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm PADDING len=657 [2025-04-30T10:14:53.764460007Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 1200 bytes [2025-04-30T10:14:53.764464605Z DEBUG quiche_apps::common] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 response stream 0 is writable with capacity Ok(13500) [2025-04-30T10:14:53.764472270Z TRACE quiche_apps::common] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 received 17 bytes [2025-04-30T10:14:53.764475445Z TRACE quiche_apps::common] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 stream 0 has 17 bytes (fin? true) [2025-04-30T10:14:53.764481096Z INFO quiche_apps::common] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 got GET request for "/www/xcpqmznjsh" on stream 0 [2025-04-30T10:14:53.764512735Z INFO quiche_apps::common] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 sending response of size 10240 on stream 0 [2025-04-30T10:14:53.764522734Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.764532071Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1303 [2025-04-30T10:14:53.764543954Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=2 [2025-04-30T10:14:53.764547660Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm ACK delay=18 blocks=[1426644398..1426644398] ecn_counts=None [2025-04-30T10:14:53.764551498Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[a2, 2a, ae, c6, b2, 9a, e5, 57, 1e, 2f, 66, 03, f5, f3, 85, 28, 34, d9, e9, 7a] reset_token=[41, bc, 6d, 19, 79, 2b, 80, 29, f0, d1, d6, 64, e0, 74, db, 28] [2025-04-30T10:14:53.764558331Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[1c, 32, 2e, 32, fe, d5, 0b, 08, c3, 88, cc, 29, e4, ea, 0a, 90, 71, af, 66, be] reset_token=[37, 78, 5d, 9d, fe, 76, af, 35, 59, 18, 58, d8, 9b, 7e, a7, 49] [2025-04-30T10:14:53.764564743Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[1d, ef, 59, 24, f8, d9, 07, b6, d3, 60, 0c, 56, 9c, c2, 14, 3a, 48, 6b, 53, 5e] reset_token=[4a, c4, dd, 3b, 45, 53, bf, b1, 1d, 29, 58, fa, 7e, e4, 76, e1] [2025-04-30T10:14:53.764570984Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[31, b7, ea, e6, fc, 72, 4e, ea, 23, 03, d0, 27, 2c, 04, b1, 0b, 9a, 26, 2c, ad] reset_token=[32, bc, f2, fa, d0, ae, c7, 03, 39, fc, e7, d9, db, 47, 3b, 3e] [2025-04-30T10:14:53.764577356Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[83, 7d, 66, 57, 65, 48, f1, c4, 43, 22, 66, af, a6, 41, b6, 39, ee, ea, c6, 9f] reset_token=[36, f9, 03, a9, 5c, fb, c3, 81, 0e, 54, e0, f8, f9, 06, 57, 7d] [2025-04-30T10:14:53.764583578Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[3d, ce, fc, dc, 17, 70, a3, bc, d9, c2, e4, 77, f3, 6f, 54, 41, e9, 8d, 15, c6] reset_token=[78, 80, fb, 11, 49, f2, ca, 49, 90, a2, 95, 25, c0, ad, 1a, 6c] [2025-04-30T10:14:53.764589529Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm HANDSHAKE_DONE [2025-04-30T10:14:53.764592344Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm CRYPTO off=0 len=396 [2025-04-30T10:14:53.764595290Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=0 len=657 fin=false [2025-04-30T10:14:53.764615317Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.40202ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764635896Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1315 [2025-04-30T10:14:53.764640374Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=3 [2025-04-30T10:14:53.764643480Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=657 len=1309 fin=false [2025-04-30T10:14:53.764671783Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.453377ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764685919Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1315 [2025-04-30T10:14:53.764689737Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=4 [2025-04-30T10:14:53.764692692Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=1966 len=1309 fin=false [2025-04-30T10:14:53.764698643Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.477211ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764715926Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1315 [2025-04-30T10:14:53.764719813Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=5 [2025-04-30T10:14:53.764722748Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=3275 len=1309 fin=false [2025-04-30T10:14:53.764728138Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.478123ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764741794Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1315 [2025-04-30T10:14:53.764744629Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=6 [2025-04-30T10:14:53.764746944Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=4584 len=1309 fin=false [2025-04-30T10:14:53.764751192Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.481449ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764764477Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=6750 out_len=1350 left=1315 [2025-04-30T10:14:53.764767402Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=7 [2025-04-30T10:14:53.764769726Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=5893 len=1309 fin=false [2025-04-30T10:14:53.764773924Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.481218ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764784494Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5400 out_len=1350 left=1315 [2025-04-30T10:14:53.764787550Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=8 [2025-04-30T10:14:53.764789894Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=7202 len=1309 fin=false [2025-04-30T10:14:53.764794092Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.481158ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764804512Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4050 out_len=1350 left=1315 [2025-04-30T10:14:53.764810192Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=1315 pn=9 [2025-04-30T10:14:53.764812587Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=8511 len=1309 fin=false [2025-04-30T10:14:53.764816754Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.478594ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.764827334Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1315 [2025-04-30T10:14:53.764830169Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=426 pn=10 [2025-04-30T10:14:53.764832544Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm STREAM id=0 off=9820 len=420 fin=true [2025-04-30T10:14:53.764836782Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.481378ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11261 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.765040453Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 written 11261 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:45898, at: Instant { tv_sec: 383, tv_nsec: 989679672 } }) [2025-04-30T10:14:53.765054069Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.765061673Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.765066852Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.765076821Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.765231300Z TRACE quiche_server] got 1342 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.765238364Z TRACE quiche_server] got packet Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false [2025-04-30T10:14:53.765244796Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=1321 pn=1426644399 [2025-04-30T10:14:53.765250757Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm PING mtu_probe=None [2025-04-30T10:14:53.765257039Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm PADDING len=1300 [2025-04-30T10:14:53.765263741Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 1342 bytes [2025-04-30T10:14:53.765268059Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.765273610Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2239 out_len=1350 left=1303 [2025-04-30T10:14:53.765276906Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx pkt Short dcid=1b104131fb6e5f5f004e3ea98ec40d279a key_phase=false len=12 pn=11 [2025-04-30T10:14:53.765279401Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 tx frm ACK delay=3 blocks=[1426644398..1426644399] ecn_counts=None [2025-04-30T10:14:53.765286334Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 timer=111.031717ms latest_rtt=34.628788ms srtt=34.578021ms min_rtt=34.57077ms rttvar=12.978542ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11261 app_limited=true congestion_recovery_start_time=None Rate { delivered: 967, delivered_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, first_sent_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, end_of_app_limited: 3, last_sent_packet: 11, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27971, is_app_limited: true, interval: 34.57077ms, delivered: 967, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 383, tv_nsec: 954794263 }), send_elapsed: 0ns, ack_elapsed: 34.57077ms, rtt: 34.57077ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 488026, last_update: Instant { tv_sec: 383, tv_nsec: 989679672 }, next_time: Instant { tv_sec: 383, tv_nsec: 989679672 }, 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:14:53.765321469Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 written 47 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:45898, at: Instant { tv_sec: 383, tv_nsec: 989679672 } }) [2025-04-30T10:14:53.765326409Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.765331027Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.765335866Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.765339513Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.797646214Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.797674697Z TRACE quiche_server] got packet Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false [2025-04-30T10:14:53.797686650Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=22 pn=1426644400 [2025-04-30T10:14:53.797698211Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm ACK delay=5 blocks=[2..3] ecn_counts=None [2025-04-30T10:14:53.797704303Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 2 [2025-04-30T10:14:53.797709673Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 3 [2025-04-30T10:14:53.797743426Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 43 bytes [2025-04-30T10:14:53.797750249Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.797754597Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.797757131Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.799754390Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.799765662Z TRACE quiche_server] got packet Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false [2025-04-30T10:14:53.799771913Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=22 pn=1426644401 [2025-04-30T10:14:53.799778746Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm ACK delay=5 blocks=[2..5] ecn_counts=None [2025-04-30T10:14:53.799782864Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 4 [2025-04-30T10:14:53.799785469Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 5 [2025-04-30T10:14:53.799796409Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 43 bytes [2025-04-30T10:14:53.799800587Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.799803513Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.799805997Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.801966251Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.801978835Z TRACE quiche_server] got packet Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false [2025-04-30T10:14:53.801984576Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=22 pn=1426644402 [2025-04-30T10:14:53.801990727Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm ACK delay=5 blocks=[2..7] ecn_counts=None [2025-04-30T10:14:53.801994664Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 6 [2025-04-30T10:14:53.801997369Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 7 [2025-04-30T10:14:53.802012768Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 43 bytes [2025-04-30T10:14:53.802019521Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.802023208Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.802025492Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.804270397Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.804285245Z TRACE quiche_server] got packet Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false [2025-04-30T10:14:53.804294112Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=22 pn=1426644403 [2025-04-30T10:14:53.804313438Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm ACK delay=6 blocks=[2..9] ecn_counts=None [2025-04-30T10:14:53.804318688Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 8 [2025-04-30T10:14:53.804322925Z TRACE quiche::recovery::congestion::recovery] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 packet newly acked 9 [2025-04-30T10:14:53.804372518Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 43 bytes [2025-04-30T10:14:53.804381485Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.804385643Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.804388749Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.804611130Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:45898 to [::]:443 [2025-04-30T10:14:53.804631829Z TRACE quiche_server] got packet Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false [2025-04-30T10:14:53.804640394Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx pkt Short dcid=0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 key_phase=false len=21 pn=1426644404 [2025-04-30T10:14:53.804648660Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[] [2025-04-30T10:14:53.804660102Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 processed 42 bytes [2025-04-30T10:14:53.804666153Z TRACE quiche_server] recv() would block [2025-04-30T10:14:53.804669369Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.804672565Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.984891411Z TRACE quiche_server] timed out [2025-04-30T10:14:53.984928230Z TRACE quiche] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 draining timeout expired [2025-04-30T10:14:53.984981109Z TRACE quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 done writing [2025-04-30T10:14:53.984986619Z TRACE quiche_server] Collecting garbage [2025-04-30T10:14:53.984992160Z INFO quiche_server] 0c0876bd1d76efc4b6af16a4e899b935cf1f6dc0 connection collected recv=10 sent=12 lost=0 retrans=0 sent_bytes=12275 recv_bytes=3956 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:45898 validation_state=Validated active=true recv=10 sent=12 lost=0 retrans=0 rtt=35.472297ms min_rtt=Some(33.157694ms) rttvar=6.12966ms cwnd=13500 sent_bytes=12275 recv_bytes=3956 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=325716]