[2025-04-30T18:36:41.435598834Z INFO  quiche_server] listening on [::]:443
[2025-04-30T18:36:41.435625705Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T18:36:41.435632638Z TRACE quiche_server] GSO detected: false
[2025-04-30T18:36:42.217181599Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:33848 to [::]:443
[2025-04-30T18:36:42.217215783Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T18:36:42.217223898Z WARN  quiche_server] Doing version negotiation
[2025-04-30T18:36:42.217328965Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:33848 to [::]:443
[2025-04-30T18:36:42.217334756Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T18:36:42.217338693Z WARN  quiche_server] Doing version negotiation
[2025-04-30T18:36:42.217360865Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:33848 to [::]:443
[2025-04-30T18:36:42.217366115Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T18:36:42.217372206Z WARN  quiche_server] Doing version negotiation
[2025-04-30T18:36:42.217404887Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.476589128Z TRACE quiche_server] got 1200 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.476621379Z TRACE quiche_server] got packet Initial version=1 dcid=65b130298718c193ed90077c3d291c3d scid=ee7808f5aacbda14644368dc2911f360a1552160 token=
[2025-04-30T18:36:42.476631418Z DEBUG quiche_server] New connection: dcid=65b130298718c193ed90077c3d291c3d scid=2e6d4629edf9c25318b454b516a2f148a9234bae
[2025-04-30T18:36:42.476858703Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Initial version=1 dcid=65b130298718c193ed90077c3d291c3d scid=ee7808f5aacbda14644368dc2911f360a1552160 token= len=287 pn=0 
[2025-04-30T18:36:42.476873010Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm CRYPTO off=0 len=266
[2025-04-30T18:36:42.476900751Z TRACE quiche::tls] checking peer ALPN Ok("h3") against Ok("h3")
[2025-04-30T18:36:42.477028520Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae write message lvl=Initial len=90
[2025-04-30T18:36:42.477065870Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae set write secret lvl=Handshake
[2025-04-30T18:36:42.477141552Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae write message lvl=Handshake len=698
[2025-04-30T18:36:42.477145239Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae set write secret lvl=OneRTT
[2025-04-30T18:36:42.477153133Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae set read secret lvl=Handshake
[2025-04-30T18:36:42.477190904Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae dropped invalid packet
[2025-04-30T18:36:42.477194671Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 1200 bytes
[2025-04-30T18:36:42.477215350Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.477229436Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Initial version=1 dcid=ee7808f5aacbda14644368dc2911f360a1552160 scid=2e6d4629edf9c25318b454b516a2f148a9234bae len=99 pn=0 
[2025-04-30T18:36:42.477233494Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm ACK delay=48 blocks=[0..0] ecn_counts=None
[2025-04-30T18:36:42.477239044Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm CRYPTO off=0 len=90
[2025-04-30T18:36:42.477249824Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=998.96765ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=166 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 954, tv_nsec: 627242177 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 627242177 }, 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: 954, tv_nsec: 627242177 }, next_time: Instant { tv_sec: 954, tv_nsec: 627242177 }, 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-30T18:36:42.477282826Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Handshake version=1 dcid=ee7808f5aacbda14644368dc2911f360a1552160 scid=2e6d4629edf9c25318b454b516a2f148a9234bae len=702 pn=1 
[2025-04-30T18:36:42.477286553Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm CRYPTO off=0 len=698
[2025-04-30T18:36:42.477293426Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=998.924459ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=934 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 954, tv_nsec: 627242177 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 627242177 }, 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: 954, tv_nsec: 627242177 }, next_time: Instant { tv_sec: 954, tv_nsec: 627242177 }, 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-30T18:36:42.477340263Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 1200 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 627242177 } })
[2025-04-30T18:36:42.477347016Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.477353899Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.477361383Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.477365881Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.510811236Z TRACE quiche_server] got 1350 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.510846722Z TRACE quiche_server] got packet Initial version=1 dcid=2e6d4629edf9c25318b454b516a2f148a9234bae scid=ee7808f5aacbda14644368dc2911f360a1552160 token=
[2025-04-30T18:36:42.510863874Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Initial version=1 dcid=2e6d4629edf9c25318b454b516a2f148a9234bae scid=ee7808f5aacbda14644368dc2911f360a1552160 token= len=23 pn=1 
[2025-04-30T18:36:42.510877049Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=94 blocks=[0..0] ecn_counts=None
[2025-04-30T18:36:42.510884132Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 0
[2025-04-30T18:36:42.510912215Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Handshake version=1 dcid=2e6d4629edf9c25318b454b516a2f148a9234bae scid=ee7808f5aacbda14644368dc2911f360a1552160 len=63 pn=2 
[2025-04-30T18:36:42.510919268Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=74 blocks=[1..1] ecn_counts=None
[2025-04-30T18:36:42.510922694Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 1
[2025-04-30T18:36:42.510926742Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm CRYPTO off=0 len=36
[2025-04-30T18:36:42.510959613Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae set read secret lvl=OneRTT
[2025-04-30T18:36:42.511036597Z TRACE quiche::tls] 2e6d4629edf9c25318b454b516a2f148a9234bae write message lvl=OneRTT len=396
[2025-04-30T18:36:42.511053880Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae dropped epoch 1 state
[2025-04-30T18:36:42.511061654Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae connection established: proto=Ok("h3") 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: 1350, initial_max_data: 10000000, initial_max_stream_data_bidi_local: 1000000, initial_max_stream_data_bidi_remote: 1000000, initial_max_stream_data_uni: 1000000, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: true, active_conn_id_limit: 8, initial_source_connection_id: Some(ee7808f5aacbda14644368dc2911f360a1552160), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T18:36:42.511097882Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae dropped epoch 0 state
[2025-04-30T18:36:42.511102801Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=1144 pn=3 
[2025-04-30T18:36:42.511111928Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[23, 4e, aa, 70, 68, bb, 0b, be, 03, 41, 34, 44, 99, fd, 51, 79, cc, 62, 94, 5e] reset_token=[af, 00, 7d, 84, 70, 09, 52, 35, 1b, 22, 43, 96, b5, c0, bd, e6]
[2025-04-30T18:36:42.511121847Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[6f, 1c, 91, a6, 14, 4e, af, 70, 87, 3d, 9c, 7e, a2, 8c, 58, 79, 37, 36, 58, 2b] reset_token=[5c, 58, 8e, c4, a3, 66, 10, cc, ac, 34, 07, 90, bc, d0, c7, 94]
[2025-04-30T18:36:42.511129090Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[9b, 3a, 0e, f6, 4f, 53, 3f, 04, 9e, 21, a7, 04, cf, 91, 60, 6a, 91, c5, 93, 0b] reset_token=[05, 74, 7a, 26, dc, aa, cc, 92, 2a, a9, 0b, 8b, a6, 26, de, 7d]
[2025-04-30T18:36:42.511136174Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[aa, 0e, db, 0d, 7c, c5, 22, e0, 0e, 27, f5, 04, af, 25, 6a, 8b, 27, 58, 84, 7c] reset_token=[4b, 26, 01, 06, 30, 6b, bc, 51, b2, 87, f1, f8, dd, f3, 1c, 66]
[2025-04-30T18:36:42.511143737Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[70, d9, 09, 4c, fc, 5e, f9, a6, e8, f7, 23, 65, 3a, 0d, 22, fe, a4, 43, c2, a1] reset_token=[83, 72, 0b, 21, 0d, a2, 24, a1, 57, ec, 87, 48, 5d, 90, e6, 7e]
[2025-04-30T18:36:42.511153516Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[70, 9e, 54, 28, 25, ba, 3d, de, 6c, 9e, fb, e1, e1, 73, c6, d4, 2b, d3, 92, 38] reset_token=[dd, a6, 22, 4b, 17, 10, 61, b3, 5c, a1, a1, 35, 68, 3c, 18, a1]
[2025-04-30T18:36:42.511165388Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[51, 69, 3b, 5e, 9e, 7f, 18, 05, 92, 6f, 6a, 06, 87, a5, 28, 80, a6, 52, c6, 2c] reset_token=[b4, a6, 26, 0b, 76, f4, 29, 32, a8, ac, 83, 8d, 72, f1, 57, c9]
[2025-04-30T18:36:42.511175467Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm STREAM id=2 off=0 len=19 fin=false
[2025-04-30T18:36:42.511188051Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm PADDING len=823
[2025-04-30T18:36:42.511207617Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 1350 bytes
[2025-04-30T18:36:42.511230029Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm SETTINGS stream=3 len=18
[2025-04-30T18:36:42.511255547Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae open GREASE stream 15
[2025-04-30T18:36:42.511262239Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae stream id 2 is readable
[2025-04-30T18:36:42.511268160Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 2
[2025-04-30T18:36:42.511273019Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae open peer's control stream 2
[2025-04-30T18:36:42.511277277Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 2
[2025-04-30T18:36:42.511281195Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 2
[2025-04-30T18:36:42.511285513Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 16 bytes on stream 2
[2025-04-30T18:36:42.511288919Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm SETTINGS max_field_section=None, qpack_max_table=None, qpack_blocked=None raw=Some([(1848144645419700753, 4496405514388356638)]), additional_settings=Some([(1848144645419700753, 4496405514388356638)]) stream=2 payload_len=16
[2025-04-30T18:36:42.511301813Z TRACE quiche_server] got 44 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.511306151Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.511312183Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=23 pn=4 
[2025-04-30T18:36:42.511318304Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm STREAM id=6 off=0 len=1 fin=false
[2025-04-30T18:36:42.511350755Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 44 bytes
[2025-04-30T18:36:42.511354472Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae stream id 6 is readable
[2025-04-30T18:36:42.511359080Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 6
[2025-04-30T18:36:42.511366865Z TRACE quiche_server] got 44 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.511370592Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.511375401Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=23 pn=5 
[2025-04-30T18:36:42.511380260Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm STREAM id=10 off=0 len=1 fin=false
[2025-04-30T18:36:42.511386071Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 44 bytes
[2025-04-30T18:36:42.511389267Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae stream id 10 is readable
[2025-04-30T18:36:42.511393465Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 10
[2025-04-30T18:36:42.511400337Z TRACE quiche_server] got 111 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.511403744Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.511408052Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=90 pn=6 
[2025-04-30T18:36:42.511412661Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm STREAM id=0 off=0 len=68 fin=true
[2025-04-30T18:36:42.511419213Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 111 bytes
[2025-04-30T18:36:42.511422489Z DEBUG quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae response stream 0 is writable with capacity Ok(13500)
[2025-04-30T18:36:42.511426577Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae stream id 0 is readable
[2025-04-30T18:36:42.511430955Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 0
[2025-04-30T18:36:42.511434762Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 7 bytes on stream 0
[2025-04-30T18:36:42.511442547Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 0
[2025-04-30T18:36:42.511445823Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm UNKNOWN raw_type=4177922235154802873 stream=0 payload_len=0
[2025-04-30T18:36:42.511451523Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 0
[2025-04-30T18:36:42.511455351Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 7 bytes on stream 0
[2025-04-30T18:36:42.511459007Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 0
[2025-04-30T18:36:42.511463025Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 18 bytes on stream 0
[2025-04-30T18:36:42.511466010Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm UNKNOWN raw_type=4598610392131894947 stream=0 payload_len=18
[2025-04-30T18:36:42.511470880Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 0
[2025-04-30T18:36:42.511474636Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 0
[2025-04-30T18:36:42.511478604Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 30 bytes on stream 0
[2025-04-30T18:36:42.511481630Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm HEADERS stream=0 payload_len=30
[2025-04-30T18:36:42.511485136Z TRACE quiche::h3::qpack::decoder] Header count=0 base=0
[2025-04-30T18:36:42.511488122Z TRACE quiche::h3::qpack::decoder] Indexed index=17 static=true
[2025-04-30T18:36:42.511491508Z TRACE quiche::h3::qpack::decoder] Indexed index=23 static=true
[2025-04-30T18:36:42.511495636Z TRACE quiche::h3::qpack::decoder] Literal name_idx=0 static=true value=[115, 101, 114, 118, 101, 114, 54]
[2025-04-30T18:36:42.511500926Z TRACE quiche::h3::qpack::decoder] Literal name_idx=1 static=true value=[47, 113, 119, 121, 104, 118, 98, 104, 97, 113, 119]
[2025-04-30T18:36:42.511505113Z TRACE quiche::h3::qpack::decoder] Literal name_idx=95 static=true value=[113, 117, 105, 99, 104, 101]
[2025-04-30T18:36:42.511513910Z INFO  quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae got request [(":method", "GET"), (":scheme", "https"), (":authority", "server6"), (":path", "/qwyhvbhaqw"), ("user-agent", "quiche")] on stream id 0
[2025-04-30T18:36:42.511571618Z INFO  quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae prioritizing response on stream 0 as Priority { urgency: 3, incremental: false }
[2025-04-30T18:36:42.511580865Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm GREASE stream=0 len=0
[2025-04-30T18:36:42.511588379Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm GREASE stream=0 len=18
[2025-04-30T18:36:42.511596184Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm HEADERS stream=0 len=16 fin=false
[2025-04-30T18:36:42.511604169Z DEBUG quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae response stream 0 is writable with capacity Ok(13446)
[2025-04-30T18:36:42.511611512Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm DATA stream=0 len=5120 fin=true
[2025-04-30T18:36:42.511619828Z TRACE quiche_server] got 75 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.511623715Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.511629065Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=54 pn=7 
[2025-04-30T18:36:42.511634916Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm STREAM id=4 off=0 len=32 fin=true
[2025-04-30T18:36:42.511641889Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 75 bytes
[2025-04-30T18:36:42.511645146Z DEBUG quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae response stream 4 is writable with capacity Ok(13500)
[2025-04-30T18:36:42.511653361Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae stream id 4 is readable
[2025-04-30T18:36:42.511657829Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 4
[2025-04-30T18:36:42.511661797Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 4
[2025-04-30T18:36:42.511666085Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 30 bytes on stream 4
[2025-04-30T18:36:42.511669191Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm HEADERS stream=4 payload_len=30
[2025-04-30T18:36:42.511672417Z TRACE quiche::h3::qpack::decoder] Header count=0 base=0
[2025-04-30T18:36:42.511675142Z TRACE quiche::h3::qpack::decoder] Indexed index=17 static=true
[2025-04-30T18:36:42.511677997Z TRACE quiche::h3::qpack::decoder] Indexed index=23 static=true
[2025-04-30T18:36:42.511681043Z TRACE quiche::h3::qpack::decoder] Literal name_idx=0 static=true value=[115, 101, 114, 118, 101, 114, 54]
[2025-04-30T18:36:42.511685361Z TRACE quiche::h3::qpack::decoder] Literal name_idx=1 static=true value=[47, 103, 98, 121, 97, 105, 112, 97, 122, 107, 97]
[2025-04-30T18:36:42.511688997Z TRACE quiche::h3::qpack::decoder] Literal name_idx=95 static=true value=[113, 117, 105, 99, 104, 101]
[2025-04-30T18:36:42.511696592Z INFO  quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae got request [(":method", "GET"), (":scheme", "https"), (":authority", "server6"), (":path", "/gbyaipazka"), ("user-agent", "quiche")] on stream id 4
[2025-04-30T18:36:42.511722250Z INFO  quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae prioritizing response on stream 4 as Priority { urgency: 3, incremental: false }
[2025-04-30T18:36:42.511729644Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm HEADERS stream=4 len=17 fin=false
[2025-04-30T18:36:42.511736446Z DEBUG quiche_apps::common] 2e6d4629edf9c25318b454b516a2f148a9234bae response stream 4 is writable with capacity Ok(13481)
[2025-04-30T18:36:42.511743550Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm DATA stream=4 len=10240 fin=true
[2025-04-30T18:36:42.511751534Z TRACE quiche_server] got 69 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.511755272Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.511760361Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=48 pn=8 
[2025-04-30T18:36:42.511765891Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm STREAM id=14 off=0 len=26 fin=true
[2025-04-30T18:36:42.511772404Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 69 bytes
[2025-04-30T18:36:42.511775720Z TRACE quiche::h3] 2e6d4629edf9c25318b454b516a2f148a9234bae stream id 14 is readable
[2025-04-30T18:36:42.511780318Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 1 bytes on stream 14
[2025-04-30T18:36:42.511783474Z TRACE quiche::h3::stream] 2e6d4629edf9c25318b454b516a2f148a9234bae read 7 bytes on stream 14
[2025-04-30T18:36:42.511788714Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.511796699Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1307
[2025-04-30T18:36:42.511805666Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=710 pn=2 
[2025-04-30T18:36:42.511808521Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm ACK delay=4 blocks=[3..8] ecn_counts=None
[2025-04-30T18:36:42.511811627Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[c7, 16, e5, c0, e4, 80, a5, ee, e3, 4a, 5f, 64, 86, cb, 8c, 85, a8, 2f, d2, c9] reset_token=[13, 27, 64, db, 55, 50, eb, 2c, 46, 48, d6, 96, 97, 4d, 39, d1]
[2025-04-30T18:36:42.511817708Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[4a, 44, e8, 3d, a6, 5f, 31, ea, a3, dd, fe, ec, 5a, c4, 3d, ce, b4, 6d, c1, a5] reset_token=[0d, 26, c7, fa, d2, 79, 3f, 83, 91, b4, 08, 2c, 7a, a1, 2d, fc]
[2025-04-30T18:36:42.511827667Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[36, 30, 3d, de, 85, cd, d2, d8, c2, 16, 16, ed, 2d, db, ce, 25, 76, e9, 6f, 2f] reset_token=[85, 59, 51, 58, 85, 09, 54, b4, c7, 41, cd, c1, 25, 00, 95, c4]
[2025-04-30T18:36:42.511833087Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[ff, bd, a7, 96, d6, 3f, 4d, 48, 5c, 4a, 73, 33, c6, 77, 0e, 99, 20, a4, a4, 61] reset_token=[a9, e3, 97, 5f, cd, 14, 56, 14, 1e, cc, 17, 39, e3, 6a, ad, 22]
[2025-04-30T18:36:42.511838277Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[61, 92, 76, 9c, 49, b4, bb, 00, a1, bd, d1, 75, 60, ca, b8, 0f, c6, 5c, dc, 24] reset_token=[a8, 2d, da, 73, b5, df, c4, 1a, 33, fe, 33, 90, 4a, d3, 37, fd]
[2025-04-30T18:36:42.511843526Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[76, e1, b4, 39, 71, 34, 92, f0, d7, 1e, d5, 0d, 88, 1c, 78, f8, 4e, eb, 63, 4b] reset_token=[14, 22, d5, 7f, a4, 1d, f3, ad, 75, 35, fb, 08, b7, a4, 2e, 58]
[2025-04-30T18:36:42.511848736Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[09, 1f, 04, 9d, 25, e3, 91, 69, 4b, d3, 55, 08, 00, 75, b2, 21, 17, 09, 6a, 1c] reset_token=[af, 9f, d8, 3a, 00, 9e, ec, 6f, da, 4b, 89, 05, ed, de, 57, 82]
[2025-04-30T18:36:42.511854177Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm HANDSHAKE_DONE
[2025-04-30T18:36:42.511856411Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm CRYPTO off=0 len=396
[2025-04-30T18:36:42.511858765Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=3 off=0 len=19 fin=false
[2025-04-30T18:36:42.511878722Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.07332ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=748 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.511924688Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 748 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 661815000 } })
[2025-04-30T18:36:42.511930148Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.511935248Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.511940207Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12752 out_len=1350 left=1312
[2025-04-30T18:36:42.511943974Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=6 pn=3 
[2025-04-30T18:36:42.511950457Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=7 off=0 len=1 fin=false
[2025-04-30T18:36:42.511956167Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.142409ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=792 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512005379Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 44 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 661815000 } })
[2025-04-30T18:36:42.512017863Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.512023473Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.512031188Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12708 out_len=1350 left=1312
[2025-04-30T18:36:42.512037620Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=6 pn=4 
[2025-04-30T18:36:42.512041897Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=11 off=0 len=1 fin=false
[2025-04-30T18:36:42.512052027Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.135436ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=836 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512086852Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 44 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 661815000 } })
[2025-04-30T18:36:42.512091310Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.512095197Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.512109113Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12664 out_len=1350 left=1312
[2025-04-30T18:36:42.512115826Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=5 
[2025-04-30T18:36:42.512120464Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=0 off=0 len=1307 fin=false
[2025-04-30T18:36:42.512130413Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.135065ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2186 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512151002Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=11314 out_len=1350 left=1312
[2025-04-30T18:36:42.512154719Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=6 
[2025-04-30T18:36:42.512157163Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=0 off=1307 len=1306 fin=false
[2025-04-30T18:36:42.512162764Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.146898ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=3536 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512173243Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9964 out_len=1350 left=1312
[2025-04-30T18:36:42.512176399Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=7 
[2025-04-30T18:36:42.512178764Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=0 off=2613 len=1306 fin=false
[2025-04-30T18:36:42.512187199Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.145756ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4886 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512197479Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8614 out_len=1350 left=1312
[2025-04-30T18:36:42.512200564Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1264 pn=8 
[2025-04-30T18:36:42.512202949Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=0 off=3919 len=1258 fin=true
[2025-04-30T18:36:42.512207357Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.150013ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6188 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512265175Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 5352 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 661815000 } })
[2025-04-30T18:36:42.512273240Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.512279101Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.512286585Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=7312 out_len=1350 left=1312
[2025-04-30T18:36:42.512292687Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=9 
[2025-04-30T18:36:42.512296574Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=0 len=1307 fin=false
[2025-04-30T18:36:42.512306913Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.136378ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=7538 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512333533Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5962 out_len=1350 left=1312
[2025-04-30T18:36:42.512339414Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=10 
[2025-04-30T18:36:42.512342560Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=1307 len=1306 fin=false
[2025-04-30T18:36:42.512348471Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.14309ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8888 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512359291Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4612 out_len=1350 left=1312
[2025-04-30T18:36:42.512362107Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=11 
[2025-04-30T18:36:42.512364461Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=2613 len=1306 fin=false
[2025-04-30T18:36:42.512368709Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.150384ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10238 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 11, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512382094Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=3262 out_len=1350 left=1312
[2025-04-30T18:36:42.512385050Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=12 
[2025-04-30T18:36:42.512387374Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=3919 len=1306 fin=false
[2025-04-30T18:36:42.512391612Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.150425ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11588 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 12, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512401600Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=1912 out_len=1350 left=1312
[2025-04-30T18:36:42.512404536Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=13 
[2025-04-30T18:36:42.512406860Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=5225 len=1306 fin=false
[2025-04-30T18:36:42.512411128Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.150514ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=12938 app_limited=true congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 13, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512423992Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=562 out_len=1350 left=524
[2025-04-30T18:36:42.512426868Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=524 pn=14 
[2025-04-30T18:36:42.512429242Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=6531 len=518 fin=false
[2025-04-30T18:36:42.512433540Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=109.150464ms latest_rtt=33.693298ms srtt=33.647633ms min_rtt=33.64111ms rttvar=12.628463ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13500 app_limited=false congestion_recovery_start_time=None Rate { delivered: 934, delivered_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 1, last_sent_packet: 14, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27763, is_app_limited: true, interval: 33.64111ms, delivered: 934, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 627242177 }), send_elapsed: 0ns, ack_elapsed: 33.64111ms, rtt: 33.64111ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 501521, last_update: Instant { tv_sec: 954, tv_nsec: 661815000 }, next_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, 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-30T18:36:42.512526263Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 7312 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 661815000 } })
[2025-04-30T18:36:42.512540410Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.512546421Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.512554046Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=0 out_len=1350 left=0
[2025-04-30T18:36:42.512559666Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.512563173Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.543464169Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.543484407Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.543496580Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=9 
[2025-04-30T18:36:42.543508191Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=11 blocks=[2..4] ecn_counts=None
[2025-04-30T18:36:42.543514403Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 2
[2025-04-30T18:36:42.543519002Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 3
[2025-04-30T18:36:42.543521907Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 4
[2025-04-30T18:36:42.543548186Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.543556772Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.543570939Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=836 out_len=1350 left=798
[2025-04-30T18:36:42.543578643Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=798 pn=15 
[2025-04-30T18:36:42.543581228Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=7049 len=792 fin=false
[2025-04-30T18:36:42.543590054Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=98.210437ms latest_rtt=31.702495ms srtt=33.404489ms min_rtt=31.702495ms rttvar=9.957631ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=13500 app_limited=false congestion_recovery_start_time=None Rate { delivered: 1770, delivered_time: Instant { tv_sec: 954, tv_nsec: 693517495 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 0, last_sent_packet: 15, largest_acked: 4, rate_sample: RateSample { delivery_rate: 26370, is_app_limited: true, interval: 31.702495ms, delivered: 836, prior_delivered: 934, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 661815000 }), send_elapsed: 0ns, ack_elapsed: 31.702495ms, rtt: 31.702495ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 505171, last_update: Instant { tv_sec: 954, tv_nsec: 693589901 }, next_time: Instant { tv_sec: 954, tv_nsec: 693589901 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(15) last_round_min_rtt=31.702495ms 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-30T18:36:42.543630179Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 836 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 693589901 } })
[2025-04-30T18:36:42.543635609Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.543640068Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.543644336Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=0 out_len=1350 left=0
[2025-04-30T18:36:42.543648724Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.543652762Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.544371296Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.544380863Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.544386374Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=10 
[2025-04-30T18:36:42.544391764Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=16 blocks=[2..5] ecn_counts=None
[2025-04-30T18:36:42.544395170Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 5
[2025-04-30T18:36:42.544406932Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.544411701Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.544416881Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1312
[2025-04-30T18:36:42.544421049Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1312 pn=16 
[2025-04-30T18:36:42.544423594Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=7841 len=1306 fin=false
[2025-04-30T18:36:42.544430066Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=89.081728ms latest_rtt=32.594303ms srtt=33.287214ms min_rtt=31.702495ms rttvar=7.702769ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=13500 app_limited=true congestion_recovery_start_time=None Rate { delivered: 3120, delivered_time: Instant { tv_sec: 954, tv_nsec: 694409303 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 0, last_sent_packet: 16, largest_acked: 5, rate_sample: RateSample { delivery_rate: 68953, is_app_limited: true, interval: 31.702495ms, delivered: 2186, prior_delivered: 934, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 661815000 }), send_elapsed: 0ns, ack_elapsed: 31.702495ms, rtt: 31.702495ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 557646, last_update: Instant { tv_sec: 954, tv_nsec: 693589901 }, next_time: Instant { tv_sec: 954, tv_nsec: 693589901 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(15) last_round_min_rtt=31.702495ms current_round_min_rtt=32.594303ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=1 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:36:42.544448811Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=1350 out_len=1350 left=1312
[2025-04-30T18:36:42.544452247Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=1121 pn=17 
[2025-04-30T18:36:42.544454742Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=4 off=9147 len=1115 fin=true
[2025-04-30T18:36:42.544459450Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=89.085767ms latest_rtt=32.594303ms srtt=33.287214ms min_rtt=31.702495ms rttvar=7.702769ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=14659 app_limited=true congestion_recovery_start_time=None Rate { delivered: 3120, delivered_time: Instant { tv_sec: 954, tv_nsec: 694409303 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 0, last_sent_packet: 17, largest_acked: 5, rate_sample: RateSample { delivery_rate: 68953, is_app_limited: true, interval: 31.702495ms, delivered: 2186, prior_delivered: 934, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 661815000 }), send_elapsed: 0ns, ack_elapsed: 31.702495ms, rtt: 31.702495ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 557646, last_update: Instant { tv_sec: 954, tv_nsec: 693589901 }, next_time: Instant { tv_sec: 954, tv_nsec: 693589901 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(15) last_round_min_rtt=31.702495ms current_round_min_rtt=32.594303ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=1 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:36:42.544496610Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 2509 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 693589901 } })
[2025-04-30T18:36:42.544504986Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.544511327Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.544518731Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae pmtud probe status false hs_con=true hs_sent=true cwnd_avail=191 out_len=1350 left=153
[2025-04-30T18:36:42.544525123Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx pkt Short dcid=ee7808f5aacbda14644368dc2911f360a1552160 key_phase=false len=31 pn=18 
[2025-04-30T18:36:42.544529271Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae tx frm STREAM id=15 off=0 len=26 fin=true
[2025-04-30T18:36:42.544539390Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae timer=89.072812ms latest_rtt=32.594303ms srtt=33.287214ms min_rtt=31.702495ms rttvar=7.702769ms cwnd=14850 ssthresh=18446744073709551615 bytes_in_flight=14728 app_limited=true congestion_recovery_start_time=None Rate { delivered: 3120, delivered_time: Instant { tv_sec: 954, tv_nsec: 694409303 }, first_sent_time: Instant { tv_sec: 954, tv_nsec: 661815000 }, end_of_app_limited: 0, last_sent_packet: 18, largest_acked: 5, rate_sample: RateSample { delivery_rate: 68953, is_app_limited: true, interval: 31.702495ms, delivered: 2186, prior_delivered: 934, prior_time: Some(Instant { tv_sec: 954, tv_nsec: 661815000 }), send_elapsed: 0ns, ack_elapsed: 31.702495ms, rtt: 31.702495ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 557646, last_update: Instant { tv_sec: 954, tv_nsec: 693589901 }, next_time: Instant { tv_sec: 954, tv_nsec: 693589901 }, max_datagram_size: 1350, last_packet_size: Some(0), iv: 0ns, max_pacing_rate: None } hystart=window_end=Some(15) last_round_min_rtt=31.702495ms current_round_min_rtt=32.594303ms css_baseline_min_rtt=18446744073709551615.999999999s rtt_sample_count=1 css_start_time=None css_round_count=0 cubic={ k=0 w_max=0 } 
[2025-04-30T18:36:42.544584354Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae written 69 bytes with Some(SendInfo { from: [::]:443, to: [fd00:cafe:cafe::100]:46880, at: Instant { tv_sec: 954, tv_nsec: 693589901 } })
[2025-04-30T18:36:42.544589714Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.544595665Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.544600364Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.544603881Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.545361758Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.545371236Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.545376636Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=11 
[2025-04-30T18:36:42.545382106Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=4 blocks=[2..6] ecn_counts=None
[2025-04-30T18:36:42.545385553Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 6
[2025-04-30T18:36:42.545416180Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.545421189Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.545424035Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.545426279Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.546474720Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.546483777Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.546488856Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=12 
[2025-04-30T18:36:42.546493926Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=3 blocks=[2..7] ecn_counts=None
[2025-04-30T18:36:42.546497222Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 7
[2025-04-30T18:36:42.546506349Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.546510787Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.546513623Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.546515817Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.547561572Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.547570920Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.547576110Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=13 
[2025-04-30T18:36:42.547581069Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=4 blocks=[2..8] ecn_counts=None
[2025-04-30T18:36:42.547589304Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 8
[2025-04-30T18:36:42.547600676Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.547605374Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.547608280Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.547610464Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.548761642Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.548775608Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.548784364Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=14 
[2025-04-30T18:36:42.548793141Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=10 blocks=[2..9] ecn_counts=None
[2025-04-30T18:36:42.548798701Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 9
[2025-04-30T18:36:42.548812858Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.548818188Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.548821253Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.548823698Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.549796207Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.549802749Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.549807448Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=15 
[2025-04-30T18:36:42.549811736Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=3 blocks=[2..10] ecn_counts=None
[2025-04-30T18:36:42.549814661Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 10
[2025-04-30T18:36:42.549822316Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.549826273Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.549828818Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.549831002Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.550909619Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.550915290Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.550919428Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=16 
[2025-04-30T18:36:42.550923575Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=3 blocks=[2..11] ecn_counts=None
[2025-04-30T18:36:42.550926341Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 11
[2025-04-30T18:36:42.550933083Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.550936971Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.550939455Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.550941639Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.552038501Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.552044111Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.552048239Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=17 
[2025-04-30T18:36:42.552058839Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=5 blocks=[2..12] ecn_counts=None
[2025-04-30T18:36:42.552061835Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 12
[2025-04-30T18:36:42.552069489Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.552073637Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.552076191Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.552078325Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.553232314Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.553245248Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.553253433Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=18 
[2025-04-30T18:36:42.553259023Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=5 blocks=[2..13] ecn_counts=None
[2025-04-30T18:36:42.553262730Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 13
[2025-04-30T18:36:42.553274663Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.553278991Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.553281726Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.553283940Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.553636460Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.553640156Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.553644204Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=19 
[2025-04-30T18:36:42.553648252Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=3 blocks=[2..14] ecn_counts=None
[2025-04-30T18:36:42.553651077Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 14
[2025-04-30T18:36:42.553657860Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.553661647Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.553664161Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.553666325Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.574959652Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.575021999Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.575035173Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=20 
[2025-04-30T18:36:42.575048037Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=8 blocks=[2..15] ecn_counts=None
[2025-04-30T18:36:42.575054299Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 15
[2025-04-30T18:36:42.575077452Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.575087250Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.575092019Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.575095285Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.576022981Z TRACE quiche_server] got 43 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.576029893Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.576047016Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=22 pn=21 
[2025-04-30T18:36:42.576051765Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm ACK delay=7 blocks=[2..16] ecn_counts=None
[2025-04-30T18:36:42.576055051Z TRACE quiche::recovery::congestion::recovery] 2e6d4629edf9c25318b454b516a2f148a9234bae packet newly acked 16
[2025-04-30T18:36:42.576063807Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 43 bytes
[2025-04-30T18:36:42.576068025Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.576070630Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.576072814Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.576955825Z TRACE quiche_server] got 49 bytes from [fd00:cafe:cafe::100]:46880 to [::]:443
[2025-04-30T18:36:42.576959612Z TRACE quiche_server] got packet Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false
[2025-04-30T18:36:42.576963710Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx pkt Short dcid=2e6d4629edf9c25318b454b516a2f148a9234bae key_phase=false len=28 pn=22 
[2025-04-30T18:36:42.576968339Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae rx frm APPLICATION_CLOSE err=100 reason=[6b, 74, 68, 78, 62, 79, 65]
[2025-04-30T18:36:42.576975653Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae processed 49 bytes
[2025-04-30T18:36:42.577002463Z TRACE quiche_server] recv() would block
[2025-04-30T18:36:42.577004977Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.577007201Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.743218690Z TRACE quiche_server] timed out
[2025-04-30T18:36:42.743248907Z TRACE quiche] 2e6d4629edf9c25318b454b516a2f148a9234bae draining timeout expired
[2025-04-30T18:36:42.743294452Z TRACE quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae done writing
[2025-04-30T18:36:42.743297648Z TRACE quiche_server] Collecting garbage
[2025-04-30T18:36:42.743300894Z INFO  quiche_server] 2e6d4629edf9c25318b454b516a2f148a9234bae connection collected recv=23 sent=19 lost=0 retrans=0 sent_bytes=17848 recv_bytes=2634 lost_bytes=0 [local_addr=[::]:443 peer_addr=[fd00:cafe:cafe::100]:46880 validation_state=Validated active=true recv=23 sent=19 lost=0 retrans=0 rtt=35.967847ms min_rtt=Some(31.466018ms) rttvar=4.768526ms cwnd=14850 sent_bytes=17848 recv_bytes=2634 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=424863]