0.049183921s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.049285190s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.049301580s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.049311148s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.049405273s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.049426292s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.050680458s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.050804600s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.050846097s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.050900949s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=99µs 0.838945804s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.838996419s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.839078031s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.839109509s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.839136490s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.839153171s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.839173819s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.839189398s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.839232719s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.839250923s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.839267774s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.839280117s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.839295576s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.839307528s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.839326353s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=385µs 1.037045469s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.037127241s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.037144253s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.037193214s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.037548817s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.037621241s s2n_quic:server:conn: connection_started: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } id=0 1.037649234s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.037685812s s2n_quic:server:conn: datagram_received: len=1252 id=0 1.037766081s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 91736, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ping id=0 1.037792881s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 91736, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Crypto { offset: 0, len: 283 } id=0 1.037854406s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 248, 247, 131, 62, 149, 36, 254, 130, 62, 243, 11, 213, 198, 156, 68, 209, 144, 17, 65, 95, 238, 113, 216, 138, 185, 244, 32, 64, 229, 114, 114, 237, 0, 0, 6, 19, 1, 19, 2, 19, 3, 1, 0, 0, 232, 0, 51, 0, 71, 0, 69, 0, 23, 0, 65, 4, 252, 17, 195, 241, 209, 108, 72, 189, 213, 60, 19, 219, 226, 83, 104, 217, 155, 64, 163, 68, 36, 155, 172, 82, 32, 82, 116, 27, 154, 173, 185, 9, 133, 27, 223, 54, 220, 128, 222, 179, 144, 248, 28, 105, 242, 193, 30, 254, 23, 206, 81, 43, 54, 1, 200, 195, 111, 151, 45, 70, 250, 13, 75, 87, 0, 0, 0, 12, 0, 10, 0, 0, 7, 115, 101, 114, 118, 101, 114, 52, 0, 16, 0, 13, 0, 11, 10, 104, 113, 45, 105, 110, 116, 101, 114, 111, 112, 0, 43, 0, 3, 2, 3, 4, 0, 13, 0, 10, 0, 8, 8, 4, 4, 3, 4, 1, 2, 1, 0, 10, 0, 6, 0, 4, 0, 23, 0, 29, 0, 57, 0, 83, 5, 4, 128, 32, 0, 0, 4, 4, 128, 16, 0, 0, 8, 2, 66, 0, 1, 4, 128, 2, 191, 32, 3, 2, 69, 160, 9, 2, 66, 0, 6, 4, 128, 1, 0, 99, 7, 4, 128, 0, 255, 255, 14, 1, 8, 11, 1, 10, 15, 8, 182, 238, 87, 62, 78, 98, 199, 234, 77, 140, 2, 76, 128, 192, 0, 0, 0, 255, 4, 222, 27, 2, 67, 232, 128, 0, 113, 88, 1, 3, 106, 178, 0, 0, 45, 0, 2, 1, 1]] id=0 1.037910600s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 91736, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Padding id=0 1.038245584s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.038424067s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.038453231s s2n_quic:server:conn: server_name_information: chosen_server_name="server4" id=0 1.038467638s s2n_quic:server:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 1.038508354s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0xb6ee573e4e62c7ea), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: true, max_idle_timeout: 180s, ack_delay_exponent: 3, max_ack_delay: 10ms, max_udp_payload_size: 1440, active_connection_id_limit: 8, initial_max_stream_data_bidi_local: 2097152, initial_max_stream_data_bidi_remote: 65635, initial_max_stream_data_uni: 65535, initial_max_streams_bidi: 512, initial_max_streams_uni: 512, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 1.038576451s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.038829472s s2n_quic:server:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 1, ce_count: 0 }), largest_acknowledged: 91736, ack_range_count: 1 } id=0 1.038864808s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=91736..=91736 id=0 1.038898130s s2n_quic:server:conn: frame_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 123 } id=0 1.038939707s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=190 id=0 1.038971076s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 988 } id=0 1.039003236s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1042 id=0 1.039048139s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.039094445s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 frame=Crypto { offset: 988, len: 1177 } id=0 1.039130713s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 1, version: 1 } packet_len=1232 id=0 1.039156050s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.039194592s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 frame=Crypto { offset: 2165, len: 1177 } id=0 1.039228024s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 2, version: 1 } packet_len=1232 id=0 1.039252290s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.039289950s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 3, version: 1 } path_id=0 frame=Crypto { offset: 3342, len: 1177 } id=0 1.039323342s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 3, version: 1 } packet_len=1232 id=0 1.039347387s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.039376791s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=10ms pto_count=0 congestion_window=12320 bytes_in_flight=4928 congestion_limited=false id=0 1.039438767s s2n_quic:server: platform_event_loop_sleep: timeout=Some(179.999312s) processing_duration=2.405ms 1.775936224s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.775977982s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.775992729s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.776050537s s2n_quic:server:conn: datagram_received: len=65 id=0 1.776102273s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 6, version: 1 } id=0 1.776126478s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 6, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ping id=0 1.776152176s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 6, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 4, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 3, ack_range_count: 1 } id=0 1.776187482s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 6, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=0..=3 id=0 1.776213821s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=InitialMtuPacketAcknowledged search_complete=false id=0 1.776247484s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=45824 burst_size=12320 pacing_gain=2.77 id=0 1.776283541s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 737.266ms, delivered_bytes: 4738, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 4928, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 6426 } id=0 1.776318907s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=737.266ms smoothed_rtt=737.266ms latest_rtt=737.266ms rtt_variance=368.633ms max_ack_delay=10ms pto_count=0 congestion_window=17058 bytes_in_flight=190 congestion_limited=false id=0 1.776371194s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 1.776385932s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=737.266ms smoothed_rtt=737.266ms latest_rtt=737.266ms rtt_variance=368.633ms max_ack_delay=10ms pto_count=0 congestion_window=17058 bytes_in_flight=190 congestion_limited=false id=0 1.776505655s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 4, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 1, ce_count: 0 }), largest_acknowledged: 6, ack_range_count: 1 } id=0 1.776533867s s2n_quic:server:conn: ack_range_sent: packet_header=Handshake { number: 4, version: 1 } path_id=0 ack_range=6..=6 id=0 1.776554546s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 4, version: 1 } path_id=0 frame=Crypto { offset: 4519, len: 1168 } id=0 1.776588198s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 4, version: 1 } packet_len=1232 id=0 1.776615429s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.776652839s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 5, version: 1 } path_id=0 frame=Crypto { offset: 5687, len: 1177 } id=0 1.776687063s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 5, version: 1 } packet_len=1232 id=0 1.776750541s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.776790746s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 6, version: 1 } path_id=0 frame=Crypto { offset: 6864, len: 1177 } id=0 1.776825641s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 6, version: 1 } packet_len=1232 id=0 1.776849936s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.776884831s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 7, version: 1 } path_id=0 frame=Crypto { offset: 8041, len: 1177 } id=0 1.776917141s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 7, version: 1 } packet_len=1232 id=0 1.776940805s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.776975630s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 8, version: 1 } path_id=0 frame=Crypto { offset: 9218, len: 713 } id=0 1.777012919s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } state=Unknown id=0 1.777033838s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 8, version: 1 } packet_len=768 id=0 1.777055449s s2n_quic:server:conn: datagram_sent: len=768 gso_offset=0 id=0 1.777089622s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=737.266ms smoothed_rtt=737.266ms latest_rtt=737.266ms rtt_variance=368.633ms max_ack_delay=10ms pto_count=0 congestion_window=17058 bytes_in_flight=5696 congestion_limited=false id=0 1.777158931s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.21112s) processing_duration=1.225ms 1.808977637s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.809025757s s2n_quic:server: platform_tx: count=5 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.809044642s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.809090698s s2n_quic:server:conn: datagram_received: len=124 id=0 1.809132997s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 7, version: 1 } id=0 1.809156821s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 7, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ping id=0 1.809187699s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 7, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 5, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 4, ack_range_count: 1 } id=0 1.809215621s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 7, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=3..=4 id=0 1.809265293s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } state=Capable id=0 1.809286853s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.591ms, delivered_bytes: 1232, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4738, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 37801 } id=0 1.809308313s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=103664 burst_size=1232 pacing_gain=2.77 id=0 1.809325977s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=737.266ms latest_rtt=32.591ms rtt_variance=368.633ms max_ack_delay=10ms pto_count=0 congestion_window=18290 bytes_in_flight=4464 congestion_limited=false id=0 1.809385537s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 8, version: 1 } id=0 1.809408470s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 8, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ping id=0 1.809429920s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 8, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 5, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 4, ack_range_count: 1 } id=0 1.809456520s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 8, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=3..=4 id=0 1.809476427s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=737.266ms latest_rtt=32.591ms rtt_variance=368.633ms max_ack_delay=10ms pto_count=0 congestion_window=18290 bytes_in_flight=4464 congestion_limited=false id=0 1.809563689s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 3, ce_count: 0 }), largest_acknowledged: 8, ack_range_count: 1 } id=0 1.809591591s s2n_quic:server:conn: ack_range_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 ack_range=7..=8 id=0 1.809620064s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 frame=Padding id=0 1.809665789s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 9, version: 1 } packet_len=69 id=0 1.809729568s s2n_quic:server:conn: datagram_sent: len=69 gso_offset=0 id=0 1.809775724s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=737.266ms latest_rtt=32.591ms rtt_variance=368.633ms max_ack_delay=10ms pto_count=0 congestion_window=18290 bytes_in_flight=4464 congestion_limited=false id=0 1.809828603s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.17845s) processing_duration=855µs 1.809949007s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.809986477s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.809999401s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.810034536s s2n_quic:server:conn: datagram_received: len=61 id=0 1.810080432s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 9, version: 1 } id=0 1.810105538s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 9, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 6, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 5, ack_range_count: 1 } id=0 1.810128371s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 9, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=3..=5 id=0 1.810166181s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.591ms, delivered_bytes: 2464, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4738, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 75603 } id=0 1.810190136s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=207328 burst_size=1232 pacing_gain=2.77 id=0 1.810213680s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=649.29975ms latest_rtt=33.539ms rtt_variance=452.40725ms max_ack_delay=10ms pto_count=0 congestion_window=19522 bytes_in_flight=3232 congestion_limited=false id=0 1.810306383s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=649.29975ms latest_rtt=33.539ms rtt_variance=452.40725ms max_ack_delay=10ms pto_count=0 congestion_window=19522 bytes_in_flight=3232 congestion_limited=false id=0 1.810357979s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.425049s) processing_duration=412µs 1.810677023s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.810732727s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.810768724s s2n_quic:server:conn: datagram_received: len=61 id=0 1.810798399s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 10, version: 1 } id=0 1.810819388s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 10, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 7, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 6, ack_range_count: 1 } id=0 1.810841740s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 10, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=3..=6 id=0 1.810879410s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.591ms, delivered_bytes: 3696, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4738, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 113405 } id=0 1.810903364s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=310992 burst_size=2464 pacing_gain=2.77 id=0 1.810920817s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=572.421276ms latest_rtt=34.275ms rtt_variance=493.062373ms max_ack_delay=10ms pto_count=0 congestion_window=20754 bytes_in_flight=2000 congestion_limited=false id=0 1.811010965s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=572.421276ms latest_rtt=34.275ms rtt_variance=493.062373ms max_ack_delay=10ms pto_count=0 congestion_window=20754 bytes_in_flight=2000 congestion_limited=false id=0 1.811061209s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.510088s) processing_duration=386µs 1.811707322s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.811742598s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.811783764s s2n_quic:server:conn: datagram_received: len=61 id=0 1.811814852s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 11, version: 1 } id=0 1.811849066s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 11, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 8, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 7, ack_range_count: 1 } id=0 1.811874263s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 11, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=3..=7 id=0 1.811912123s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.591ms, delivered_bytes: 4928, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4738, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 151207 } id=0 1.811935928s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=414656 burst_size=2464 pacing_gain=2.77 id=0 1.811953340s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=505.279363ms latest_rtt=35.289ms rtt_variance=504.080598ms max_ack_delay=10ms pto_count=0 congestion_window=21986 bytes_in_flight=768 congestion_limited=false id=0 1.812042987s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=505.279363ms latest_rtt=35.289ms rtt_variance=504.080598ms max_ack_delay=10ms pto_count=0 congestion_window=21986 bytes_in_flight=768 congestion_limited=false id=0 1.812097809s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.485982s) processing_duration=409µs 1.812637034s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.812666358s s2n_quic:server: platform_rx: count=2 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.812722813s s2n_quic:server:conn: datagram_received: len=283 id=0 1.812761375s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 12, version: 1 } id=0 1.812783156s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 12, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 9, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 8, ack_range_count: 1 } id=0 1.812805908s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 12, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } ack_range=3..=8 id=0 1.812844771s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.591ms, delivered_bytes: 5696, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 4738, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 174772 } id=0 1.812874556s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=479278 burst_size=2464 pacing_gain=2.77 id=0 1.812893171s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=446.644315ms latest_rtt=36.207ms rtt_variance=495.330537ms max_ack_delay=10ms pto_count=0 congestion_window=22754 bytes_in_flight=0 congestion_limited=false id=0 1.812919259s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 12, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 1.813006041s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 1.813028493s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 1.813047348s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.813087663s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 1.813103553s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=446.644315ms latest_rtt=36.207ms rtt_variance=495.330537ms max_ack_delay=10ms pto_count=0 congestion_window=22754 bytes_in_flight=0 congestion_limited=false id=0 1.813172090s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 1.813198349s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xb6ee573e4e62c7ea, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 1.813242371s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xb6ee573e4e62c7ea current=0xd7035514b0589c5f id=0 1.813264833s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 1.813293907s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Padding id=0 1.813380569s s2n_quic:server:conn: datagram_received: len=55 id=0 1.813417257s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 1.813436673s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 1.813485975s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Padding id=0 1.813519958s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 1.813620997s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 1.813655461s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 1.813709872s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 1.813731903s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.813769092s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 0, ect_1_count: 2, ce_count: 0 }), largest_acknowledged: 1, ack_range_count: 1 } id=0 1.813787747s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=0..=1 id=0 1.813801833s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 1.813822041s 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.813835887s 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.813848430s 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.813865201s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=RetireConnectionId id=0 1.813913511s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=146 id=0 1.813932186s s2n_quic:server:conn: datagram_sent: len=146 gso_offset=0 id=0 1.813965919s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=446.644315ms latest_rtt=36.207ms rtt_variance=495.330537ms max_ack_delay=10ms pto_count=0 congestion_window=22754 bytes_in_flight=1598 congestion_limited=false id=0 1.814024067s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.43754s) processing_duration=1.388ms Accepted a QUIC connection from [::ffff:193.167.0.100]:43893 on 193.167.100.100:443 1.814739389s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 1.814790204s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 1.814855947s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.814884229s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.814921038s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 1.814956905s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1203, is_fin: false } id=0 1.814997801s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1232 id=0 1.815014773s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.815045410s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 1.815076568s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 0, offset: 1203, len: 1201, is_fin: false } id=0 1.815113356s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=1232 id=0 1.815129757s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.815159182s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=HandshakeDone id=0 1.815195940s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Stream { id: 0, offset: 2404, len: 1201, is_fin: false } id=0 1.815233841s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=1232 id=0 1.815250301s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.815279926s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=HandshakeDone id=0 1.815311695s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Stream { id: 0, offset: 3605, len: 491, is_fin: false } id=0 1.815356519s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=524 id=0 1.815387156s s2n_quic:server:conn: datagram_sent: len=524 gso_offset=0 id=0 1.815407774s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=446.644315ms latest_rtt=36.207ms rtt_variance=495.330537ms max_ack_delay=10ms pto_count=0 congestion_window=22754 bytes_in_flight=5818 congestion_limited=false id=0 1.815438943s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.815482474s s2n_quic:server: platform_event_loop_sleep: timeout=Some(4.562ms) processing_duration=626µs 1.815643734s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(0) 1.815686494s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(0) 1.815764128s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.815792020s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.815811366s s2n_quic:server: platform_event_loop_sleep: timeout=Some(4.231ms) processing_duration=49µs 1.819976855s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.820035654s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=446.644315ms latest_rtt=36.207ms rtt_variance=495.330537ms max_ack_delay=10ms pto_count=0 congestion_window=22754 bytes_in_flight=5818 congestion_limited=false id=0 1.820132936s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=HandshakeDone id=0 1.820172499s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Stream { id: 0, offset: 4096, len: 1024, is_fin: true } id=0 1.820214127s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=1057 id=0 1.820231419s s2n_quic:server:conn: datagram_sent: len=1057 gso_offset=0 id=0 1.820265633s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x715d8a49d913a0ff8b2d2aa4f1554654, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.591ms smoothed_rtt=446.644315ms latest_rtt=36.207ms rtt_variance=495.330537ms max_ack_delay=10ms pto_count=0 congestion_window=22754 bytes_in_flight=6875 congestion_limited=false id=0 1.820295629s s2n_quic:server:conn: tx_stream_progress: bytes=1024 id=0 1.820336064s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.437743s) processing_duration=360µs 1.846034049s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.846091626s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.846111794s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.846156187s s2n_quic:server:conn: datagram_received: len=183 id=0 1.846199728s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 1.846221228s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x715d8a49d913a0ff8b2d2aa4f1554654 current=0xbce952ef1a06f1c02ead42cf619fbedd id=0 1.846247617s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=RetireConnectionId id=0 1.846283674s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 0 } id=0 1.846330822s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Padding id=0 1.846411482s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.729ms) processing_duration=379µs 1.847039041s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.847075018s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.847115453s s2n_quic:server:conn: datagram_received: len=55 id=0 1.847152963s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 1.847179543s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 3, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 2, ack_range_count: 1 } id=0 1.847208717s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } ack_range=0..=2 id=0 1.847239094s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 1.847258881s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 1.847320005s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.501ms, delivered_bytes: 2830, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 10434, bytes_in_flight: 2830, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 84475 } id=0 1.847352054s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.198ms smoothed_rtt=394.838523ms latest_rtt=32.198ms rtt_variance=475.10948ms max_ack_delay=10ms pto_count=0 congestion_window=29647 bytes_in_flight=4045 congestion_limited=false id=0 1.847380627s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Padding id=0 1.847455657s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Ping id=0 1.847511351s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Padding id=0 1.847544403s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 7 } packet_len=5202 id=0 1.847559972s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.847593254s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.198ms smoothed_rtt=394.838523ms latest_rtt=32.198ms rtt_variance=475.10948ms max_ack_delay=10ms pto_count=0 congestion_window=29647 bytes_in_flight=9247 congestion_limited=false id=0 1.847643156s s2n_quic:server: platform_event_loop_sleep: timeout=Some(23.495ms) processing_duration=606µs 1.848976891s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.849010614s s2n_quic:server: platform_tx_error: errno=90 1.849022566s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.849034678s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.849066267s s2n_quic:server:conn: datagram_received: len=55 id=0 1.849096654s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 1.849118414s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 5, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 4, ack_range_count: 1 } id=0 1.849141106s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } ack_range=0..=4 id=0 1.849190839s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.501ms, delivered_bytes: 5294, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 10434, bytes_in_flight: 2830, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 158025 } id=0 1.849220725s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=32.198ms smoothed_rtt=349.752205ms latest_rtt=34.152ms rtt_variance=446.50474ms max_ack_delay=10ms pto_count=0 congestion_window=32111 bytes_in_flight=6783 congestion_limited=false id=0 1.849248777s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Padding id=0 1.849309230s s2n_quic:server: platform_event_loop_sleep: timeout=Some(21.83ms) processing_duration=333µs 1.851763451s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.851804988s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.851857626s s2n_quic:server:conn: datagram_received: len=45 id=0 1.851900566s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 1.851930041s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 7, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 6, ack_range_count: 1 } id=0 1.851960248s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } ack_range=0..=6 id=0 1.852040767s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.501ms, delivered_bytes: 6875, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 10434, bytes_in_flight: 2830, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 205217 } id=0 1.852080742s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=562769 burst_size=2904 pacing_gain=2.77 id=0 1.852104987s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } min_rtt=31.726ms smoothed_rtt=309.998925ms latest_rtt=31.726ms rtt_variance=414.385106ms max_ack_delay=10ms pto_count=0 congestion_window=33692 bytes_in_flight=5202 congestion_limited=false id=0 1.852141986s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=ConnectionClose id=0 1.852170399s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0xbce952ef1a06f1c02ead42cf619fbedd, remote_addr: [::ffff:193.167.0.100]:43893, remote_cid: 0xd7035514b0589c5f, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: None, reason: None } id=0 1.852201206s 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.852259194s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=498µs 1.852347890s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 19, stream_requests: 1 } 1.870671900s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.870750917s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=82µs