[2025-04-30T17:37:29.097071501Z INFO  quiche_server] listening on [::]:443
[2025-04-30T17:37:29.097095045Z TRACE mio::poll] registering event source with poller: token=Token(0), interests=READABLE
[2025-04-30T17:37:29.097102148Z TRACE quiche_server] GSO detected: false
[2025-04-30T17:37:29.899973693Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:36004 to [::]:443
[2025-04-30T17:37:29.900003990Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T17:37:29.900011253Z WARN  quiche_server] Doing version negotiation
[2025-04-30T17:37:29.900096552Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:36004 to [::]:443
[2025-04-30T17:37:29.900101572Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T17:37:29.900104547Z WARN  quiche_server] Doing version negotiation
[2025-04-30T17:37:29.900132179Z TRACE quiche_server] got 1207 bytes from [::ffff:193.167.100.2]:36004 to [::]:443
[2025-04-30T17:37:29.900138029Z TRACE quiche_server] got packet Initial version=57414954 dcid= scid= token=
[2025-04-30T17:37:29.900142758Z WARN  quiche_server] Doing version negotiation
[2025-04-30T17:37:29.900166182Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.296367761Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:47713 to [::]:443
[2025-04-30T17:37:30.296389391Z TRACE quiche_server] got packet Initial version=1 dcid=8a413a86604864cc scid=3be6060a6177bbc7 token=
[2025-04-30T17:37:30.296397496Z DEBUG quiche_server] New connection: dcid=8a413a86604864cc scid=07783a96ea4525184f5607f73453a16607a43746
[2025-04-30T17:37:30.296577372Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Initial version=1 dcid=8a413a86604864cc scid=3be6060a6177bbc7 token= len=504 pn=0 
[2025-04-30T17:37:30.296588342Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm CRYPTO off=0 len=482
[2025-04-30T17:37:30.296612778Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T17:37:30.296616565Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T17:37:30.296712704Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 write message lvl=Initial len=123
[2025-04-30T17:37:30.296741157Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 set write secret lvl=Handshake
[2025-04-30T17:37:30.296830023Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 write message lvl=Handshake len=711
[2025-04-30T17:37:30.296834962Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 set write secret lvl=OneRTT
[2025-04-30T17:37:30.296842877Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 set read secret lvl=Handshake
[2025-04-30T17:37:30.296872382Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 dropped invalid packet
[2025-04-30T17:37:30.296875407Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 processed 1200 bytes
[2025-04-30T17:37:30.296892770Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.296903850Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Initial version=1 dcid=3be6060a6177bbc7 scid=07783a96ea4525184f5607f73453a16607a43746 len=132 pn=0 
[2025-04-30T17:37:30.296907107Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm ACK delay=42 blocks=[0..0] ecn_counts=None
[2025-04-30T17:37:30.296912046Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm CRYPTO off=0 len=123
[2025-04-30T17:37:30.296920652Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=998.973551ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=187 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 341, tv_nsec: 953127788 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 953127788 }, 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: 341, tv_nsec: 953127788 }, next_time: Instant { tv_sec: 341, tv_nsec: 953127788 }, 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-30T17:37:30.296948093Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Handshake version=1 dcid=3be6060a6177bbc7 scid=07783a96ea4525184f5607f73453a16607a43746 len=715 pn=1 
[2025-04-30T17:37:30.296950948Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm CRYPTO off=0 len=711
[2025-04-30T17:37:30.296956508Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=998.938255ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=956 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 341, tv_nsec: 953127788 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 953127788 }, 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: 341, tv_nsec: 953127788 }, next_time: Instant { tv_sec: 341, tv_nsec: 953127788 }, 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-30T17:37:30.297005440Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47713, at: Instant { tv_sec: 341, tv_nsec: 953127788 } })
[2025-04-30T17:37:30.297011521Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.297016190Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.297019737Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 done writing
[2025-04-30T17:37:30.297022081Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.332008196Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:47713 to [::]:443
[2025-04-30T17:37:30.332040987Z TRACE quiche_server] got packet Initial version=1 dcid=07783a96ea4525184f5607f73453a16607a43746 scid=3be6060a6177bbc7 token=
[2025-04-30T17:37:30.332056716Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Initial version=1 dcid=07783a96ea4525184f5607f73453a16607a43746 scid=3be6060a6177bbc7 token= len=24 pn=1 
[2025-04-30T17:37:30.332069520Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm ACK delay=275 blocks=[0..0] ecn_counts=None
[2025-04-30T17:37:30.332077284Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 packet newly acked 0
[2025-04-30T17:37:30.332104295Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Handshake version=1 dcid=07783a96ea4525184f5607f73453a16607a43746 scid=3be6060a6177bbc7 len=80 pn=2 
[2025-04-30T17:37:30.332110266Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm ACK delay=275 blocks=[1..1] ecn_counts=None
[2025-04-30T17:37:30.332113792Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 packet newly acked 1
[2025-04-30T17:37:30.332117780Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm CRYPTO off=0 len=52
[2025-04-30T17:37:30.332140152Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 set read secret lvl=OneRTT
[2025-04-30T17:37:30.332197128Z TRACE quiche::tls] 07783a96ea4525184f5607f73453a16607a43746 write message lvl=OneRTT len=428
[2025-04-30T17:37:30.332208680Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 dropped epoch 1 state
[2025-04-30T17:37:30.332213418Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 connection established: proto=Ok("hq-interop") cipher=Some(AES256_GCM) curve=Some("P-256") sigalg=None resumed=false TransportParams { original_destination_connection_id: None, max_idle_timeout: 60000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 1048576, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 1048576, initial_max_streams_bidi: 128, initial_max_streams_uni: 128, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(3be6060a6177bbc7), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T17:37:30.332239086Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 dropped epoch 0 state
[2025-04-30T17:37:30.332243114Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false len=1000 pn=3 
[2025-04-30T17:37:30.332251379Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[a0, 6d, f0, 0c, 3b, c2, 3f, 38] reset_token=[68, 18, 61, 28, d8, 4a, 62, be, 63, a3, 85, 1e, 74, 89, c4, ff]
[2025-04-30T17:37:30.332260145Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[1d, c2, bf, 97, 3d, 4f, 4f, e4] reset_token=[9c, 93, 7e, 16, ce, b2, b4, ae, 29, b1, 20, 45, 13, b1, 3c, 47]
[2025-04-30T17:37:30.332265626Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[15, 83, 64, 7f, d8, ea, 48, f3] reset_token=[cf, 77, 5c, 17, 55, 17, 5f, e8, cc, c1, fc, 1d, 95, d9, ad, 9e]
[2025-04-30T17:37:30.332270916Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[fa, 29, c3, 15, 57, 88, 4b, 72] reset_token=[eb, 46, b6, 48, e7, 2d, 89, 96, 56, f6, 08, db, d0, 1b, 92, 1f]
[2025-04-30T17:37:30.332276827Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[78, d9, 8a, d6, 52, 0d, 09, 1b] reset_token=[bb, 8e, 01, d7, 52, 97, 45, 24, 31, 11, 50, 53, d5, 94, 93, f0]
[2025-04-30T17:37:30.332282317Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[e6, c2, aa, b2, 8d, 4e, 92, 81] reset_token=[1c, da, 25, 99, 9c, c3, 61, 50, 5f, e8, bd, 08, df, aa, be, 24]
[2025-04-30T17:37:30.332296243Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[1f, 9a, 73, 19, e9, 0b, 09, 96] reset_token=[21, c2, c1, 64, 18, c6, cc, 0a, cf, 07, f1, bc, 29, 1e, b3, d8]
[2025-04-30T17:37:30.332304218Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm PADDING len=786
[2025-04-30T17:37:30.332314827Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 processed 1200 bytes
[2025-04-30T17:37:30.332329795Z TRACE quiche_server] got 60 bytes from [::ffff:193.167.0.100]:47713 to [::]:443
[2025-04-30T17:37:30.332334664Z TRACE quiche_server] got packet Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false
[2025-04-30T17:37:30.332340355Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false len=39 pn=4 
[2025-04-30T17:37:30.332345575Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T17:37:30.332353560Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 processed 60 bytes
[2025-04-30T17:37:30.332356846Z DEBUG quiche_apps::common] 07783a96ea4525184f5607f73453a16607a43746 response stream 0 is writable with capacity Ok(13500)
[2025-04-30T17:37:30.332371563Z TRACE quiche_apps::common] 07783a96ea4525184f5607f73453a16607a43746 received 17 bytes
[2025-04-30T17:37:30.332374849Z TRACE quiche_apps::common] 07783a96ea4525184f5607f73453a16607a43746 stream 0 has 17 bytes (fin? true)
[2025-04-30T17:37:30.332380019Z INFO  quiche_apps::common] 07783a96ea4525184f5607f73453a16607a43746 got GET request for "/www/okbjipnxkz" on stream 0
[2025-04-30T17:37:30.332427297Z INFO  quiche_apps::common] 07783a96ea4525184f5607f73453a16607a43746 sending response of size 5120 on stream 0
[2025-04-30T17:37:30.332436855Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.332447204Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T17:37:30.332459397Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Short dcid=3be6060a6177bbc7 key_phase=false len=1324 pn=2 
[2025-04-30T17:37:30.332463004Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm ACK delay=13 blocks=[3..4] ecn_counts=None
[2025-04-30T17:37:30.332467532Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[44, 7c, 72, d1, 7c, 9f, 96, 37, ef, c0, 48, 23, 59, 11, 58, e5, f1, d3, c9, 4e] reset_token=[9b, d7, d4, 99, 42, 85, fe, f6, 2e, c1, 2b, fd, e7, 56, fb, fb]
[2025-04-30T17:37:30.332474545Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[66, 4a, 5c, 07, a0, d5, fc, 97, eb, e0, d6, d1, ec, f4, bc, 47, 0e, 60, 6c, f0] reset_token=[c4, ab, fb, d4, 90, 2c, 63, 84, 42, dd, e0, ab, 62, bb, 38, 7e]
[2025-04-30T17:37:30.332480897Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[39, e3, 8c, 66, ae, 07, 07, f5, e4, ac, 8a, 85, ee, 55, 7b, a8, 94, dd, 6b, 3d] reset_token=[08, aa, 23, 85, 8b, 1b, a0, bd, 8a, 2e, ac, 1c, ec, df, ce, 83]
[2025-04-30T17:37:30.332487099Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[a1, b9, 60, eb, 06, ed, dc, c4, 3f, a2, 2d, c2, 5b, b1, b3, 6c, 02, 05, 25, 2b] reset_token=[00, 06, 60, 35, 3a, e9, 0c, 1c, 4b, fb, 5e, f5, 7a, d2, 78, 21]
[2025-04-30T17:37:30.332493330Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[71, 64, b4, 86, 41, 16, d7, 0c, a5, 03, a1, d3, 41, 62, ea, 12, ef, dd, ce, 63] reset_token=[f1, 48, 23, 08, 0e, 02, 2f, 45, 08, 1e, f0, a8, b1, 14, 14, 6f]
[2025-04-30T17:37:30.332499632Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[50, 5f, 23, cc, d6, 10, 7d, b1, 30, 54, 88, 9a, 50, 53, ce, 91, c6, e0, 22, bb] reset_token=[40, 9f, a6, 98, d4, 31, ca, 60, e8, f8, 51, 28, fe, 8c, 84, 42]
[2025-04-30T17:37:30.332505543Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[ac, da, 8e, ea, 0d, 06, 58, 9b, 42, 8d, 85, 41, 74, d9, 5c, f7, 9b, 08, df, 09] reset_token=[4e, 33, 10, c3, 4d, 57, 0c, 68, fa, 96, 6f, 06, 6b, 8e, 9b, 14]
[2025-04-30T17:37:30.332511955Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm HANDSHAKE_DONE
[2025-04-30T17:37:30.332514760Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm CRYPTO off=0 len=428
[2025-04-30T17:37:30.332517696Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm STREAM id=0 off=0 len=601 fin=false
[2025-04-30T17:37:30.332535499Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=112.854203ms latest_rtt=35.20852ms srtt=35.163583ms min_rtt=35.157164ms rttvar=13.196775ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 956, delivered_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27192, is_app_limited: true, interval: 35.157164ms, delivered: 956, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 341, tv_nsec: 953127788 }), send_elapsed: 0ns, ack_elapsed: 35.157164ms, rtt: 35.157164ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 479899, last_update: Instant { tv_sec: 341, tv_nsec: 988672705 }, next_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, 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-30T17:37:30.332562840Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324
[2025-04-30T17:37:30.332567438Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Short dcid=3be6060a6177bbc7 key_phase=false len=1324 pn=3 
[2025-04-30T17:37:30.332570584Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm STREAM id=0 off=601 len=1318 fin=false
[2025-04-30T17:37:30.332577107Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=112.933782ms latest_rtt=35.20852ms srtt=35.163583ms min_rtt=35.157164ms rttvar=13.196775ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 956, delivered_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27192, is_app_limited: true, interval: 35.157164ms, delivered: 956, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 341, tv_nsec: 953127788 }), send_elapsed: 0ns, ack_elapsed: 35.157164ms, rtt: 35.157164ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 479899, last_update: Instant { tv_sec: 341, tv_nsec: 988672705 }, next_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, 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-30T17:37:30.332616891Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1324
[2025-04-30T17:37:30.332621730Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Short dcid=3be6060a6177bbc7 key_phase=false len=1324 pn=4 
[2025-04-30T17:37:30.332624736Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm STREAM id=0 off=1919 len=1318 fin=false
[2025-04-30T17:37:30.332630847Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=112.933892ms latest_rtt=35.20852ms srtt=35.163583ms min_rtt=35.157164ms rttvar=13.196775ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 956, delivered_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27192, is_app_limited: true, interval: 35.157164ms, delivered: 956, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 341, tv_nsec: 953127788 }), send_elapsed: 0ns, ack_elapsed: 35.157164ms, rtt: 35.157164ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 479899, last_update: Instant { tv_sec: 341, tv_nsec: 988672705 }, next_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, 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-30T17:37:30.332646676Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1324
[2025-04-30T17:37:30.332650473Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Short dcid=3be6060a6177bbc7 key_phase=false len=1324 pn=5 
[2025-04-30T17:37:30.332653399Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm STREAM id=0 off=3237 len=1318 fin=false
[2025-04-30T17:37:30.332658989Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=112.936827ms latest_rtt=35.20852ms srtt=35.163583ms min_rtt=35.157164ms rttvar=13.196775ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 956, delivered_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, end_of_app_limited: 4, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27192, is_app_limited: true, interval: 35.157164ms, delivered: 956, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 341, tv_nsec: 953127788 }), send_elapsed: 0ns, ack_elapsed: 35.157164ms, rtt: 35.157164ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 479899, last_update: Instant { tv_sec: 341, tv_nsec: 988672705 }, next_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, 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-30T17:37:30.332670361Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1324
[2025-04-30T17:37:30.332673877Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx pkt Short dcid=3be6060a6177bbc7 key_phase=false len=571 pn=6 
[2025-04-30T17:37:30.332676793Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 tx frm STREAM id=0 off=4555 len=565 fin=true
[2025-04-30T17:37:30.332682964Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 timer=112.936647ms latest_rtt=35.20852ms srtt=35.163583ms min_rtt=35.157164ms rttvar=13.196775ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5997 app_limited=true congestion_recovery_start_time=None Rate { delivered: 956, delivered_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, first_sent_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, end_of_app_limited: 5, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 27192, is_app_limited: true, interval: 35.157164ms, delivered: 956, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 341, tv_nsec: 953127788 }), send_elapsed: 0ns, ack_elapsed: 35.157164ms, rtt: 35.157164ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 479899, last_update: Instant { tv_sec: 341, tv_nsec: 988672705 }, next_time: Instant { tv_sec: 341, tv_nsec: 988672705 }, 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-30T17:37:30.332851027Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 written 5997 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:47713, at: Instant { tv_sec: 341, tv_nsec: 988672705 } })
[2025-04-30T17:37:30.332872948Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.332879520Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.332884189Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 done writing
[2025-04-30T17:37:30.332887005Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.367797587Z TRACE quiche_server] got 45 bytes from [::ffff:193.167.0.100]:47713 to [::]:443
[2025-04-30T17:37:30.367831049Z TRACE quiche_server] got packet Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false
[2025-04-30T17:37:30.367846979Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false len=24 pn=5 
[2025-04-30T17:37:30.367860384Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm ACK delay=394 blocks=[2..2] ecn_counts=None
[2025-04-30T17:37:30.367867507Z TRACE quiche::recovery::congestion::recovery] 07783a96ea4525184f5607f73453a16607a43746 packet newly acked 2
[2025-04-30T17:37:30.367893917Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 processed 45 bytes
[2025-04-30T17:37:30.367902222Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.367907201Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 done writing
[2025-04-30T17:37:30.367910287Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.368717493Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:47713 to [::]:443
[2025-04-30T17:37:30.368724435Z TRACE quiche_server] got packet Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false
[2025-04-30T17:37:30.368730116Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx pkt Short dcid=07783a96ea4525184f5607f73453a16607a43746 key_phase=false len=22 pn=6 
[2025-04-30T17:37:30.368736037Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 rx frm APPLICATION_CLOSE err=100 reason=[]
[2025-04-30T17:37:30.368743681Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 processed 43 bytes
[2025-04-30T17:37:30.368747489Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.368749813Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 done writing
[2025-04-30T17:37:30.368752007Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.595045051Z TRACE quiche_server] timed out
[2025-04-30T17:37:30.595081569Z TRACE quiche] 07783a96ea4525184f5607f73453a16607a43746 draining timeout expired
[2025-04-30T17:37:30.595131482Z TRACE quiche_server] 07783a96ea4525184f5607f73453a16607a43746 done writing
[2025-04-30T17:37:30.595135299Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.595139286Z INFO  quiche_server] 07783a96ea4525184f5607f73453a16607a43746 connection collected recv=7 sent=7 lost=0 retrans=0 sent_bytes=6953 recv_bytes=1878 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:47713 validation_state=Validated active=true recv=7 sent=7 lost=0 retrans=0 rtt=35.193413ms min_rtt=Some(35.157164ms) rttvar=9.957242ms cwnd=13500 sent_bytes=6953 recv_bytes=1878 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=38133]
[2025-04-30T17:37:30.934757968Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:30.934801268Z TRACE quiche_server] got packet Initial version=1 dcid=2b0604b4fbf0c50a scid=02876044a950d4d2 token=
[2025-04-30T17:37:30.934809554Z DEBUG quiche_server] New connection: dcid=2b0604b4fbf0c50a scid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6
[2025-04-30T17:37:30.934965134Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Initial version=1 dcid=2b0604b4fbf0c50a scid=02876044a950d4d2 token= len=759 pn=0 
[2025-04-30T17:37:30.934978719Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm CRYPTO off=0 len=737
[2025-04-30T17:37:30.935006942Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("h3")
[2025-04-30T17:37:30.935019245Z TRACE quiche::tls] checking peer ALPN Ok("hq-interop") against Ok("hq-interop")
[2025-04-30T17:37:30.935158254Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 write message lvl=Initial len=129
[2025-04-30T17:37:30.935178131Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 set write secret lvl=Handshake
[2025-04-30T17:37:30.935213086Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 write message lvl=Handshake len=164
[2025-04-30T17:37:30.935215571Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 set write secret lvl=OneRTT
[2025-04-30T17:37:30.935222804Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 set read secret lvl=Handshake
[2025-04-30T17:37:30.935247500Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 dropped invalid packet
[2025-04-30T17:37:30.935250506Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 1200 bytes
[2025-04-30T17:37:30.935266796Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.935278208Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Initial version=1 dcid=02876044a950d4d2 scid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 len=138 pn=0 
[2025-04-30T17:37:30.935281313Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm ACK delay=41 blocks=[0..0] ecn_counts=None
[2025-04-30T17:37:30.935286072Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm CRYPTO off=0 len=129
[2025-04-30T17:37:30.935295079Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=998.973351ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=193 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 342, tv_nsec: 591501825 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 591501825 }, 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: 342, tv_nsec: 591501825 }, next_time: Instant { tv_sec: 342, tv_nsec: 591501825 }, 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-30T17:37:30.935314045Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Handshake version=1 dcid=02876044a950d4d2 scid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 len=168 pn=1 
[2025-04-30T17:37:30.935316830Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm CRYPTO off=0 len=164
[2025-04-30T17:37:30.935322089Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=998.946661ms latest_rtt=0ns srtt=333ms min_rtt=333ms rttvar=166.5ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=415 app_limited=true congestion_recovery_start_time=None Rate { delivered: 0, delivered_time: Instant { tv_sec: 342, tv_nsec: 591501825 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 591501825 }, 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: 342, tv_nsec: 591501825 }, next_time: Instant { tv_sec: 342, tv_nsec: 591501825 }, 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-30T17:37:30.935371121Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 written 1200 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:60016, at: Instant { tv_sec: 342, tv_nsec: 591501825 } })
[2025-04-30T17:37:30.935377332Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.935382863Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.935388413Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:30.935392070Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.970027783Z TRACE quiche_server] got 1200 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:30.970057238Z TRACE quiche_server] got packet Initial version=1 dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 scid=02876044a950d4d2 token=
[2025-04-30T17:37:30.970073859Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Initial version=1 dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 scid=02876044a950d4d2 token= len=24 pn=1 
[2025-04-30T17:37:30.970087915Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm ACK delay=223 blocks=[0..0] ecn_counts=None
[2025-04-30T17:37:30.970094677Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 0
[2025-04-30T17:37:30.970117570Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Handshake version=1 dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 scid=02876044a950d4d2 len=80 pn=2 
[2025-04-30T17:37:30.970122429Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm ACK delay=223 blocks=[1..1] ecn_counts=None
[2025-04-30T17:37:30.970125505Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 1
[2025-04-30T17:37:30.970128881Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm CRYPTO off=0 len=52
[2025-04-30T17:37:30.970149129Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 set read secret lvl=OneRTT
[2025-04-30T17:37:30.970183253Z TRACE quiche::tls] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 write message lvl=OneRTT len=428
[2025-04-30T17:37:30.970192860Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 dropped epoch 1 state
[2025-04-30T17:37:30.970197018Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 connection established: proto=Ok("hq-interop") cipher=Some(AES256_GCM) curve=Some("P-256") sigalg=None resumed=true TransportParams { original_destination_connection_id: None, max_idle_timeout: 60000, stateless_reset_token: None, max_udp_payload_size: 65527, initial_max_data: 1048576, initial_max_stream_data_bidi_local: 1048576, initial_max_stream_data_bidi_remote: 1048576, initial_max_stream_data_uni: 1048576, initial_max_streams_bidi: 128, initial_max_streams_uni: 128, ack_delay_exponent: 3, max_ack_delay: 25, disable_active_migration: false, active_conn_id_limit: 8, initial_source_connection_id: Some(02876044a950d4d2), retry_source_connection_id: None, max_datagram_frame_size: None, unknown_params: None }
[2025-04-30T17:37:30.970216234Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 dropped epoch 0 state
[2025-04-30T17:37:30.970219129Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=1000 pn=3 
[2025-04-30T17:37:30.970225792Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[ee, 79, 72, 0e, 29, fe, 03, ce] reset_token=[72, ee, fc, 6d, 73, 0b, 59, 49, ca, 1f, ef, 12, 89, f8, b9, c5]
[2025-04-30T17:37:30.970232945Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[50, bf, 73, 8f, 2e, f7, 8a, 4a] reset_token=[df, b2, 08, 7e, d6, 66, f6, 06, 70, 99, 1b, 7a, 85, 24, c9, d9]
[2025-04-30T17:37:30.970237664Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[58, 95, bf, 73, 7f, 61, 63, a2] reset_token=[66, ee, 43, 0e, 60, 57, 0f, 2b, e3, 3b, 76, 51, 71, 83, 0b, c1]
[2025-04-30T17:37:30.970252351Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[a4, 7d, ab, fb, 86, 2d, 4f, a5] reset_token=[e6, 4a, 81, 00, a4, 09, ff, a8, fe, 38, d2, ef, 94, b5, 06, 01]
[2025-04-30T17:37:30.970257301Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[5c, bf, 8f, 62, 38, f5, 57, ed] reset_token=[50, c1, c9, 54, fb, 92, 2f, 1e, 3c, 7a, 38, 10, b8, 50, 34, 20]
[2025-04-30T17:37:30.970261619Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[23, f2, 1a, 69, 51, 7f, 87, 37] reset_token=[b8, 29, 71, 32, 46, 0b, 4f, e3, 92, 81, e9, 4f, 78, 6d, 52, ee]
[2025-04-30T17:37:30.970265917Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[c4, 2d, fe, 8d, 91, 18, b4, 4e] reset_token=[ec, 96, 56, a7, aa, 01, 92, eb, a8, 8d, 1c, 74, f0, 72, 06, d2]
[2025-04-30T17:37:30.970271898Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm PADDING len=786
[2025-04-30T17:37:30.970280444Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 1200 bytes
[2025-04-30T17:37:30.970289050Z TRACE quiche_server] got 60 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:30.970292216Z TRACE quiche_server] got packet Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false
[2025-04-30T17:37:30.970296153Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=39 pn=4 
[2025-04-30T17:37:30.970300131Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm STREAM id=0 off=0 len=17 fin=true
[2025-04-30T17:37:30.970306683Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 60 bytes
[2025-04-30T17:37:30.970309298Z DEBUG quiche_apps::common] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 response stream 0 is writable with capacity Ok(13500)
[2025-04-30T17:37:30.970315389Z TRACE quiche_apps::common] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 received 17 bytes
[2025-04-30T17:37:30.970317793Z TRACE quiche_apps::common] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 stream 0 has 17 bytes (fin? true)
[2025-04-30T17:37:30.970321781Z INFO  quiche_apps::common] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 got GET request for "/www/yidwprgfue" on stream 0
[2025-04-30T17:37:30.970357087Z INFO  quiche_apps::common] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 sending response of size 10240 on stream 0
[2025-04-30T17:37:30.970365873Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.970374850Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=false cwnd_avail=13500 out_len=1350 left=1319
[2025-04-30T17:37:30.970384217Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=2 
[2025-04-30T17:37:30.970387153Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm ACK delay=9 blocks=[3..4] ecn_counts=None
[2025-04-30T17:37:30.970390249Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=1 retire_prior_to=0 conn_id=[de, 6a, c2, 04, 1d, 32, 77, a2, bc, 01, 05, 5f, f6, 35, 6b, b1, f8, db, 25, 3d] reset_token=[1e, fd, 4d, 60, 16, e8, a5, 83, 39, ab, 52, 7d, 46, 5a, 5f, 4a]
[2025-04-30T17:37:30.970395809Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=2 retire_prior_to=0 conn_id=[17, c7, 48, 21, 43, 75, 82, c5, 38, 2e, b1, 64, 7d, b0, c9, 46, 87, 70, 4a, bf] reset_token=[bd, 83, ad, 7a, 17, 4f, 4a, 5b, 3e, d3, f9, af, 81, 14, dd, d0]
[2025-04-30T17:37:30.970400788Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=3 retire_prior_to=0 conn_id=[c0, 53, 49, 55, c5, 65, e3, 10, 20, f0, dc, 88, 88, 16, 25, d3, 2f, f4, 8d, ba] reset_token=[19, 9c, b8, db, 9e, 01, b3, c9, e8, 66, a1, f8, 60, 49, 57, 69]
[2025-04-30T17:37:30.970410376Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=4 retire_prior_to=0 conn_id=[e9, 3d, 92, db, 2d, 74, 83, c5, 87, 1b, 43, 13, 75, 34, d6, c4, 28, cd, 1e, 80] reset_token=[52, 2d, 88, eb, 46, 85, 77, 8d, 14, 78, 5f, 66, b6, c1, b6, 4f]
[2025-04-30T17:37:30.970415346Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=5 retire_prior_to=0 conn_id=[40, ae, 5a, ef, d9, 5b, 64, d0, b3, 9b, dc, 98, 45, fb, 50, d9, 06, b6, 9c, 3d] reset_token=[1b, 0f, 37, 31, 5c, 25, d4, 20, 38, d6, b7, 73, 7d, 72, 00, f7]
[2025-04-30T17:37:30.970420345Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=6 retire_prior_to=0 conn_id=[ad, e6, 7b, 70, a7, a1, 38, bb, d4, d1, 50, fc, 4a, 6d, e0, 16, e9, 66, 9e, f0] reset_token=[fd, e2, 25, 57, 54, d0, 4c, 5a, c9, b8, 8c, d5, fc, 21, f2, 21]
[2025-04-30T17:37:30.970425224Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm NEW_CONNECTION_ID seq_num=7 retire_prior_to=0 conn_id=[1e, 1d, f0, 99, d6, e8, 39, 41, 7c, 54, a0, b5, c7, 01, d3, c7, 31, 3a, 5b, 53] reset_token=[04, e1, ec, a1, a6, a0, a0, 9e, d0, d0, 47, 8b, 2f, ea, ae, b0]
[2025-04-30T17:37:30.970430203Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm HANDSHAKE_DONE
[2025-04-30T17:37:30.970432527Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm CRYPTO off=0 len=428
[2025-04-30T17:37:30.970434822Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=0 len=601 fin=false
[2025-04-30T17:37:30.970446974Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=111.973545ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=1350 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 1, last_sent_packet: 2, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970464577Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=12150 out_len=1350 left=1324
[2025-04-30T17:37:30.970468054Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=3 
[2025-04-30T17:37:30.970470518Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=601 len=1318 fin=false
[2025-04-30T17:37:30.970475487Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.039798ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=2700 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 2, last_sent_packet: 3, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970510944Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=10800 out_len=1350 left=1324
[2025-04-30T17:37:30.970514430Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=4 
[2025-04-30T17:37:30.970516865Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=1919 len=1318 fin=false
[2025-04-30T17:37:30.970522044Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.039908ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=4050 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 4, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970531512Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=9450 out_len=1350 left=1324
[2025-04-30T17:37:30.970534558Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=5 
[2025-04-30T17:37:30.970536842Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=3237 len=1318 fin=false
[2025-04-30T17:37:30.970541130Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.041922ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=5400 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 5, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970553343Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=8100 out_len=1350 left=1324
[2025-04-30T17:37:30.970556178Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=6 
[2025-04-30T17:37:30.970558492Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=4555 len=1318 fin=false
[2025-04-30T17:37:30.970563021Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.041893ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=6750 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 6, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970572058Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=6750 out_len=1350 left=1324
[2025-04-30T17:37:30.970574893Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=7 
[2025-04-30T17:37:30.970577167Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=5873 len=1318 fin=false
[2025-04-30T17:37:30.970581405Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.042242ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=8100 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 7, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970590412Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=5400 out_len=1350 left=1324
[2025-04-30T17:37:30.970593317Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=8 
[2025-04-30T17:37:30.970598307Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=7191 len=1318 fin=false
[2025-04-30T17:37:30.970602695Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.039306ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=9450 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 8, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970611722Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=4050 out_len=1350 left=1324
[2025-04-30T17:37:30.970614617Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=1324 pn=9 
[2025-04-30T17:37:30.970616901Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=8509 len=1318 fin=false
[2025-04-30T17:37:30.970626609Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.036642ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=10800 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 9, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970635847Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 pmtud probe status false hs_con=true hs_sent=true cwnd_avail=2700 out_len=1350 left=1324
[2025-04-30T17:37:30.970638712Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx pkt Short dcid=02876044a950d4d2 key_phase=false len=419 pn=10 
[2025-04-30T17:37:30.970641066Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 tx frm STREAM id=0 off=9827 len=413 fin=true
[2025-04-30T17:37:30.970645384Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 timer=112.042012ms latest_rtt=34.847918ms srtt=34.805198ms min_rtt=34.799097ms rttvar=13.061866ms cwnd=13500 ssthresh=18446744073709551615 bytes_in_flight=11245 app_limited=true congestion_recovery_start_time=None Rate { delivered: 415, delivered_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, first_sent_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, end_of_app_limited: 3, last_sent_packet: 10, largest_acked: 1, rate_sample: RateSample { delivery_rate: 11925, is_app_limited: true, interval: 34.799097ms, delivered: 415, prior_delivered: 0, prior_time: Some(Instant { tv_sec: 342, tv_nsec: 591501825 }), send_elapsed: 0ns, ack_elapsed: 34.799097ms, rtt: 34.799097ms } } pacer=Pacer { enabled: false, capacity: 13500, used: 0, rate: 484841, last_update: Instant { tv_sec: 342, tv_nsec: 626601092 }, next_time: Instant { tv_sec: 342, tv_nsec: 626601092 }, 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-30T17:37:30.970861908Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 written 11245 bytes with Some(SendInfo { from: [::]:443, to: [::ffff:193.167.0.100]:60016, at: Instant { tv_sec: 342, tv_nsec: 626601092 } })
[2025-04-30T17:37:30.970875664Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:30.970883528Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:30.970888598Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:30.970892205Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.003909237Z TRACE quiche_server] got 45 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:31.003929946Z TRACE quiche_server] got packet Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false
[2025-04-30T17:37:31.003943271Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=24 pn=5 
[2025-04-30T17:37:31.003956125Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm ACK delay=186 blocks=[2..2] ecn_counts=None
[2025-04-30T17:37:31.003962917Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 2
[2025-04-30T17:37:31.003989627Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 45 bytes
[2025-04-30T17:37:31.003997592Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:31.004002391Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:31.004005677Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.005629826Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:31.005636178Z TRACE quiche_server] got packet Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false
[2025-04-30T17:37:31.005641057Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=23 pn=6 
[2025-04-30T17:37:31.005645565Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm ACK delay=8 blocks=[2..5] ecn_counts=None
[2025-04-30T17:37:31.005648581Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 3
[2025-04-30T17:37:31.005650945Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 4
[2025-04-30T17:37:31.005653209Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 5
[2025-04-30T17:37:31.005662387Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 44 bytes
[2025-04-30T17:37:31.005666094Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:31.005668678Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:31.005670833Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.007780076Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:31.007794974Z TRACE quiche_server] got packet Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false
[2025-04-30T17:37:31.007800414Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=23 pn=7 
[2025-04-30T17:37:31.007805473Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm ACK delay=6 blocks=[2..7] ecn_counts=None
[2025-04-30T17:37:31.007809180Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 6
[2025-04-30T17:37:31.007812025Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 7
[2025-04-30T17:37:31.007821413Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 44 bytes
[2025-04-30T17:37:31.007826012Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:31.007829027Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:31.007831722Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.010019642Z TRACE quiche_server] got 44 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:31.010026455Z TRACE quiche_server] got packet Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false
[2025-04-30T17:37:31.010031524Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=23 pn=8 
[2025-04-30T17:37:31.010036343Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm ACK delay=6 blocks=[2..9] ecn_counts=None
[2025-04-30T17:37:31.010039930Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 8
[2025-04-30T17:37:31.010042685Z TRACE quiche::recovery::congestion::recovery] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 packet newly acked 9
[2025-04-30T17:37:31.010052193Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 44 bytes
[2025-04-30T17:37:31.010056641Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:31.010059747Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:31.010062412Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.010789578Z TRACE quiche_server] got 43 bytes from [::ffff:193.167.0.100]:60016 to [::]:443
[2025-04-30T17:37:31.010796180Z TRACE quiche_server] got packet Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false
[2025-04-30T17:37:31.010801220Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx pkt Short dcid=95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 key_phase=false len=22 pn=9 
[2025-04-30T17:37:31.010806670Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 rx frm APPLICATION_CLOSE err=100 reason=[]
[2025-04-30T17:37:31.010814124Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 processed 43 bytes
[2025-04-30T17:37:31.010818321Z TRACE quiche_server] recv() would block
[2025-04-30T17:37:31.010821057Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:31.010823651Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.190053212Z TRACE quiche_server] timed out
[2025-04-30T17:37:31.190086424Z TRACE quiche] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 draining timeout expired
[2025-04-30T17:37:31.190138932Z TRACE quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 done writing
[2025-04-30T17:37:31.190142830Z TRACE quiche_server] Collecting garbage
[2025-04-30T17:37:31.190146847Z INFO  quiche_server] 95bdc751b4bb2f2e48ed8a82ee6ee9db3113a3f6 connection collected recv=10 sent=11 lost=0 retrans=0 sent_bytes=11660 recv_bytes=2265 lost_bytes=0 [local_addr=[::]:443 peer_addr=[::ffff:193.167.0.100]:60016 validation_state=Validated active=true recv=10 sent=11 lost=0 retrans=0 rtt=35.623578ms min_rtt=Some(33.571817ms) rttvar=5.980729ms cwnd=13500 sent_bytes=11660 recv_bytes=2265 lost_bytes=0 stream_retrans_bytes=0 pmtu=1350 delivery_rate=321698]