[2025-12-13T09:50:23.009381220Z INFO  quiche_server] listening on [::]:443
[2025-12-13T09:50:23.009404434Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-12-13T09:50:23.009411227Z TRACE quiche_server] GSO detected: false
[2025-12-13T09:50:23.349956465Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:44461 to [::]:443
[2025-12-13T09:50:23.350002671Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-12-13T09:50:23.350011808Z WARN  quiche_server] Doing version negotiation
[2025-12-13T09:50:23.350123758Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.052268780Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:49996 to [::]:443
[2025-12-13T09:50:24.052295891Z TRACE quiche_server] got packet Initial version=1 dcid=3b42c1a922fcfaab940cb319aa scid=597bbdcc41a18460 token=
[2025-12-13T09:50:24.052313684Z DEBUG quiche_server] New connection: dcid=3b42c1a922fcfaab940cb319aa scid=1995e6f518c54d8d538dac1132b30501337e5cbf
[2025-12-13T09:50:24.052496577Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Initial version=1 dcid=3b42c1a922fcfaab940cb319aa scid=597bbdcc41a18460 token= len=1169 pn=0 
[2025-12-13T09:50:24.052515232Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm CRYPTO off=0 len=248
[2025-12-13T09:50:24.052543725Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-12-13T09:50:24.052548684Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-12-13T09:50:24.052649403Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf write message lvl=Initial len=90
[2025-12-13T09:50:24.052680270Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf set write secret lvl=Handshake
[2025-12-13T09:50:24.052755642Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf write message lvl=Handshake len=698
[2025-12-13T09:50:24.052760110Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf set write secret lvl=OneRTT
[2025-12-13T09:50:24.052768626Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf set read secret lvl=Handshake
[2025-12-13T09:50:24.052790597Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm PADDING len=900
[2025-12-13T09:50:24.052812548Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf processed 1200 bytes
[2025-12-13T09:50:24.052833918Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.052849768Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Initial version=1 dcid=597bbdcc41a18460 scid=1995e6f518c54d8d538dac1132b30501337e5cbf len=99 pn=0 
[2025-12-13T09:50:24.052854767Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm ACK delay=46 blocks=[0..0] ecn_counts=None
[2025-12-13T09:50:24.052860538Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm CRYPTO off=0 len=90
[2025-12-13T09:50:24.052871278Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=998.965385ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=154 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 244, tv_nsec: 962746949 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 962746949 }, end_of_app_limited: 1, 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: 244, tv_nsec: 962746949 }, next_time: Instant { tv_sec: 244, tv_nsec: 962746949 }, 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-12-13T09:50:24.052906674Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Handshake version=1 dcid=597bbdcc41a18460 scid=1995e6f518c54d8d538dac1132b30501337e5cbf len=702 pn=1 
[2025-12-13T09:50:24.052911143Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm CRYPTO off=0 len=698
[2025-12-13T09:50:24.052918487Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=998.918618ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=910 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 244, tv_nsec: 962746949 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 962746949 }, 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: 244, tv_nsec: 962746949 }, next_time: Instant { tv_sec: 244, tv_nsec: 962746949 }, 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-12-13T09:50:24.052968931Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49996, at: Instant { tv_sec: 244, tv_nsec: 962746949 } })
[2025-12-13T09:50:24.052976685Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.052982246Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.052987285Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.052991103Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.086842302Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:49996 to [::]:443
[2025-12-13T09:50:24.086858753Z TRACE quiche_server] got packet Initial version=1 dcid=1995e6f518c54d8d538dac1132b30501337e5cbf scid=597bbdcc41a18460 token=
[2025-12-13T09:50:24.086869002Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Initial version=1 dcid=1995e6f518c54d8d538dac1132b30501337e5cbf scid=597bbdcc41a18460 token= len=969 pn=1 
[2025-12-13T09:50:24.086878329Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm ACK delay=166 blocks=[0..0] ecn_counts=None
[2025-12-13T09:50:24.086884170Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 0
[2025-12-13T09:50:24.086893959Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm PADDING len=945
[2025-12-13T09:50:24.086911621Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Handshake version=1 dcid=1995e6f518c54d8d538dac1132b30501337e5cbf scid=597bbdcc41a18460 len=62 pn=2 
[2025-12-13T09:50:24.086918204Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm ACK delay=85 blocks=[1..1] ecn_counts=None
[2025-12-13T09:50:24.086922382Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 1
[2025-12-13T09:50:24.086927291Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm CRYPTO off=0 len=36
[2025-12-13T09:50:24.086941537Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf set read secret lvl=OneRTT
[2025-12-13T09:50:24.086975371Z TRACE quiche::tls] 1995e6f518c54d8d538dac1132b30501337e5cbf write message lvl=OneRTT len=396
[2025-12-13T09:50:24.086984728Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf dropped epoch 1 state
[2025-12-13T09:50:24.086989598Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf 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: 15728640, initial_max_stream_data_bidi_local: 6291456, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 32768, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(597bbdcc41a18460), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-12-13T09:50:24.087019834Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf dropped epoch 0 state
[2025-12-13T09:50:24.087024513Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false len=73 pn=3 
[2025-12-13T09:50:24.087032347Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[8e, a8, 9e, 12, d8, 05, f4, 81] reset_token=[05, 9a, df, 9f, c4, 7d, 8b, 6d, d2, 41, a1, 05, 54, e0, 43, b5]
[2025-12-13T09:50:24.087040182Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm STREAM id=0 off=0 len=25 fin=true
[2025-12-13T09:50:24.087049740Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf processed 1200 bytes
[2025-12-13T09:50:24.087054809Z DEBUG quiche_apps::common] 1995e6f518c54d8d538dac1132b30501337e5cbf response stream 0 is writable with capacity Ok(13500)
[2025-12-13T09:50:24.087062925Z TRACE quiche_apps::common] 1995e6f518c54d8d538dac1132b30501337e5cbf received 25 bytes
[2025-12-13T09:50:24.087066692Z TRACE quiche_apps::common] 1995e6f518c54d8d538dac1132b30501337e5cbf stream 0 has 25 bytes (fin? true)
[2025-12-13T09:50:24.087072513Z INFO  quiche_apps::common] 1995e6f518c54d8d538dac1132b30501337e5cbf got GET request for "/www/excited-wet-camera" on stream 0
[2025-12-13T09:50:24.087126474Z INFO  quiche_apps::common] 1995e6f518c54d8d538dac1132b30501337e5cbf sending response of size 5120 on stream 0
[2025-12-13T09:50:24.087138967Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.087154436Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Short dcid=597bbdcc41a18460 key_phase=false len=1324 pn=2 
[2025-12-13T09:50:24.087159095Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm ACK delay=15 blocks=[3..3] ecn_counts=None
[2025-12-13T09:50:24.087163744Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[bc, 49, e6, 64, 45, 0d, 11, 2d, 07, 76, a8, 55, 7b, 5f, 67, f5, 41, 98, 82, 75] reset_token=[77, 50, 57, 06, 0d, 90, 63, ac, 06, fa, 97, 08, ce, 18, 4e, fe]
[2025-12-13T09:50:24.087172810Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[3c, 26, 4c, 79, bb, ae, df, 83, b6, ca, 87, b8, fd, 9a, af, 5d, a4, 98, 43, f9] reset_token=[5e, b2, f3, 1c, cb, 71, 1c, 73, 64, 91, ab, d3, 92, 61, bd, 21]
[2025-12-13T09:50:24.087180705Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[e7, 8f, d7, a6, 10, df, 36, ac, 62, c2, e7, 82, b5, 2b, 7d, ba, 28, 09, c6, 89] reset_token=[f9, 73, 96, ff, ca, cc, 39, b8, 92, 16, 7c, 94, 72, b3, 3e, b8]
[2025-12-13T09:50:24.087188430Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[57, c5, 1f, 08, 94, 25, 38, 97, 89, 4b, 16, bd, ea, 76, 19, f7, 2b, 81, 94, ec] reset_token=[43, 95, a0, aa, 81, 47, 0e, 53, fc, e7, b1, 76, 0b, 06, 99, 1a]
[2025-12-13T09:50:24.087196354Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[e0, 88, 24, 2f, d7, 1a, 44, d8, e1, 7d, c4, 49, 8c, 3e, 64, a0, f4, ed, ea, 41] reset_token=[6a, 14, ea, 2a, 5a, 7d, ab, 03, 4f, 9f, 80, e5, a9, f6, 4f, 9e]
[2025-12-13T09:50:24.087203969Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[e5, 49, dd, c8, c6, f2, aa, 26, ba, ab, ea, c3, ed, d4, 16, d2, d4, b6, ec, f5] reset_token=[c9, 4f, 52, 50, fe, 5a, 4c, 9f, 4a, 7a, e4, ba, 36, a0, 9e, cb]
[2025-12-13T09:50:24.087217023Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[d8, df, 03, 5c, 25, 8b, 50, b3, 49, 4a, 7f, 85, 6a, 93, be, 9a, 08, 03, b8, 73] reset_token=[5a, d9, bb, be, fd, 4e, b3, 4a, 61, 12, 17, d7, 70, 14, e7, 2d]
[2025-12-13T09:50:24.087224848Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm HANDSHAKE_DONE
[2025-12-13T09:50:24.087228314Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm CRYPTO off=0 len=396
[2025-12-13T09:50:24.087231921Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm STREAM id=0 off=0 len=633 fin=false
[2025-12-13T09:50:24.087248142Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=110.014495ms latest_rtt=34.072884ms srtt=34.033925ms min_rtt=34.028361ms rttvar=12.771765ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 910, delivered_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { bandwidth: 213.66 Kbps, is_app_limited: true, interval: 34.072884ms, delivered: 910, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 244, tv_nsec: 962746949 }), send_elapsed: 0ns, ack_elapsed: 34.072884ms, rtt: 34.072884ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 495828, last_update: Instant { tv_sec: 244, tv_nsec: 997051707 }, next_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, 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-12-13T09:50:24.087271666Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Short dcid=597bbdcc41a18460 key_phase=false len=1324 pn=3 
[2025-12-13T09:50:24.087275934Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm STREAM id=0 off=633 len=1318 fin=false
[2025-12-13T09:50:24.087282957Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=110.105916ms latest_rtt=34.072884ms srtt=34.033925ms min_rtt=34.028361ms rttvar=12.771765ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 910, delivered_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { bandwidth: 213.66 Kbps, is_app_limited: true, interval: 34.072884ms, delivered: 910, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 244, tv_nsec: 962746949 }), send_elapsed: 0ns, ack_elapsed: 34.072884ms, rtt: 34.072884ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 495828, last_update: Instant { tv_sec: 244, tv_nsec: 997051707 }, next_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, 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-12-13T09:50:24.087300670Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Short dcid=597bbdcc41a18460 key_phase=false len=1324 pn=4 
[2025-12-13T09:50:24.087304517Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm STREAM id=0 off=1951 len=1318 fin=false
[2025-12-13T09:50:24.087314847Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=110.104114ms latest_rtt=34.072884ms srtt=34.033925ms min_rtt=34.028361ms rttvar=12.771765ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 910, delivered_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { bandwidth: 213.66 Kbps, is_app_limited: true, interval: 34.072884ms, delivered: 910, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 244, tv_nsec: 962746949 }), send_elapsed: 0ns, ack_elapsed: 34.072884ms, rtt: 34.072884ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 495828, last_update: Instant { tv_sec: 244, tv_nsec: 997051707 }, next_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, 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-12-13T09:50:24.087331908Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Short dcid=597bbdcc41a18460 key_phase=false len=1324 pn=5 
[2025-12-13T09:50:24.087335715Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm STREAM id=0 off=3269 len=1318 fin=false
[2025-12-13T09:50:24.087341847Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=110.108431ms latest_rtt=34.072884ms srtt=34.033925ms min_rtt=34.028361ms rttvar=12.771765ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 910, delivered_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { bandwidth: 213.66 Kbps, is_app_limited: true, interval: 34.072884ms, delivered: 910, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 244, tv_nsec: 962746949 }), send_elapsed: 0ns, ack_elapsed: 34.072884ms, rtt: 34.072884ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 495828, last_update: Instant { tv_sec: 244, tv_nsec: 997051707 }, next_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, 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-12-13T09:50:24.087358268Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx pkt Short dcid=597bbdcc41a18460 key_phase=false len=539 pn=6 
[2025-12-13T09:50:24.087362085Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf tx frm STREAM id=0 off=4587 len=533 fin=true
[2025-12-13T09:50:24.087368747Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf timer=110.108211ms latest_rtt=34.072884ms srtt=34.033925ms min_rtt=34.028361ms rttvar=12.771765ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5965 app_limited=true congestion_recovery_start_time=None Rate { delivered: 910, delivered_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, first_sent_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { bandwidth: 213.66 Kbps, is_app_limited: true, interval: 34.072884ms, delivered: 910, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 244, tv_nsec: 962746949 }), send_elapsed: 0ns, ack_elapsed: 34.072884ms, rtt: 34.072884ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 495828, last_update: Instant { tv_sec: 244, tv_nsec: 997051707 }, next_time: Instant { tv_sec: 244, tv_nsec: 997051707 }, 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-12-13T09:50:24.087453206Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf written 5965 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:49996, at: Instant { tv_sec: 244, tv_nsec: 997051707 } })
[2025-12-13T09:50:24.087461110Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.087466340Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.087470528Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.087473964Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.120151830Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:49996 to [::]:443
[2025-12-13T09:50:24.120167669Z TRACE quiche_server] got packet Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false
[2025-12-13T09:50:24.120177137Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false len=23 pn=4 
[2025-12-13T09:50:24.120186545Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm ACK delay=4 blocks=[2..3] ecn_counts=None
[2025-12-13T09:50:24.120191685Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 2
[2025-12-13T09:50:24.120195702Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 3
[2025-12-13T09:50:24.120243261Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf processed 44 bytes
[2025-12-13T09:50:24.120250725Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.120255273Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.120258189Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.122326502Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:49996 to [::]:443
[2025-12-13T09:50:24.122336991Z TRACE quiche_server] got packet Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false
[2025-12-13T09:50:24.122342822Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false len=23 pn=5 
[2025-12-13T09:50:24.122348803Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm ACK delay=4 blocks=[2..5] ecn_counts=None
[2025-12-13T09:50:24.122352911Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 4
[2025-12-13T09:50:24.122355766Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 5
[2025-12-13T09:50:24.122367058Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf processed 44 bytes
[2025-12-13T09:50:24.122371576Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.122375122Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.122377888Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.122840965Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:49996 to [::]:443
[2025-12-13T09:50:24.122849861Z TRACE quiche_server] got packet Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false
[2025-12-13T09:50:24.122858658Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false len=23 pn=6 
[2025-12-13T09:50:24.122865891Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm ACK delay=5 blocks=[2..6] ecn_counts=None
[2025-12-13T09:50:24.122869719Z TRACE quiche::recovery::congestion::recovery] 1995e6f518c54d8d538dac1132b30501337e5cbf packet newly acked 6
[2025-12-13T09:50:24.122885989Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf processed 44 bytes
[2025-12-13T09:50:24.122895287Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:49996 to [::]:443
[2025-12-13T09:50:24.122898643Z TRACE quiche_server] got packet Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false
[2025-12-13T09:50:24.122902981Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx pkt Short dcid=1995e6f518c54d8d538dac1132b30501337e5cbf key_phase=false len=21 pn=7 
[2025-12-13T09:50:24.122908471Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-12-13T09:50:24.122914543Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf processed 42 bytes
[2025-12-13T09:50:24.122918450Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.122921345Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.122924040Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.128774725Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.128788420Z TRACE quiche_server] got packet Initial version=1 dcid=8889bbe7965e77a595 scid=fabb337704edd280 token=
[2025-12-13T09:50:24.128794802Z DEBUG quiche_server] New connection: dcid=8889bbe7965e77a595 scid=37c1d9aaf216268ba753217bf3b5b86c8fe93305
[2025-12-13T09:50:24.128912192Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Initial version=1 dcid=8889bbe7965e77a595 scid=fabb337704edd280 token= len=1173 pn=0 
[2025-12-13T09:50:24.128923523Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm CRYPTO off=0 len=471
[2025-12-13T09:50:24.128948079Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-12-13T09:50:24.128952738Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-12-13T09:50:24.129069066Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 write message lvl=Initial len=96
[2025-12-13T09:50:24.129088111Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 set write secret lvl=Handshake
[2025-12-13T09:50:24.129164044Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 write message lvl=Handshake len=147
[2025-12-13T09:50:24.129168702Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 set write secret lvl=OneRTT
[2025-12-13T09:50:24.129177088Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 set read secret lvl=Handshake
[2025-12-13T09:50:24.129192777Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm PADDING len=681
[2025-12-13T09:50:24.129207164Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 1200 bytes
[2025-12-13T09:50:24.129227623Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.129231379Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.129243362Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Initial version=1 dcid=fabb337704edd280 scid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 len=105 pn=0 
[2025-12-13T09:50:24.129247870Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm ACK delay=43 blocks=[0..0] ecn_counts=None
[2025-12-13T09:50:24.129252569Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm CRYPTO off=0 len=96
[2025-12-13T09:50:24.129262317Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=998.971276ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=160 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 245, tv_nsec: 39143599 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 39143599 }, end_of_app_limited: 1, 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: 245, tv_nsec: 39143599 }, next_time: Instant { tv_sec: 245, tv_nsec: 39143599 }, 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-12-13T09:50:24.129293215Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Handshake version=1 dcid=fabb337704edd280 scid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 len=151 pn=1 
[2025-12-13T09:50:24.129297634Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm CRYPTO off=0 len=147
[2025-12-13T09:50:24.129304817Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=998.928987ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=365 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 245, tv_nsec: 39143599 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 39143599 }, 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: 245, tv_nsec: 39143599 }, next_time: Instant { tv_sec: 245, tv_nsec: 39143599 }, 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-12-13T09:50:24.129348349Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:51261, at: Instant { tv_sec: 245, tv_nsec: 39143599 } })
[2025-12-13T09:50:24.129355692Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.129360040Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.129368396Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.129374277Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.129383164Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.129389325Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.129394745Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.163143354Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.163163101Z TRACE quiche_server] got packet Initial version=1 dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 scid=fabb337704edd280 token=
[2025-12-13T09:50:24.163174151Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Initial version=1 dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 scid=fabb337704edd280 token= len=963 pn=1 
[2025-12-13T09:50:24.163184270Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=156 blocks=[0..0] ecn_counts=None
[2025-12-13T09:50:24.163190582Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 0
[2025-12-13T09:50:24.163200140Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm PADDING len=939
[2025-12-13T09:50:24.163217833Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Handshake version=1 dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 scid=fabb337704edd280 len=61 pn=2 
[2025-12-13T09:50:24.163224506Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=54 blocks=[1..1] ecn_counts=None
[2025-12-13T09:50:24.163236969Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 1
[2025-12-13T09:50:24.163242269Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm CRYPTO off=0 len=36
[2025-12-13T09:50:24.163257277Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 set read secret lvl=OneRTT
[2025-12-13T09:50:24.163291271Z TRACE quiche::tls] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 write message lvl=OneRTT len=396
[2025-12-13T09:50:24.163300278Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 dropped epoch 1 state
[2025-12-13T09:50:24.163305457Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 connection established: proto=Ok("hq-interop") cipher=Some(AES128_GCM) curve=Some("X25519") sigalg=None resumed=true TransportParams { original_destination_connection_id: None, max_idle_timeout: 30000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 15728640, initial_max_stream_data_bidi_local: 6291456, initial_max_stream_data_bidi_remote: 0, initial_max_stream_data_uni: 32768, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(fabb337704edd280), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-12-13T09:50:24.163329152Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 dropped epoch 0 state
[2025-12-13T09:50:24.163333921Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=80 pn=3 
[2025-12-13T09:50:24.163341856Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[38, 2e, 2a, 3c, ad, d8, 8b, 83] reset_token=[f7, 47, e7, cb, 4a, 86, 54, 41, 08, 9b, 6d, 7a, 23, 2c, 68, 9b]
[2025-12-13T09:50:24.163350151Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm STREAM id=0 off=0 len=32 fin=true
[2025-12-13T09:50:24.163360580Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 1200 bytes
[2025-12-13T09:50:24.163365429Z DEBUG quiche_apps::common] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 response stream 0 is writable with capacity Ok(13500)
[2025-12-13T09:50:24.163372813Z TRACE quiche_apps::common] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 received 32 bytes
[2025-12-13T09:50:24.163376641Z TRACE quiche_apps::common] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 stream 0 has 32 bytes (fin? true)
[2025-12-13T09:50:24.163382973Z INFO  quiche_apps::common] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 got GET request for "/www/infinite-boiling-suitcase" on stream 0
[2025-12-13T09:50:24.163410344Z INFO  quiche_apps::common] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 sending response of size 10240 on stream 0
[2025-12-13T09:50:24.163421154Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.163425312Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.163440530Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=2 
[2025-12-13T09:50:24.163445600Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm ACK delay=12 blocks=[3..3] ecn_counts=None
[2025-12-13T09:50:24.163450379Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[8b, 32, fe, d7, 42, bd, 8c, 89, 13, 8d, ac, 92, eb, 19, 35, 76, ad, 7f, 0e, a6] reset_token=[a0, 0d, df, 35, 91, 62, b5, f2, 79, 07, 7f, 53, 3f, 0b, ab, a1]
[2025-12-13T09:50:24.163459225Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[c0, 3d, 9b, 5c, 47, c5, 81, 90, 1b, 61, 25, 87, 6d, 2b, 4c, c8, f1, c9, 23, f7] reset_token=[13, 1e, 0a, 93, cd, cf, 86, fa, 50, ff, d7, 9e, a8, f3, b6, f0]
[2025-12-13T09:50:24.163467220Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[2e, ee, 54, cb, 9a, e8, 21, 1a, 43, da, 00, 39, 4e, 62, b4, 64, 4b, d3, 5d, 5a] reset_token=[11, 4e, 9c, 68, 4a, 52, 0c, 1f, 4f, 4c, 92, c0, f8, 21, d1, 65]
[2025-12-13T09:50:24.163480826Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[d0, ad, 29, ba, 34, ec, d6, 7c, d7, 17, 1d, bb, 4c, e8, e0, eb, a1, 75, ff, 33] reset_token=[82, 0d, 75, 13, b2, 61, 4d, 07, 24, 6f, 77, 49, 95, 9b, c1, 0c]
[2025-12-13T09:50:24.163488841Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[fd, 60, b4, 4d, 93, d4, 48, 66, 44, 1d, 2c, 62, e0, 11, fb, 1e, 65, 37, 5f, f3] reset_token=[2d, 02, 64, bd, be, a6, 63, 46, 8b, 6c, cc, 56, 80, 61, 37, e4]
[2025-12-13T09:50:24.163496365Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[06, f8, 9c, 20, 7b, 69, 18, 8a, ff, 6c, e3, 93, 92, 44, 37, 4e, 97, 30, 7e, 86] reset_token=[86, 5f, a6, 54, f5, 03, be, df, 9e, 77, 8e, bd, 31, 88, 97, 7c]
[2025-12-13T09:50:24.163504049Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[8d, cb, 2c, 01, 39, 41, fc, 5b, 48, 56, 94, 69, ba, 7f, 51, a3, a7, de, 90, 06] reset_token=[3c, d0, 31, 25, 32, d6, a3, 98, 7a, 48, b9, c0, 28, 0c, d4, b7]
[2025-12-13T09:50:24.163511814Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm HANDSHAKE_DONE
[2025-12-13T09:50:24.163515501Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm CRYPTO off=0 len=396
[2025-12-13T09:50:24.163519288Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=0 len=633 fin=false
[2025-12-13T09:50:24.163536470Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.784922ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163561316Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=3 
[2025-12-13T09:50:24.163565765Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=633 len=1318 fin=false
[2025-12-13T09:50:24.163573158Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.877536ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163595530Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=4 
[2025-12-13T09:50:24.163599718Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=1951 len=1318 fin=false
[2025-12-13T09:50:24.163606431Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.879518ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163623242Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=5 
[2025-12-13T09:50:24.163627300Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=3269 len=1318 fin=false
[2025-12-13T09:50:24.163633742Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.880291ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163650022Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=6 
[2025-12-13T09:50:24.163654020Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=4587 len=1318 fin=false
[2025-12-13T09:50:24.163664660Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.876404ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163681211Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=7 
[2025-12-13T09:50:24.163685248Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=5905 len=1318 fin=false
[2025-12-13T09:50:24.163711808Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.860183ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163729291Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=8 
[2025-12-13T09:50:24.163733389Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=7223 len=1318 fin=false
[2025-12-13T09:50:24.163739991Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.87988ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163760680Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=1324 pn=9 
[2025-12-13T09:50:24.163764807Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=8541 len=1318 fin=false
[2025-12-13T09:50:24.163771269Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.880321ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163787891Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx pkt Short dcid=fabb337704edd280 key_phase=false len=387 pn=10 
[2025-12-13T09:50:24.163791988Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 tx frm STREAM id=0 off=9859 len=381 fin=true
[2025-12-13T09:50:24.163799172Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 timer=109.87984ms latest_rtt=33.982596ms srtt=33.942471ms min_rtt=33.93674ms rttvar=12.737741ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11213 app_limited=true congestion_recovery_start_time=None Rate { delivered: 365, delivered_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, first_sent_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { bandwidth: 85.92 Kbps, is_app_limited: true, interval: 33.982596ms, delivered: 365, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 245, tv_nsec: 39143599 }), send_elapsed: 0ns, ack_elapsed: 33.982596ms, rtt: 33.982596ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 497164, last_update: Instant { tv_sec: 245, tv_nsec: 73338052 }, next_time: Instant { tv_sec: 245, tv_nsec: 73338052 }, 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-12-13T09:50:24.163908546Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 written 11213 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:51261, at: Instant { tv_sec: 245, tv_nsec: 73338052 } })
[2025-12-13T09:50:24.163919838Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.163924266Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.163937030Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.163942260Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.163948371Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.163953060Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.163957618Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.196592916Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.196617392Z TRACE quiche_server] got packet Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false
[2025-12-13T09:50:24.196634354Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=23 pn=4 
[2025-12-13T09:50:24.196649963Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=4 blocks=[2..3] ecn_counts=None
[2025-12-13T09:50:24.196657136Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 2
[2025-12-13T09:50:24.196663197Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 3
[2025-12-13T09:50:24.196685119Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 44 bytes
[2025-12-13T09:50:24.196693064Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.196697762Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.196703252Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.196707431Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.196711247Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.198760007Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.198778061Z TRACE quiche_server] got packet Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false
[2025-12-13T09:50:24.198789823Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=23 pn=5 
[2025-12-13T09:50:24.198797898Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=5 blocks=[2..5] ecn_counts=None
[2025-12-13T09:50:24.198803509Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 4
[2025-12-13T09:50:24.198807677Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 5
[2025-12-13T09:50:24.198822805Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 44 bytes
[2025-12-13T09:50:24.198829407Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.198833705Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.198838715Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.198842672Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.198846399Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.200968753Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.200985053Z TRACE quiche_server] got packet Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false
[2025-12-13T09:50:24.200996404Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=23 pn=6 
[2025-12-13T09:50:24.201004379Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=4 blocks=[2..7] ecn_counts=None
[2025-12-13T09:50:24.201009900Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 6
[2025-12-13T09:50:24.201014037Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 7
[2025-12-13T09:50:24.201030408Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 44 bytes
[2025-12-13T09:50:24.201047560Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.201051067Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.201054814Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.201057569Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.201060104Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.203178847Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.203192212Z TRACE quiche_server] got packet Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false
[2025-12-13T09:50:24.203200748Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=23 pn=7 
[2025-12-13T09:50:24.203209224Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=5 blocks=[2..9] ecn_counts=None
[2025-12-13T09:50:24.203214804Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 8
[2025-12-13T09:50:24.203218762Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 9
[2025-12-13T09:50:24.203234311Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 44 bytes
[2025-12-13T09:50:24.203252815Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.203257324Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.203262473Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.203266541Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.203269927Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.203602238Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.203612998Z TRACE quiche_server] got packet Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false
[2025-12-13T09:50:24.203622225Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=23 pn=8 
[2025-12-13T09:50:24.203630471Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm ACK delay=5 blocks=[2..10] ecn_counts=None
[2025-12-13T09:50:24.203636853Z TRACE quiche::recovery::congestion::recovery] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 packet newly acked 10
[2025-12-13T09:50:24.203654045Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 44 bytes
[2025-12-13T09:50:24.203660126Z TRACE quiche_server] got 42 bytes from [::ffff:193.167.0.100]:51261 to [::]:443
[2025-12-13T09:50:24.203663863Z TRACE quiche_server] got packet Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false
[2025-12-13T09:50:24.203668181Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx pkt Short dcid=37c1d9aaf216268ba753217bf3b5b86c8fe93305 key_phase=false len=21 pn=9 
[2025-12-13T09:50:24.203673501Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 rx frm CONNECTION_CLOSE err=0 frame=0 reason=[]
[2025-12-13T09:50:24.203679693Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 processed 42 bytes
[2025-12-13T09:50:24.203683650Z TRACE quiche_server] recv() would block
[2025-12-13T09:50:24.203686606Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.203689431Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.203692116Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.203695572Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.300816263Z TRACE quiche_server] timed out
[2025-12-13T09:50:24.300842512Z TRACE quiche] 1995e6f518c54d8d538dac1132b30501337e5cbf draining timeout expired
[2025-12-13T09:50:24.300876596Z TRACE quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf done writing
[2025-12-13T09:50:24.300881976Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.300889630Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.300895611Z INFO  quiche_server] 1995e6f518c54d8d538dac1132b30501337e5cbf connection collected recv=8 sent=7 lost=0 retrans=0 sent_bytes=6875 recv_bytes=2574 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:49996 validation_state=Validated active=true recv=8 sent=7 lost=0 retrans=0 rtt=34.267174ms min_rtt=Some(33.03239ms) rttvar=6.167152ms cwnd=13500 sent_bytes=6875 recv_bytes=2574 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=167016]
[2025-12-13T09:50:24.300928713Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.383035252Z TRACE quiche_server] timed out
[2025-12-13T09:50:24.383051433Z TRACE quiche] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 draining timeout expired
[2025-12-13T09:50:24.383088001Z TRACE quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 done writing
[2025-12-13T09:50:24.383113769Z TRACE quiche_server] Collecting garbage
[2025-12-13T09:50:24.383123517Z INFO  quiche_server] 37c1d9aaf216268ba753217bf3b5b86c8fe93305 connection collected recv=10 sent=11 lost=0 retrans=0 sent_bytes=11578 recv_bytes=2662 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:51261 validation_state=Validated active=true recv=10 sent=11 lost=0 retrans=0 rtt=35.756596ms min_rtt=Some(33.20253ms) rttvar=5.970498ms cwnd=13500 sent_bytes=11578 recv_bytes=2662 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=278985]