0.059547639s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.059668534s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.059685246s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.059694693s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.059775434s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.059798096s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.061259829s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.061367550s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.061412744s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.061476944s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=110µs 0.814844840s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.814939516s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.815030075s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.815062084s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.815089976s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.815107018s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.815128188s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.815144528s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.815197096s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.815215961s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.815233554s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.815245827s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.815261466s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.815273268s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.815294487s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=465µs 1.060923167s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.061007124s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.061041408s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=132µs 1.844217081s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.844294716s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.844345981s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.844739805s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.844816247s s2n_quic:server:conn: connection_started: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } id=0 1.844847495s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.844885977s s2n_quic:server:conn: datagram_received: len=1200 id=0 1.844924850s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Crypto { offset: 0, len: 257 } id=0 1.844988989s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 22, 77, 223, 185, 93, 3, 142, 79, 227, 99, 174, 73, 234, 25, 83, 143, 145, 229, 142, 88, 208, 24, 234, 28, 51, 160, 13, 38, 147, 17, 112, 155, 0, 0, 2, 19, 1, 1, 0, 0, 210, 0, 0, 0, 12, 0, 10, 0, 0, 7, 115, 101, 114, 118, 101, 114, 54, 0, 43, 0, 3, 2, 3, 4, 0, 10, 0, 4, 0, 2, 0, 23, 0, 13, 0, 14, 0, 12, 8, 4, 8, 5, 8, 6, 4, 3, 5, 3, 6, 3, 0, 51, 0, 71, 0, 69, 0, 23, 0, 65, 4, 230, 191, 171, 29, 213, 41, 202, 46, 0, 3, 223, 51, 67, 88, 45, 71, 43, 33, 18, 67, 93, 230, 140, 98, 150, 139, 168, 214, 160, 234, 133, 158, 44, 113, 8, 18, 96, 93, 175, 15, 18, 124, 130, 231, 16, 64, 162, 89, 36, 131, 62, 108, 249, 42, 91, 206, 197, 26, 180, 139, 135, 153, 85, 23, 0, 45, 0, 2, 1, 1, 0, 57, 0, 59, 1, 4, 128, 0, 234, 96, 3, 2, 69, 220, 4, 4, 128, 38, 37, 160, 5, 4, 128, 3, 208, 144, 6, 4, 128, 3, 208, 144, 7, 4, 128, 3, 208, 144, 8, 1, 3, 9, 1, 3, 10, 1, 3, 11, 1, 25, 14, 1, 2, 15, 8, 174, 239, 137, 196, 230, 125, 51, 121, 0, 16, 0, 13, 0, 11, 10, 104, 113, 45, 105, 110, 116, 101, 114, 111, 112]] id=0 1.845042779s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Padding id=0 1.845396729s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.845589628s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.845623361s s2n_quic:server:conn: server_name_information: chosen_server_name="server6" id=0 1.845639200s s2n_quic:server:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 1.845680086s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0xaeef89c4e67d3379), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: true, max_idle_timeout: 60s, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 1500, active_connection_id_limit: 2, initial_max_stream_data_bidi_local: 250000, initial_max_stream_data_bidi_remote: 250000, initial_max_stream_data_uni: 250000, initial_max_streams_bidi: 3, initial_max_streams_uni: 3, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 1.845747783s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.845977801s s2n_quic:server:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.846009931s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 1.846042692s s2n_quic:server:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 123 } id=0 1.846084380s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=184 id=0 1.846114756s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 686 } id=0 1.846134773s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 1.846158027s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1048 id=0 1.846201969s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.846253405s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=25ms pto_count=0 congestion_window=12320 bytes_in_flight=1232 congestion_limited=false id=0 1.846329576s s2n_quic:server: platform_event_loop_sleep: timeout=Some(998.574ms) processing_duration=2.126ms 1.933887911s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.933976816s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.934000050s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.934054321s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.934120755s s2n_quic:server:conn: datagram_received: len=1201 id=0 1.934199001s s2n_quic:server:conn: packet_received: packet_header=Initial { number: 1, version: 1 } id=0 1.934238203s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.934291643s s2n_quic:server:conn: ack_range_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=0 id=0 1.934364358s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=383342 burst_size=12320 pacing_gain=2.77 id=0 1.934412989s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } state=Failed id=0 1.934443496s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 88.133ms, delivered_bytes: 184, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 184, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 2087 } id=0 1.934480034s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=1048 congestion_limited=false id=0 1.934591862s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Padding id=0 1.934725041s s2n_quic:server: platform_event_loop_sleep: timeout=Some(910.18ms) processing_duration=850µs 1.960439467s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.960521921s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.960611207s s2n_quic:server:conn: datagram_received: len=88 id=0 1.960670838s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 0, version: 1 } id=0 1.960707026s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 1.960802283s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 1.960827170s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=1048 congestion_limited=false id=0 1.960998579s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 1.961028054s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 1.961059663s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.961125706s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 1.961152155s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=1048 congestion_limited=false id=0 1.961387764s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 1.961444079s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 1.961531692s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 1.961572679s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.961628442s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 1.961669940s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 1.961693073s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 1.961756431s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=99 id=0 1.961791496s s2n_quic:server:conn: datagram_sent: len=99 gso_offset=0 id=0 1.961847471s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=1551 congestion_limited=false id=0 1.961946986s s2n_quic:server: platform_event_loop_sleep: timeout=Some(288.792ms) processing_duration=1.512ms Accepted a QUIC connection from [fd00:cafe:cafe::100]:60151 on [fd00:cafe:cafe:100::100]:443 1.964961151s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.964999292s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.965020071s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.965056469s s2n_quic:server:conn: datagram_received: len=54 id=0 1.965101222s s2n_quic:server: platform_event_loop_sleep: timeout=Some(285.634ms) processing_duration=143µs 1.989416958s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.989455119s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.989492408s s2n_quic:server:conn: datagram_received: len=76 id=0 1.989566096s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 1.989598285s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 17, is_fin: true } id=0 1.989663006s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 1.989719802s s2n_quic:server:conn: rx_stream_progress: bytes=34 id=0 1.989776468s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.701ms) processing_duration=363µs 1.990522618s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 1.990581116s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 1.990651438s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.990727640s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.990754389s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 2 } path_id=0 ack_range=0..=0 id=0 1.990770760s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 1.990816846s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1197, is_fin: false } id=0 1.990865947s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1232 id=0 1.990894811s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.990927512s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 1.990964110s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 0, offset: 1197, len: 1201, is_fin: false } id=0 1.991011669s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=1232 id=0 1.991028841s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.991069206s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=HandshakeDone id=0 1.991116003s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Stream { id: 0, offset: 2398, len: 1201, is_fin: false } id=0 1.991163081s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=1232 id=0 1.991184921s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.991215569s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=HandshakeDone id=0 1.991256114s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Stream { id: 0, offset: 3599, len: 497, is_fin: false } id=0 1.991295167s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=530 id=0 1.991311457s s2n_quic:server:conn: datagram_sent: len=530 gso_offset=0 id=0 1.991344338s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=5777 congestion_limited=false id=0 1.991380456s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.991416683s s2n_quic:server: platform_event_loop_sleep: timeout=Some(288.67ms) processing_duration=766µs 1.991539813s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.991583113s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.991646011s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.991673522s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.991710080s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=HandshakeDone id=0 1.991743552s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Stream { id: 4, offset: 0, len: 1203, is_fin: false } id=0 1.991782334s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=1232 id=0 1.991798976s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.991827449s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=HandshakeDone id=0 1.991856723s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Stream { id: 4, offset: 1203, len: 1201, is_fin: false } id=0 1.991891007s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 7 } packet_len=1232 id=0 1.991907317s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.991934648s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=HandshakeDone id=0 1.991963763s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=Stream { id: 4, offset: 2404, len: 1201, is_fin: false } id=0 1.992003637s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 8 } packet_len=1232 id=0 1.992020518s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.992048400s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=HandshakeDone id=0 1.992078196s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=Stream { id: 4, offset: 3605, len: 491, is_fin: false } id=0 1.992112950s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 9 } packet_len=524 id=0 1.992129060s s2n_quic:server:conn: datagram_sent: len=524 gso_offset=0 id=0 1.992160118s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=9997 congestion_limited=false id=0 1.992195444s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.992231221s s2n_quic:server: platform_event_loop_sleep: timeout=Some(288.857ms) processing_duration=586µs 1.992326058s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(0) 1.992362876s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(0) 1.992431915s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.992461039s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.992498439s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=HandshakeDone id=0 1.992565413s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=Stream { id: 0, offset: 4096, len: 1024, is_fin: false } id=0 1.992612772s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 10 } packet_len=1057 id=0 1.992630825s s2n_quic:server:conn: datagram_sent: len=1057 gso_offset=0 id=0 1.992664328s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=11054 congestion_limited=false id=0 1.992694043s s2n_quic:server:conn: tx_stream_progress: bytes=1024 id=0 1.992729359s s2n_quic:server: platform_event_loop_sleep: timeout=Some(289.147ms) processing_duration=299µs 1.992803768s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.992840386s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.992900127s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.992927047s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.992963044s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=HandshakeDone id=0 1.992996837s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=Stream { id: 4, offset: 4096, len: 1201, is_fin: false } id=0 1.993035409s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 11 } packet_len=1232 id=0 1.993051699s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.993082276s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xde0b3115d77d87232db60e3d3cb51d54, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=88.133ms smoothed_rtt=88.133ms latest_rtt=88.133ms rtt_variance=44.0665ms max_ack_delay=25ms pto_count=0 congestion_window=12504 bytes_in_flight=12286 congestion_limited=true id=0 1.993111341s s2n_quic:server:conn: tx_stream_progress: bytes=1205 id=0 1.993145835s s2n_quic:server: platform_event_loop_sleep: timeout=Some(289.195ms) processing_duration=247µs 1.993260188s s2n_quic_qns::server::h09: 2048 bytes ready to send on Stream(4) 1.993288691s s2n_quic_qns::server::h09: 2048 bytes sent on Stream(4) 1.999356064s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.999390038s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.999403243s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.999437707s s2n_quic:server:conn: datagram_received: len=42 id=0 1.999469065s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 1.999493731s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0xde0b3115d77d87232db60e3d3cb51d54 current=0x275b0e0b2f4568e2a94ef9bff90b959d id=0 1.999540238s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 1.999572327s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=1 id=0 1.999598987s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 1.999615508s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 1.999667214s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.084ms, delivered_bytes: 1551, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 184, bytes_in_flight: 1551, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 40725 } id=0 1.999699384s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=38.084ms smoothed_rtt=81.876875ms latest_rtt=38.084ms rtt_variance=45.562125ms max_ack_delay=25ms pto_count=0 congestion_window=16287 bytes_in_flight=10735 congestion_limited=false id=0 1.999727567s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=RetireConnectionId id=0 1.999800022s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Ping id=0 1.999855325s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Padding id=0 1.999896441s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 12 } packet_len=5202 id=0 1.999911149s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.999940293s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=38.084ms smoothed_rtt=81.876875ms latest_rtt=38.084ms rtt_variance=45.562125ms max_ack_delay=25ms pto_count=0 congestion_window=16287 bytes_in_flight=15937 congestion_limited=true id=0 1.999996869s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.426ms) processing_duration=643µs 2.024898210s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=true tx_ready=false application_wakeup=false 2.024937814s s2n_quic:server: platform_tx_error: errno=90 2.024951500s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 2.024964453s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.024997726s s2n_quic:server:conn: datagram_received: len=39 id=0 2.025030587s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 2.025058769s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 2.025084307s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=3 id=0 2.025141263s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.084ms, delivered_bytes: 4015, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 184, bytes_in_flight: 1551, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 105424 } id=0 2.025172040s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=75.929138ms latest_rtt=34.295ms rtt_variance=46.067061ms max_ack_delay=25ms pto_count=0 congestion_window=18751 bytes_in_flight=13473 congestion_limited=false id=0 2.025252951s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 2.025278990s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 13 } path_id=0 ack_range=1..=2 id=0 2.025308615s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 0, offset: 5120, len: 0, is_fin: true } id=0 2.025333962s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 4, offset: 5297, len: 1412, is_fin: false } id=0 2.025372584s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 13 } packet_len=1452 id=0 2.025390117s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 2.025433678s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 14 } path_id=0 frame=Stream { id: 4, offset: 6709, len: 1422, is_fin: false } id=0 2.025478441s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 14 } packet_len=1452 id=0 2.025495834s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 2.025563349s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 15 } path_id=0 frame=Stream { id: 4, offset: 8131, len: 1422, is_fin: false } id=0 2.025605227s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 15 } packet_len=1452 id=0 2.025621688s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 2.025640143s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=75.929138ms latest_rtt=34.295ms rtt_variance=46.067061ms max_ack_delay=25ms pto_count=0 congestion_window=18751 bytes_in_flight=17829 congestion_limited=true id=0 2.025666962s s2n_quic:server:conn: tx_stream_progress: bytes=4256 id=0 2.025704382s s2n_quic:server: platform_event_loop_sleep: timeout=Some(7.101ms) processing_duration=809µs 2.026128232s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.026163698s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.026177153s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.026207640s s2n_quic:server:conn: datagram_received: len=39 id=0 2.026237746s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 2.026258715s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 5, ack_range_count: 1 } id=0 2.026280846s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=5 id=0 2.026332112s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.084ms, delivered_bytes: 5777, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 184, bytes_in_flight: 1551, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 151691 } id=0 2.026360254s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=415982 burst_size=2904 pacing_gain=2.77 id=0 2.026379069s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=70.876369ms latest_rtt=35.507ms rtt_variance=44.655829ms max_ack_delay=25ms pto_count=0 congestion_window=20513 bytes_in_flight=16067 congestion_limited=false id=0 2.026433441s s2n_quic:server: platform_event_loop_sleep: timeout=Some(6.372ms) processing_duration=307µs 2.028096258s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.028129069s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.028160979s s2n_quic:server:conn: datagram_received: len=40 id=0 2.028191025s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 2.028212344s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 1 } id=0 2.028237502s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=7 id=0 2.028306290s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.084ms, delivered_bytes: 8241, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 184, bytes_in_flight: 1551, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 216390 } id=0 2.028337638s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=593406 burst_size=2904 pacing_gain=2.77 id=0 2.028355812s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=66.558447ms latest_rtt=36.458ms rtt_variance=42.127713ms max_ack_delay=25ms pto_count=0 congestion_window=22977 bytes_in_flight=13603 congestion_limited=false id=0 2.028416916s s2n_quic:server: platform_event_loop_sleep: timeout=Some(4.389ms) processing_duration=322µs 2.030140677s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.030173037s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.030204957s s2n_quic:server:conn: datagram_received: len=39 id=0 2.030234903s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 2.030255521s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 9, ack_range_count: 1 } id=0 2.030277472s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=9 id=0 2.030328888s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.084ms, delivered_bytes: 9997, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 184, bytes_in_flight: 1551, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 262498 } id=0 2.030355928s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=719850 burst_size=2904 pacing_gain=2.77 id=0 2.030373882s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=63.051385ms latest_rtt=38.502ms rtt_variance=38.609895ms max_ack_delay=25ms pto_count=0 congestion_window=24733 bytes_in_flight=11847 congestion_limited=false id=0 2.030428984s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.377ms) processing_duration=290µs 2.031526900s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.031559821s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.031591841s s2n_quic:server:conn: datagram_received: len=39 id=0 2.031621987s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 2.031642525s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 11, ack_range_count: 1 } id=0 2.031664727s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=0..=11 id=0 2.031719128s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 38.084ms, delivered_bytes: 12286, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 184, bytes_in_flight: 1551, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 322602 } id=0 2.031752560s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=884674 burst_size=2904 pacing_gain=2.77 id=0 2.031771486s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=59.999461ms latest_rtt=38.636ms rtt_variance=35.061265ms max_ack_delay=25ms pto_count=0 congestion_window=27022 bytes_in_flight=9558 congestion_limited=false id=0 2.031841386s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=59.999461ms latest_rtt=38.636ms rtt_variance=35.061265ms max_ack_delay=25ms pto_count=0 congestion_window=27022 bytes_in_flight=9558 congestion_limited=false id=0 2.031941913s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 6, ack_range_count: 1 } id=0 2.031966258s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 16 } path_id=0 ack_range=1..=6 id=0 2.031996845s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Stream { id: 4, offset: 9553, len: 687, is_fin: true } id=0 2.032037511s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 16 } packet_len=724 id=0 2.032054483s s2n_quic:server:conn: datagram_sent: len=724 gso_offset=0 id=0 2.032088456s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=59.999461ms latest_rtt=38.636ms rtt_variance=35.061265ms max_ack_delay=25ms pto_count=0 congestion_window=27022 bytes_in_flight=10282 congestion_limited=false id=0 2.032118261s s2n_quic:server:conn: tx_stream_progress: bytes=683 id=0 2.032150912s s2n_quic:server: platform_event_loop_sleep: timeout=Some(212.901ms) processing_duration=627µs 2.059469322s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.059546386s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.059575540s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.059629431s s2n_quic:server:conn: datagram_received: len=41 id=0 2.059678723s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 7 } id=0 2.059713527s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 14, ack_range_count: 2 } id=0 2.059748082s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=13..=14 id=0 2.059811270s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=4..=11 id=0 2.059856734s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 63.892ms, delivered_bytes: 11175, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4199, bytes_in_flight: 16377, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 174904 } id=0 2.059885468s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=56.796649ms latest_rtt=34.377ms rtt_variance=32.701563ms max_ack_delay=25ms pto_count=0 congestion_window=29926 bytes_in_flight=7378 congestion_limited=false id=0 2.059977379s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 17 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 1 } id=0 2.060003437s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 17 } path_id=0 ack_range=3..=7 id=0 2.060029676s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 17 } path_id=0 frame=Padding id=0 2.060060875s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 17 } packet_len=45 id=0 2.060075712s s2n_quic:server:conn: datagram_sent: len=45 gso_offset=0 id=0 2.060107832s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=34.295ms smoothed_rtt=56.796649ms latest_rtt=34.377ms rtt_variance=32.701563ms max_ack_delay=25ms pto_count=0 congestion_window=29926 bytes_in_flight=7378 congestion_limited=false id=0 2.060164107s s2n_quic:server: platform_event_loop_sleep: timeout=Some(3.517ms) processing_duration=699µs 2.063969296s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.064003730s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.064016865s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.064048464s s2n_quic:server:conn: datagram_received: len=40 id=0 2.064078840s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 8 } id=0 2.064100741s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 8 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 16, ack_range_count: 1 } id=0 2.064123253s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 8 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } ack_range=13..=16 id=0 2.064196169s s2n_quic:server:conn: packet_lost: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } bytes_lost=5202 is_mtu_probe=true id=0 2.064231144s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 70.581ms, delivered_bytes: 5080, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 12470, bytes_in_flight: 10282, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 71974 } id=0 2.064260669s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=32.117ms smoothed_rtt=53.711692ms latest_rtt=32.117ms rtt_variance=30.696082ms max_ack_delay=25ms pto_count=0 congestion_window=32102 bytes_in_flight=0 congestion_limited=false id=0 2.064337031s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 18 } path_id=0 frame=Ping id=0 2.064392705s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 18 } path_id=0 frame=Padding id=0 2.064424935s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 18 } packet_len=5202 id=0 2.064439943s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 2.064471231s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } min_rtt=32.117ms smoothed_rtt=53.711692ms latest_rtt=32.117ms rtt_variance=30.696082ms max_ack_delay=25ms pto_count=0 congestion_window=32102 bytes_in_flight=5202 congestion_limited=false id=0 2.064550960s s2n_quic:server: platform_event_loop_sleep: timeout=Some(27.519ms) processing_duration=583µs 2.074665232s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.074707811s s2n_quic:server: platform_tx_error: errno=90 2.074723651s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 2.074739901s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.074780076s s2n_quic:server:conn: datagram_received: len=43 id=0 2.074819750s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 9 } id=0 2.074845238s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=ConnectionClose id=0 2.074882517s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x275b0e0b2f4568e2a94ef9bff90b959d, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:60151, remote_cid: 0xaeef89c4e67d3379, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: Some(0), reason: None } id=0 2.074913906s s2n_quic:server:conn: connection_closed: error=Closed { initiator: Remote, source: Location { file: "/app/quic/s2n-quic-transport/src/space/mod.rs", line: 966, col: 32 } } id=0 2.074972054s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=310µs 2.075022337s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 21, stream_requests: 2 } 2.093253891s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 2.093306719s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=57µs