0.045969768s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.046088852s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.046104561s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.046113869s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.046207664s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.046225367s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.047553616s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.047672298s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.047717753s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.047783356s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=113µs 0.341320918s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.341419122s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.341526944s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.341557140s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.341612344s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.341628634s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.341649574s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=344µs 1.046458250s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.046546986s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.046581942s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=138µs 1.047514237s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.047544614s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.047593465s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.047962467s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.048032918s s2n_quic:server:conn: connection_started: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } id=0 1.048062924s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.048100655s s2n_quic:server:conn: datagram_received: len=1200 id=0 1.048140019s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } frame=Crypto { offset: 0, len: 266 } id=0 1.048194851s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 5, 63, 253, 175, 132, 249, 90, 154, 34, 133, 99, 159, 193, 239, 181, 179, 71, 4, 159, 241, 149, 58, 216, 39, 156, 0, 142, 5, 201, 172, 253, 131, 0, 0, 6, 19, 1, 19, 2, 19, 3, 1, 0, 0, 215, 0, 0, 0, 12, 0, 10, 0, 0, 7, 115, 101, 114, 118, 101, 114, 54, 0, 10, 0, 8, 0, 6, 0, 29, 0, 23, 0, 24, 0, 16, 0, 25, 0, 23, 2, 104, 51, 10, 104, 113, 45, 105, 110, 116, 101, 114, 111, 112, 8, 104, 116, 116, 112, 47, 48, 46, 57, 0, 13, 0, 20, 0, 18, 4, 3, 8, 4, 4, 1, 5, 3, 8, 5, 5, 1, 8, 6, 6, 1, 2, 1, 0, 51, 0, 38, 0, 36, 0, 29, 0, 32, 224, 142, 68, 161, 219, 209, 143, 0, 193, 105, 185, 25, 178, 40, 182, 160, 116, 130, 113, 220, 150, 150, 202, 171, 77, 23, 174, 226, 86, 217, 163, 4, 0, 45, 0, 2, 1, 1, 0, 43, 0, 3, 2, 3, 4, 0, 57, 0, 75, 1, 4, 128, 0, 117, 48, 3, 2, 69, 70, 4, 4, 128, 152, 150, 128, 5, 4, 128, 15, 66, 64, 6, 4, 128, 15, 66, 64, 7, 4, 128, 15, 66, 64, 8, 2, 64, 100, 9, 2, 64, 100, 10, 1, 3, 11, 1, 25, 12, 0, 14, 1, 8, 15, 20, 251, 191, 141, 225, 13, 38, 169, 226, 79, 130, 83, 100, 230, 214, 240, 33, 68, 31, 78, 56]] id=0 1.048523587s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.048699426s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.048727940s s2n_quic:server:conn: server_name_information: chosen_server_name="server6" id=0 1.048742367s s2n_quic:server:conn: key_exchange_group: chosen_group_name="x25519" contains_kem=false id=0 1.048779316s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0xfbbf8de10d26a9e24f825364e6d6f021441f4e38), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: false, max_idle_timeout: 30s, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 1350, active_connection_id_limit: 8, initial_max_stream_data_bidi_local: 1000000, initial_max_stream_data_bidi_remote: 1000000, initial_max_stream_data_uni: 1000000, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 1.048856380s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.048926111s s2n_quic:server:conn: packet_dropped: reason=DecodingFailed { path: Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } } id=0 1.049105176s 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.049132667s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 1.049174375s s2n_quic:server:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 90 } id=0 1.049215232s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=163 id=0 1.049270195s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 694 } id=0 1.049300241s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 1.049326200s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1069 id=0 1.049367136s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.049418452s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, 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.049486450s s2n_quic:server: platform_event_loop_sleep: timeout=Some(998.536ms) processing_duration=1.972ms 1.082814928s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.082859582s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.082876493s s2n_quic:server: platform_rx: count=2 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.082908363s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.082949911s s2n_quic:server:conn: datagram_received: len=1350 id=0 1.082992040s s2n_quic:server:conn: packet_received: packet_header=Initial { number: 1, version: 1 } id=0 1.083018770s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.083067832s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } ack_range=0..=0 id=0 1.083124638s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=997230 burst_size=12320 pacing_gain=2.77 id=0 1.083165755s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } state=Failed id=0 1.083191072s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.879ms, delivered_bytes: 163, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 163, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 4811 } id=0 1.083220818s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=12483 bytes_in_flight=1069 congestion_limited=false id=0 1.083321807s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 2, version: 1 } id=0 1.083359307s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.083393381s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } ack_range=0..=0 id=0 1.083434538s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.879ms, delivered_bytes: 1232, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 36364 } id=0 1.083470676s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.083503657s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 1.083566926s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 1.083585701s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.083698823s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 1.083722748s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 1.083745470s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.083792538s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 1.083811384s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.083891434s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 1.083925267s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xfbbf8de10d26a9e24f825364e6d6f021441f4e38, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 1.083978397s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xfbbf8de10d26a9e24f825364e6d6f021441f4e38 current=0xab0169ef114e07c1249a38bdce4f700e04be6383 id=0 1.084005718s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 1.084039671s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 1.084112638s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Padding id=0 1.084161860s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 1.084226822s s2n_quic:server:conn: datagram_received: len=56 id=0 1.084281233s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 1.084302613s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 17, is_fin: true } id=0 1.084353449s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 1.084443637s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 1.084475567s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 1.084511705s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 1.084527404s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.084560035s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 4, ack_range_count: 1 } id=0 1.084577118s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=3..=4 id=0 1.084590823s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 1.084613896s 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.084627652s 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.084640125s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 1.084656997s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=RetireConnectionId id=0 1.084698515s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=155 id=0 1.084715637s s2n_quic:server:conn: datagram_sent: len=155 gso_offset=0 id=0 1.084747837s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1607 congestion_limited=false id=0 1.084804834s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.255ms) processing_duration=1.993ms Accepted a QUIC connection from [fd00:cafe:cafe::100]:39263 on [fd00:cafe:cafe:100::100]:443 1.085575677s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.085633886s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.085701953s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.085730096s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.085766775s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 1.085818371s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 4, offset: 0, len: 1191, is_fin: false } id=0 1.085860561s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1232 id=0 1.085877001s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.085905625s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 1.085935280s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 4, offset: 1191, len: 1189, is_fin: false } id=0 1.085970046s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=1232 id=0 1.085985875s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.086013166s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=HandshakeDone id=0 1.086041910s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Stream { id: 4, offset: 2380, len: 1189, is_fin: false } id=0 1.086075593s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=1232 id=0 1.086091423s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.086118343s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=HandshakeDone id=0 1.086148249s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Stream { id: 4, offset: 3569, len: 527, is_fin: false } id=0 1.086182413s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=572 id=0 1.086198814s s2n_quic:server:conn: datagram_sent: len=572 gso_offset=0 id=0 1.086229972s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=5875 congestion_limited=false id=0 1.086297028s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.086335289s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.047ms) processing_duration=634µs 1.086442680s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 1.086481112s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 1.086542187s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.086569308s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.086605525s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=HandshakeDone id=0 1.086638217s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1191, is_fin: false } id=0 1.086676518s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=1232 id=0 1.086692999s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.086721262s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=HandshakeDone id=0 1.086750076s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Stream { id: 0, offset: 1191, len: 1189, is_fin: false } id=0 1.086783769s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 7 } packet_len=1232 id=0 1.086799899s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.086833312s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=HandshakeDone id=0 1.086864039s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=Stream { id: 0, offset: 2380, len: 1189, is_fin: false } id=0 1.086904295s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 8 } packet_len=1232 id=0 1.086921016s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.086948698s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=HandshakeDone id=0 1.086978534s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=Stream { id: 0, offset: 3569, len: 527, is_fin: false } id=0 1.087013369s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 9 } packet_len=572 id=0 1.087029399s s2n_quic:server:conn: datagram_sent: len=572 gso_offset=0 id=0 1.087060457s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=10143 congestion_limited=false id=0 1.087089191s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.087123455s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.099ms) processing_duration=582µs 1.087227690s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.087283485s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.087359527s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.087388832s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.087425390s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=HandshakeDone id=0 1.087459133s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=Stream { id: 4, offset: 4096, len: 1189, is_fin: false } id=0 1.087502475s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 10 } packet_len=1232 id=0 1.087519767s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.087547990s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=HandshakeDone id=0 1.087577415s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=Stream { id: 4, offset: 5285, len: 1189, is_fin: false } id=0 1.087610797s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 11 } packet_len=1232 id=0 1.087626477s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.087655321s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=33.879ms smoothed_rtt=33.879ms latest_rtt=33.879ms rtt_variance=16.9395ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=12607 congestion_limited=true id=0 1.087683323s s2n_quic:server:conn: tx_stream_progress: bytes=2382 id=0 1.087719210s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.322ms) processing_duration=361µs 1.087806534s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(0) 1.087846589s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(0) 1.087888447s s2n_quic_qns::server::h09: 2048 bytes ready to send on Stream(4) 1.087909887s s2n_quic_qns::server::h09: 2048 bytes sent on Stream(4) 1.116568542s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.116609909s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.116625879s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.116666705s s2n_quic:server:conn: datagram_received: len=39 id=0 1.116704526s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 1.116729764s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.116763627s 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: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=0 id=0 1.116792681s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 1.116857392s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 1452, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 45058 } id=0 1.116892979s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.225ms smoothed_rtt=33.67225ms latest_rtt=32.225ms rtt_variance=13.118125ms max_ack_delay=25ms pto_count=0 congestion_window=17424 bytes_in_flight=11155 congestion_limited=false id=0 1.116981715s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Ping id=0 1.117047959s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Padding id=0 1.117083295s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 12 } packet_len=5202 id=0 1.117101369s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.117136766s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x88bd7ae95cca1c3d6525bae31f552070, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.225ms smoothed_rtt=33.67225ms latest_rtt=32.225ms rtt_variance=13.118125ms max_ack_delay=25ms pto_count=0 congestion_window=17424 bytes_in_flight=16357 congestion_limited=true id=0 1.117195736s s2n_quic:server: platform_event_loop_sleep: timeout=Some(110.91ms) processing_duration=630µs 1.117294200s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.117325980s s2n_quic:server: platform_tx_error: errno=90 1.117337321s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.117349103s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.117384870s s2n_quic:server:conn: datagram_received: len=81 id=0 1.117416008s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 1.117430956s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x88bd7ae95cca1c3d6525bae31f552070 current=0x71298da73bfa940de6985aeab3bad75c id=0 1.117451424s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 1.117477684s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=1 id=0 1.117500807s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 1.117544769s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 1607, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 49868 } id=0 1.117572711s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.225ms smoothed_rtt=33.580592ms latest_rtt=32.949ms rtt_variance=10.021905ms max_ack_delay=25ms pto_count=0 congestion_window=17579 bytes_in_flight=16202 congestion_limited=true id=0 1.117599682s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 1.117629358s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=RetireConnectionId id=0 1.117694951s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.679ms) processing_duration=401µs 1.117842176s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.117868445s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.117898552s s2n_quic:server:conn: datagram_received: len=39 id=0 1.117928037s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 7 } id=0 1.117947924s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 1.117969144s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=2 id=0 1.118022744s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 2839, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 88099 } id=0 1.118051558s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.400518ms latest_rtt=32.14ms rtt_variance=7.876576ms max_ack_delay=25ms pto_count=0 congestion_window=18811 bytes_in_flight=14970 congestion_limited=false id=0 1.118127049s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 1 } id=0 1.118152227s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 13 } path_id=0 ack_range=5..=7 id=0 1.118181892s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 0, offset: 4096, len: 1024, is_fin: true } id=0 1.118205937s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 4, offset: 6474, len: 375, is_fin: false } id=0 1.118264346s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 13 } packet_len=1452 id=0 1.118288271s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.118334137s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 14 } path_id=0 frame=Stream { id: 4, offset: 6849, len: 1410, is_fin: false } id=0 1.118374403s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 14 } packet_len=1452 id=0 1.118390373s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.118419717s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.400518ms latest_rtt=32.14ms rtt_variance=7.876576ms max_ack_delay=25ms pto_count=0 congestion_window=18811 bytes_in_flight=17874 congestion_limited=true id=0 1.118447439s s2n_quic:server:conn: tx_stream_progress: bytes=2809 id=0 1.118483437s s2n_quic:server: platform_event_loop_sleep: timeout=Some(89.526ms) processing_duration=642µs 1.118842649s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.118870952s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.118883225s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.118912831s s2n_quic:server:conn: datagram_received: len=39 id=0 1.118942195s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 8 } id=0 1.118962464s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 1.118983673s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=3 id=0 1.119035811s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 4071, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 126330 } id=0 1.119064334s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.369198ms latest_rtt=33.154ms rtt_variance=5.970061ms max_ack_delay=25ms pto_count=0 congestion_window=20043 bytes_in_flight=16642 congestion_limited=false id=0 1.119140797s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 15 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 8, ack_range_count: 1 } id=0 1.119165814s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 15 } path_id=0 ack_range=5..=8 id=0 1.119194508s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 15 } path_id=0 frame=Stream { id: 4, offset: 8259, len: 1405, is_fin: false } id=0 1.119234493s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 15 } packet_len=1452 id=0 1.119277283s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.119297320s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.369198ms latest_rtt=33.154ms rtt_variance=5.970061ms max_ack_delay=25ms pto_count=0 congestion_window=20043 bytes_in_flight=18094 congestion_limited=false id=0 1.119323469s s2n_quic:server:conn: tx_stream_progress: bytes=1405 id=0 1.119360138s s2n_quic:server: platform_event_loop_sleep: timeout=Some(1.657ms) processing_duration=519µs 1.119863150s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.119891232s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.119903595s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.119933201s s2n_quic:server:conn: datagram_received: len=39 id=0 1.119962796s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 9 } id=0 1.119983115s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 4, ack_range_count: 1 } id=0 1.120004244s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=4 id=0 1.120051232s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 5303, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 164561 } id=0 1.120084694s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.469418ms latest_rtt=34.175ms rtt_variance=4.677995ms max_ack_delay=25ms pto_count=0 congestion_window=21275 bytes_in_flight=16862 congestion_limited=false id=0 1.120149816s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.469418ms latest_rtt=34.175ms rtt_variance=4.677995ms max_ack_delay=25ms pto_count=0 congestion_window=21275 bytes_in_flight=16862 congestion_limited=false id=0 1.120272496s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 9, ack_range_count: 1 } id=0 1.120302112s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 16 } path_id=0 ack_range=5..=9 id=0 1.120332939s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Stream { id: 4, offset: 9664, len: 576, is_fin: true } id=0 1.120373876s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 16 } packet_len=625 id=0 1.120390367s s2n_quic:server:conn: datagram_sent: len=625 gso_offset=0 id=0 1.120424190s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.469418ms latest_rtt=34.175ms rtt_variance=4.677995ms max_ack_delay=25ms pto_count=0 congestion_window=21275 bytes_in_flight=17487 congestion_limited=false id=0 1.120453124s s2n_quic:server:conn: tx_stream_progress: bytes=572 id=0 1.120487399s s2n_quic:server: platform_event_loop_sleep: timeout=Some(76.919ms) processing_duration=626µs 1.120591433s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.120619306s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.120631538s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.120661184s s2n_quic:server:conn: datagram_received: len=39 id=0 1.120690679s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 10 } id=0 1.120710907s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 5, ack_range_count: 1 } id=0 1.120732337s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=5 id=0 1.120780668s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 5875, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 182311 } id=0 1.120814130s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.648114ms latest_rtt=34.903ms rtt_variance=3.865889ms max_ack_delay=25ms pto_count=0 congestion_window=21847 bytes_in_flight=16915 congestion_limited=false id=0 1.120880214s s2n_quic:server: platform_event_loop_sleep: timeout=Some(73.458ms) processing_duration=289µs 1.121390980s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.121419594s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.121449991s s2n_quic:server:conn: datagram_received: len=39 id=0 1.121479726s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 11 } id=0 1.121499854s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 6, ack_range_count: 1 } id=0 1.121520894s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=6 id=0 1.121566889s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 7107, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 220543 } id=0 1.121594161s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=33.798098ms latest_rtt=34.852ms rtt_variance=3.199387ms max_ack_delay=25ms pto_count=0 congestion_window=23079 bytes_in_flight=15683 congestion_limited=false id=0 1.121658391s s2n_quic:server: platform_event_loop_sleep: timeout=Some(70.166ms) processing_duration=267µs 1.122412663s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.122441267s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.122471513s s2n_quic:server:conn: datagram_received: len=39 id=0 1.122501299s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 12 } id=0 1.122521567s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 1 } id=0 1.122542827s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=7 id=0 1.122594413s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 8339, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 258774 } id=0 1.122622616s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=34.056959ms latest_rtt=35.873ms rtt_variance=2.917263ms max_ack_delay=25ms pto_count=0 congestion_window=24311 bytes_in_flight=14451 congestion_limited=false id=0 1.122682198s s2n_quic:server: platform_event_loop_sleep: timeout=Some(68.272ms) processing_duration=270µs 1.123430579s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.123459102s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.123489249s s2n_quic:server:conn: datagram_received: len=39 id=0 1.123518483s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 13 } id=0 1.123538852s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 13 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 8, ack_range_count: 1 } id=0 1.123560342s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 13 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=8 id=0 1.123606438s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 9571, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 297005 } id=0 1.123633959s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=34.410708ms latest_rtt=36.891ms rtt_variance=2.895455ms max_ack_delay=25ms pto_count=0 congestion_window=25543 bytes_in_flight=13219 congestion_limited=false id=0 1.123693291s s2n_quic:server: platform_event_loop_sleep: timeout=Some(67.527ms) processing_duration=263µs 1.123934422s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.123959740s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.123989645s s2n_quic:server:conn: datagram_received: len=39 id=0 1.124019512s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 14 } id=0 1.124039429s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 9, ack_range_count: 1 } id=0 1.124066409s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 14 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=9 id=0 1.124137733s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 10143, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 314755 } id=0 1.124165024s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=34.782741ms latest_rtt=37.391ms rtt_variance=2.915662ms max_ack_delay=25ms pto_count=0 congestion_window=26115 bytes_in_flight=12647 congestion_limited=false id=0 1.124224826s s2n_quic:server: platform_event_loop_sleep: timeout=Some(67.447ms) processing_duration=291µs 1.124960984s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.124990570s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.125020866s s2n_quic:server:conn: datagram_received: len=39 id=0 1.125050542s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 15 } id=0 1.125070800s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 10, ack_range_count: 1 } id=0 1.125091939s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 15 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=10 id=0 1.125137725s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 11375, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 352986 } id=0 1.125164926s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=35.134894ms latest_rtt=37.604ms rtt_variance=2.891059ms max_ack_delay=25ms pto_count=0 congestion_window=27347 bytes_in_flight=11415 congestion_limited=false id=0 1.125224488s s2n_quic:server: platform_event_loop_sleep: timeout=Some(66.703ms) processing_duration=264µs 1.125979902s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.126009647s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.126040074s s2n_quic:server:conn: datagram_received: len=39 id=0 1.126069379s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 16 } id=0 1.126095258s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 11, ack_range_count: 1 } id=0 1.126117499s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 16 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=0..=11 id=0 1.126164357s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.225ms, delivered_bytes: 12607, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1452, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 391218 } id=0 1.126190566s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=1072838 burst_size=2904 pacing_gain=2.77 id=0 1.126207889s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=35.570402ms latest_rtt=38.623ms rtt_variance=3.039318ms max_ack_delay=25ms pto_count=0 congestion_window=28579 bytes_in_flight=10183 congestion_limited=false id=0 1.126290734s s2n_quic:server: platform_event_loop_sleep: timeout=Some(66.666ms) processing_duration=310µs 1.150291580s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.150331404s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.150368955s s2n_quic:server:conn: datagram_received: len=41 id=0 1.150405473s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 17 } id=0 1.150430901s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 13, ack_range_count: 2 } id=0 1.150457290s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=13..=13 id=0 1.150521150s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 17 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=3..=11 id=0 1.150562307s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.681ms, delivered_bytes: 11220, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4071, bytes_in_flight: 16422, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 333125 } id=0 1.150590860s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=35.154225ms latest_rtt=32.25ms rtt_variance=3.111837ms max_ack_delay=25ms pto_count=0 congestion_window=30031 bytes_in_flight=8731 congestion_limited=false id=0 1.150693312s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 17 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 17, ack_range_count: 1 } id=0 1.150724791s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 17 } path_id=0 ack_range=8..=17 id=0 1.150754036s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 17 } path_id=0 frame=Padding id=0 1.150790644s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 17 } packet_len=57 id=0 1.150808808s s2n_quic:server:conn: datagram_sent: len=57 gso_offset=0 id=0 1.150846699s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=35.154225ms latest_rtt=32.25ms rtt_variance=3.111837ms max_ack_delay=25ms pto_count=0 congestion_window=30031 bytes_in_flight=8731 congestion_limited=false id=0 1.150910298s s2n_quic:server: platform_event_loop_sleep: timeout=Some(5.6ms) processing_duration=621µs 1.151392230s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.151423720s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.151436443s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.151466199s s2n_quic:server:conn: datagram_received: len=41 id=0 1.151495584s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 18 } id=0 1.151516463s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 14, ack_range_count: 2 } id=0 1.151538154s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=13..=14 id=0 1.151576566s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 18 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=3..=11 id=0 1.151606652s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.681ms, delivered_bytes: 12672, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4071, bytes_in_flight: 16422, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 376235 } id=0 1.151628944s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=34.927821ms latest_rtt=33.35ms rtt_variance=2.786683ms max_ack_delay=25ms pto_count=0 congestion_window=31483 bytes_in_flight=7279 congestion_limited=false id=0 1.151694737s s2n_quic:server: platform_event_loop_sleep: timeout=Some(4.56ms) processing_duration=304µs 1.152565707s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.152594431s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.152624918s s2n_quic:server:conn: datagram_received: len=41 id=0 1.152654534s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 19 } id=0 1.152674942s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 15, ack_range_count: 2 } id=0 1.152696412s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=13..=15 id=0 1.152732820s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 19 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } ack_range=4..=11 id=0 1.152776352s 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: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } bytes_lost=5202 is_mtu_probe=true id=0 1.152805196s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 34.696ms, delivered_bytes: 12892, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 5303, bytes_in_flight: 18094, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 371570 } id=0 1.152827237s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=34.747714ms latest_rtt=33.493ms rtt_variance=2.450215ms max_ack_delay=25ms pto_count=0 congestion_window=32935 bytes_in_flight=625 congestion_limited=false id=0 1.152901005s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 18 } path_id=0 frame=Ping id=0 1.152955407s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 18 } path_id=0 frame=Padding id=0 1.152986696s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 18 } packet_len=5202 id=0 1.153001894s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.153033082s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } min_rtt=32.14ms smoothed_rtt=34.747714ms latest_rtt=33.493ms rtt_variance=2.450215ms max_ack_delay=25ms pto_count=0 congestion_window=32935 bytes_in_flight=5827 congestion_limited=false id=0 1.153080642s s2n_quic:server: platform_event_loop_sleep: timeout=Some(29.726ms) processing_duration=515µs 1.153157506s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.153179917s s2n_quic:server: platform_tx_error: errno=90 1.153190457s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.153202850s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.153231825s s2n_quic:server:conn: datagram_received: len=44 id=0 1.153286086s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 20 } id=0 1.153308087s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=ConnectionClose id=0 1.153330409s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 20 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x71298da73bfa940de6985aeab3bad75c, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:39263, remote_cid: 0xab0169ef114e07c1249a38bdce4f700e04be6383, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: None, reason: Some("kthxbye") } id=0 1.153354584s s2n_quic:server:conn: connection_closed: error=Application { error: application::Error(0), initiator: Remote, source: Location { file: "/app/quic/s2n-quic-transport/src/space/mod.rs", line: 995, column: 32 } } id=0 1.153415228s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=257µs 1.153499135s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 21, stream_requests: 2 } 1.182860216s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.182906743s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=50µs