0.048783098s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.048911516s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.048928328s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.048938126s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.049033193s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.049061335s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.050481382s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.050603208s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.050652099s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.050700128s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=103µs 0.806350635s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.806446232s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.806532913s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.806562769s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.806588096s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.806604276s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.806623853s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.806638630s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.806687130s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.806703440s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.806719320s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.806730460s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.806744807s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.806755898s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.806772188s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=437µs 1.049267407s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.049365289s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.049404673s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=153µs 1.052635881s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.052682298s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.052740456s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.053215708s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.053305575s s2n_quic:server:conn: connection_started: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } id=0 1.053334850s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.053371528s s2n_quic:server:conn: datagram_received: len=1200 id=0 1.053411442s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } frame=Crypto { offset: 0, len: 266 } id=0 1.053474118s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 129, 152, 22, 43, 240, 212, 213, 140, 87, 94, 231, 27, 26, 101, 85, 117, 0, 73, 122, 49, 49, 253, 245, 188, 134, 198, 35, 189, 78, 58, 9, 184, 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, 52, 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, 226, 202, 153, 158, 245, 89, 71, 232, 191, 39, 59, 180, 154, 58, 103, 229, 29, 185, 29, 210, 133, 87, 41, 29, 22, 124, 17, 88, 137, 130, 127, 115, 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, 138, 108, 39, 173, 50, 229, 171, 204, 109, 223, 90, 84, 60, 77, 142, 121, 70, 221, 114, 244]] id=0 1.053774867s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.053940144s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.053969228s s2n_quic:server:conn: server_name_information: chosen_server_name="server4" id=0 1.053984526s s2n_quic:server:conn: key_exchange_group: chosen_group_name="x25519" contains_kem=false id=0 1.054042514s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4), 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.054118956s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.054195558s s2n_quic:server:conn: packet_dropped: reason=DecodingFailed { path: Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } } id=0 1.054381103s 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.054409766s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 1.054443078s 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.054488382s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=163 id=0 1.054519169s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 692 } id=0 1.054539918s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 1.054563541s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1069 id=0 1.054608034s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.054659931s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, 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.054732375s s2n_quic:server: platform_event_loop_sleep: timeout=Some(998.564ms) processing_duration=2.099ms 1.088091206s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.088139075s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.088157249s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.088193617s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.088240073s s2n_quic:server:conn: datagram_received: len=1350 id=0 1.088291559s s2n_quic:server:conn: packet_received: packet_header=Initial { number: 1, version: 1 } id=0 1.088324770s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.088369193s s2n_quic:server:conn: ack_range_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } ack_range=0..=0 id=0 1.088421510s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=996936 burst_size=12320 pacing_gain=2.77 id=0 1.088462356s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } state=Failed id=0 1.088488234s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.889ms, 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: 4809 } id=0 1.088519031s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=12483 bytes_in_flight=1069 congestion_limited=false id=0 1.088592818s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 2, version: 1 } id=0 1.088627433s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.088658801s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } ack_range=0..=0 id=0 1.088719223s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.889ms, 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: 36353 } id=0 1.088750932s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.088784084s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 2, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 1.088849675s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 1.088869562s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.088986850s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 1.089039638s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 1.089070055s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.089118324s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 1.089137360s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.089221255s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 1.089253275s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 1.089315039s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0x8a6c27ad32e5abcc6ddf5a543c4d8e7946dd72f4 current=0x626dd4b9114992488995de2ee0896e1c107c03bf id=0 1.089338944s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 1.089369100s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 1.089445211s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=Padding id=0 1.089496777s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 1.089611560s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 1.089647287s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 1.089683644s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 1.089699985s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.089733677s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 1.089751310s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=3..=3 id=0 1.089765687s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 1.089785644s 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.089799570s 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.089812103s 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.089828704s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=RetireConnectionId id=0 1.089875010s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=155 id=0 1.089894015s s2n_quic:server:conn: datagram_sent: len=155 gso_offset=0 id=0 1.089927407s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1607 congestion_limited=false id=0 1.089988089s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.267ms) processing_duration=1.9ms Accepted a QUIC connection from [::ffff:193.167.0.100]:38194 on 193.167.100.100:443 1.090681808s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(0) 1.090729336s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(0) 1.090792383s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.090820085s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.090856422s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 1.090898360s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1024, is_fin: false } id=0 1.090940649s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1067 id=0 1.090958622s s2n_quic:server:conn: datagram_sent: len=1067 gso_offset=0 id=0 1.090998145s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=2674 congestion_limited=false id=0 1.091059018s s2n_quic:server:conn: tx_stream_progress: bytes=1024 id=0 1.091097180s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.406ms) processing_duration=305µs 1.091255974s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.091286281s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.091323249s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 1.091357363s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 0, offset: 1024, len: 0, is_fin: true } id=0 1.091377310s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Padding id=0 1.091408347s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=57 id=0 1.091425209s s2n_quic:server:conn: datagram_sent: len=57 gso_offset=0 id=0 1.091462448s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } min_rtt=33.889ms smoothed_rtt=33.889ms latest_rtt=33.889ms rtt_variance=16.9445ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=2731 congestion_limited=false id=0 1.091524463s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.447ms) processing_duration=269µs 1.121863168s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.121914754s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.121931174s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.121971990s s2n_quic:server:conn: datagram_received: len=39 id=0 1.122034897s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 1.122065915s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.122100028s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } ack_range=0..=0 id=0 1.122129934s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 1.122203109s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.366ms, 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: 44861 } id=0 1.122247552s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } min_rtt=32.366ms smoothed_rtt=33.698625ms latest_rtt=32.366ms rtt_variance=13.089125ms max_ack_delay=25ms pto_count=0 congestion_window=17424 bytes_in_flight=1279 congestion_limited=false id=0 1.122349061s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Ping id=0 1.122415293s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Padding id=0 1.122446942s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=5202 id=0 1.122462521s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.122494140s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x97e461aedc35c857ee3c44fcb7b5563c, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } min_rtt=32.366ms smoothed_rtt=33.698625ms latest_rtt=32.366ms rtt_variance=13.089125ms max_ack_delay=25ms pto_count=0 congestion_window=17424 bytes_in_flight=6481 congestion_limited=false id=0 1.122545876s s2n_quic:server: platform_event_loop_sleep: timeout=Some(110.839ms) processing_duration=686µs 1.122623901s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.122650220s s2n_quic:server: platform_tx_error: errno=90 1.122661541s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.122673613s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.122704881s s2n_quic:server:conn: datagram_received: len=81 id=0 1.122735137s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 1.122750546s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x97e461aedc35c857ee3c44fcb7b5563c current=0x25df2657951e6875ae35b1aaf5d556d1 id=0 1.122771926s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 1.122793856s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } ack_range=0..=1 id=0 1.122817811s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 1.122861532s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.366ms, 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: 49650 } id=0 1.122890887s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } min_rtt=32.366ms smoothed_rtt=33.622921ms latest_rtt=33.104ms rtt_variance=9.968249ms max_ack_delay=25ms pto_count=0 congestion_window=17579 bytes_in_flight=6326 congestion_limited=false id=0 1.122919790s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 1.122957090s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=RetireConnectionId id=0 1.123044462s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.65ms) processing_duration=420µs 1.123123479s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.123146702s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.123178621s s2n_quic:server:conn: datagram_received: len=44 id=0 1.123208777s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 1.123228223s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=ConnectionClose id=0 1.123251626s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x25df2657951e6875ae35b1aaf5d556d1, remote_addr: [::ffff:193.167.0.100]:38194, remote_cid: 0x626dd4b9114992488995de2ee0896e1c107c03bf, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: None, reason: Some("kthxbye") } id=0 1.123276864s 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: 966, col: 32 } } id=0 1.123339360s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=216µs 1.123414709s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 7, stream_requests: 1 } 1.147660947s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.147718524s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=62µs