0.048919982s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.049086424s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.049103566s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.049112994s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.049206318s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.049228851s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.050574959s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.050693020s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.050736572s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.050790623s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=101µs 0.804821293s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.804921260s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.805023671s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.805069838s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.805121114s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.805142895s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.805164034s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.805180635s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.805241670s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.805258341s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.805274882s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.805286413s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.805301421s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.805312823s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.805333642s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=528µs 1.022872941s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.022972658s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.022992585s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.023047568s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.023475469s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.023571839s s2n_quic:server:conn: connection_started: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } id=0 1.023605792s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.023656046s s2n_quic:server:conn: datagram_received: len=1200 id=0 1.023707092s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Crypto { offset: 0, len: 249 } id=0 1.023770821s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 143, 98, 56, 105, 125, 240, 17, 160, 237, 28, 4, 76, 181, 186, 30, 38, 244, 12, 36, 31, 81, 109, 17, 49, 212, 85, 191, 201, 248, 47, 148, 108, 0, 0, 6, 19, 1, 19, 2, 19, 3, 1, 0, 0, 198, 0, 0, 0, 12, 0, 10, 0, 0, 7, 115, 101, 114, 118, 101, 114, 52, 0, 5, 0, 5, 1, 0, 0, 0, 0, 0, 10, 0, 10, 0, 8, 0, 29, 0, 23, 0, 24, 0, 25, 0, 11, 0, 2, 1, 0, 0, 13, 0, 26, 0, 24, 8, 4, 4, 3, 8, 7, 8, 5, 8, 6, 4, 1, 5, 1, 6, 1, 5, 3, 6, 3, 2, 1, 2, 3, 255, 1, 0, 1, 0, 0, 23, 0, 0, 0, 16, 0, 13, 0, 11, 10, 104, 113, 45, 105, 110, 116, 101, 114, 111, 112, 0, 18, 0, 0, 0, 43, 0, 3, 2, 3, 4, 0, 51, 0, 38, 0, 36, 0, 29, 0, 32, 199, 159, 115, 15, 194, 19, 97, 211, 146, 110, 26, 66, 231, 176, 176, 26, 196, 79, 211, 81, 8, 53, 11, 210, 46, 217, 71, 231, 248, 96, 137, 41, 0, 57, 0, 40, 3, 2, 69, 192, 4, 4, 128, 1, 0, 0, 5, 4, 128, 1, 0, 0, 6, 4, 128, 1, 0, 0, 7, 4, 128, 1, 0, 0, 12, 0, 15, 8, 124, 196, 81, 34, 6, 61, 104, 2]] id=0 1.024098955s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.024307696s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.024341389s s2n_quic:server:conn: server_name_information: chosen_server_name="server4" id=0 1.024356337s s2n_quic:server:conn: key_exchange_group: chosen_group_name="x25519" contains_kem=false id=0 1.024391523s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0x7cc45122063d6802), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: false, max_idle_timeout: 0ns, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 1472, active_connection_id_limit: 2, initial_max_stream_data_bidi_local: 65536, initial_max_stream_data_bidi_remote: 65536, initial_max_stream_data_uni: 65536, initial_max_streams_bidi: 0, initial_max_streams_uni: 0, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 1.024480930s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.024565178s s2n_quic:server:conn: packet_dropped: reason=DecodingFailed { path: Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } } id=0 1.024748781s 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.024779929s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 1.024813031s 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.024860460s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=151 id=0 1.024899934s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 1027 } id=0 1.024933467s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1081 id=0 1.024975245s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.025020219s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 1, version: 1 } path_id=0 frame=Crypto { offset: 1027, len: 1177 } id=0 1.025059282s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 1, version: 1 } packet_len=1232 id=0 1.025085672s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.025124965s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 2, version: 1 } path_id=0 frame=Crypto { offset: 2204, len: 1177 } id=0 1.025170360s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 2, version: 1 } packet_len=1232 id=0 1.025198242s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.025230322s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, 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=3696 congestion_limited=false id=0 1.025294643s s2n_quic:server: platform_event_loop_sleep: timeout=Some(299.997735s) processing_duration=2.435ms 2.887320483s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.887416974s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.887467458s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.887569539s s2n_quic:server:conn: datagram_received: len=53 id=0 2.887660369s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 6, version: 1 } id=0 2.887694693s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 6, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ping id=0 2.887725992s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 6, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Padding id=0 2.887788058s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 2.887808166s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, 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=3696 congestion_limited=false id=0 2.888002379s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=25ms pto_count=1 congestion_window=12320 bytes_in_flight=3545 congestion_limited=false id=0 2.888052483s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=25ms pto_count=1 congestion_window=12320 bytes_in_flight=3545 congestion_limited=false id=0 2.888168620s s2n_quic:server:conn: packet_skipped: number=3 space=Handshake reason=PtoProbe id=0 2.888221509s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 4, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 6, ack_range_count: 1 } id=0 2.888242739s s2n_quic:server:conn: ack_range_sent: packet_header=Handshake { number: 4, version: 1 } path_id=0 ack_range=6..=6 id=0 2.888279047s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 4, version: 1 } path_id=0 frame=Crypto { offset: 3381, len: 1139 } id=0 2.888335332s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 4, version: 1 } packet_len=1200 id=0 2.888368815s s2n_quic:server:conn: datagram_sent: len=1200 gso_offset=0 id=0 2.888396737s s2n_quic:server:conn: packet_skipped: number=5 space=Handshake reason=PtoProbe id=0 2.888422095s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 6, version: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 6, ack_range_count: 1 } id=0 2.888455377s s2n_quic:server:conn: ack_range_sent: packet_header=Handshake { number: 6, version: 1 } path_id=0 ack_range=6..=6 id=0 2.888479722s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 6, version: 1 } path_id=0 frame=Crypto { offset: 4520, len: 1139 } id=0 2.888512414s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 6, version: 1 } packet_len=1200 id=0 2.888538623s s2n_quic:server:conn: datagram_sent: len=1200 gso_offset=0 id=0 2.888575913s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 7, version: 1 } path_id=0 frame=Crypto { offset: 5659, len: 1177 } id=0 2.888609285s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 7, version: 1 } packet_len=1232 id=0 2.888633260s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 2.888667634s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 8, version: 1 } path_id=0 frame=Crypto { offset: 6836, len: 1177 } id=0 2.888712528s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 8, version: 1 } packet_len=1232 id=0 2.888738827s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 2.888773973s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 9, version: 1 } path_id=0 frame=Crypto { offset: 8013, len: 1177 } id=0 2.888807145s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 9, version: 1 } packet_len=1232 id=0 2.888830960s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 2.888865154s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 10, version: 1 } path_id=0 frame=Crypto { offset: 9190, len: 743 } id=0 2.888902223s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } state=Unknown id=0 2.888923473s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 10, version: 1 } packet_len=798 id=0 2.888945815s s2n_quic:server:conn: datagram_sent: len=798 gso_offset=0 id=0 2.888979949s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=25ms pto_count=1 congestion_window=12320 bytes_in_flight=10439 congestion_limited=false id=0 2.889047244s s2n_quic:server: platform_event_loop_sleep: timeout=Some(1.997099s) processing_duration=1.742ms 2.921031834s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.921119909s s2n_quic:server: platform_tx: count=6 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.921138985s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.921219014s s2n_quic:server:conn: datagram_received: len=57 id=0 2.921294786s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 7, version: 1 } id=0 2.921330122s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 7, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 4, ack_range_count: 2 } id=0 2.921389433s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=4..=4 id=0 2.921457962s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=0..=2 id=0 2.921520839s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=1022862 burst_size=12320 pacing_gain=2.77 id=0 2.921560864s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } state=Failed id=0 2.921591060s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.896502s, delivered_bytes: 4745, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 4745, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 2501 } id=0 2.921621808s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.03ms latest_rtt=33.03ms rtt_variance=16.515ms max_ack_delay=25ms pto_count=0 congestion_window=17065 bytes_in_flight=5694 congestion_limited=false id=0 2.921773301s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.03ms latest_rtt=33.03ms rtt_variance=16.515ms max_ack_delay=25ms pto_count=0 congestion_window=17065 bytes_in_flight=5694 congestion_limited=false id=0 2.921838684s s2n_quic:server: platform_event_loop_sleep: timeout=Some(65.397ms) processing_duration=822µs 2.921936056s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.921967605s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.922009023s s2n_quic:server:conn: datagram_received: len=59 id=0 2.922041493s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 8, version: 1 } id=0 2.922069195s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 8, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 6, ack_range_count: 3 } id=0 2.922094493s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=6..=6 id=0 2.922134207s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=4..=4 id=0 2.922154565s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=0..=2 id=0 2.922180584s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.897319s, delivered_bytes: 5945, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 5945, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 3133 } id=0 2.922206031s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.132125ms latest_rtt=33.847ms rtt_variance=12.5905ms max_ack_delay=25ms pto_count=0 congestion_window=18265 bytes_in_flight=4494 congestion_limited=false id=0 2.922298494s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.132125ms latest_rtt=33.847ms rtt_variance=12.5905ms max_ack_delay=25ms pto_count=0 congestion_window=18265 bytes_in_flight=4494 congestion_limited=false id=0 2.922368946s s2n_quic:server: platform_event_loop_sleep: timeout=Some(49.268ms) processing_duration=434µs 2.922588998s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.922619144s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.922653519s s2n_quic:server:conn: datagram_received: len=59 id=0 2.922683074s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 9, version: 1 } id=0 2.922703031s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 9, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 3 } id=0 2.922725133s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=6..=7 id=0 2.922753997s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=4..=4 id=0 2.922772551s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=0..=2 id=0 2.922797879s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.897967s, delivered_bytes: 7177, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 7177, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 3781 } id=0 2.922827113s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.30248ms latest_rtt=34.495ms rtt_variance=9.783593ms max_ack_delay=25ms pto_count=0 congestion_window=19497 bytes_in_flight=3262 congestion_limited=false id=0 2.922918595s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.30248ms latest_rtt=34.495ms rtt_variance=9.783593ms max_ack_delay=25ms pto_count=0 congestion_window=19497 bytes_in_flight=3262 congestion_limited=false id=0 2.922974870s s2n_quic:server: platform_event_loop_sleep: timeout=Some(37.604ms) processing_duration=387µs 2.923586885s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.923622522s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.923669881s s2n_quic:server:conn: datagram_received: len=59 id=0 2.923703814s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 10, version: 1 } id=0 2.923724122s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 10, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 8, ack_range_count: 3 } id=0 2.923746724s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=6..=8 id=0 2.923775548s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=4..=4 id=0 2.923793652s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=0..=2 id=0 2.923818128s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.89898s, delivered_bytes: 8409, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 8409, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 4428 } id=0 2.923841382s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.57817ms latest_rtt=35.508ms rtt_variance=7.889074ms max_ack_delay=25ms pto_count=0 congestion_window=20729 bytes_in_flight=2030 congestion_limited=false id=0 2.923930378s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.57817ms latest_rtt=35.508ms rtt_variance=7.889074ms max_ack_delay=25ms pto_count=0 congestion_window=20729 bytes_in_flight=2030 congestion_limited=false id=0 2.923992204s s2n_quic:server: platform_event_loop_sleep: timeout=Some(29.287ms) processing_duration=406µs 2.924580174s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.924609539s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.924643793s s2n_quic:server:conn: datagram_received: len=59 id=0 2.924673338s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 11, version: 1 } id=0 2.924694167s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 11, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 9, ack_range_count: 3 } id=0 2.924716479s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=6..=9 id=0 2.924745403s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=4..=4 id=0 2.924763798s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=0..=2 id=0 2.924788564s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.899958s, delivered_bytes: 9641, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 9641, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 5074 } id=0 2.924811868s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.941647ms latest_rtt=36.486ms rtt_variance=6.643761ms max_ack_delay=25ms pto_count=0 congestion_window=21961 bytes_in_flight=798 congestion_limited=false id=0 2.924901936s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=33.941647ms latest_rtt=36.486ms rtt_variance=6.643761ms max_ack_delay=25ms pto_count=0 congestion_window=21961 bytes_in_flight=798 congestion_limited=false id=0 2.924968420s s2n_quic:server: platform_event_loop_sleep: timeout=Some(23.69ms) processing_duration=389µs 2.925696353s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.925726559s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.925763148s s2n_quic:server:conn: datagram_received: len=188 id=0 2.925797452s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 12, version: 1 } id=0 2.925825134s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 12, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 10, ack_range_count: 3 } id=0 2.925848718s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=6..=10 id=0 2.925878213s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=4..=4 id=0 2.925896337s 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: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } ack_range=0..=2 id=0 2.925919130s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 1.901076s, delivered_bytes: 10439, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 10439, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 5491 } id=0 2.925942373s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=34.399435ms latest_rtt=37.604ms rtt_variance=5.898408ms max_ack_delay=25ms pto_count=0 congestion_window=22759 bytes_in_flight=0 congestion_limited=false id=0 2.925968722s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 12, version: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 2.926079169s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 2.926102873s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 2.926123392s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 2.926163747s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 2.926179617s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=34.399435ms latest_rtt=37.604ms rtt_variance=5.898408ms max_ack_delay=25ms pto_count=0 congestion_window=22759 bytes_in_flight=0 congestion_limited=false id=0 2.926257973s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 2.926284603s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x7cc45122063d6802, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 2.926330710s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0x7cc45122063d6802 current=0x03c317bfcecf983b id=0 2.926352601s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 2.926523120s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 2.926565379s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 2.926602689s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 2.926619470s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 2.926657551s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 2.926675234s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=0..=0 id=0 2.926689591s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 2.926710691s 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 2.926724446s 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 2.926741669s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=RetireConnectionId id=0 2.926784329s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=107 id=0 2.926802683s s2n_quic:server:conn: datagram_sent: len=107 gso_offset=0 id=0 2.926835334s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=34.399435ms latest_rtt=37.604ms rtt_variance=5.898408ms max_ack_delay=25ms pto_count=0 congestion_window=22759 bytes_in_flight=1559 congestion_limited=false id=0 2.926890437s s2n_quic:server: platform_event_loop_sleep: timeout=Some(82.6ms) processing_duration=1.195ms Accepted a QUIC connection from [::ffff:193.167.0.100]:43809 on 193.167.100.100:443 2.927114887s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.927144432s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.927157336s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.927190088s s2n_quic:server:conn: datagram_received: len=54 id=0 2.927222028s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 2.927242867s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 2.927308930s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 2.927365376s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.813ms) processing_duration=252µs 2.927994002s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 2.928048724s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 2.928116151s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 2.928173298s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 2.928200499s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 2 } path_id=0 ack_range=0..=1 id=0 2.928215116s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 2.928246565s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1197, is_fin: false } id=0 2.928288453s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1232 id=0 2.928305745s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 2.928335632s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 2.928365738s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 0, offset: 1197, len: 1201, is_fin: false } id=0 2.928401755s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=1232 id=0 2.928418106s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 2.928466536s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=HandshakeDone id=0 2.928504728s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Stream { id: 0, offset: 2398, len: 1201, is_fin: false } id=0 2.928542649s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=1232 id=0 2.928561434s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 2.928590048s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=HandshakeDone id=0 2.928621567s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Stream { id: 0, offset: 3599, len: 497, is_fin: false } id=0 2.928657343s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=530 id=0 2.928674135s s2n_quic:server:conn: datagram_sent: len=530 gso_offset=0 id=0 2.928692720s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=34.399435ms latest_rtt=37.604ms rtt_variance=5.898408ms max_ack_delay=25ms pto_count=0 congestion_window=22759 bytes_in_flight=5785 congestion_limited=false id=0 2.928723146s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 2.928762791s s2n_quic:server: platform_event_loop_sleep: timeout=Some(1.795ms) processing_duration=647µs 2.928805460s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(0) 2.928839685s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(0) 2.928998532s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 2.929028638s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.929048365s s2n_quic:server: platform_event_loop_sleep: timeout=Some(1.509ms) processing_duration=52µs 2.930214828s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 2.930266425s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=34.399435ms latest_rtt=37.604ms rtt_variance=5.898408ms max_ack_delay=25ms pto_count=0 congestion_window=22759 bytes_in_flight=5785 congestion_limited=false id=0 2.930340533s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=HandshakeDone id=0 2.930392420s 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 2.930434369s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=1057 id=0 2.930475776s s2n_quic:server:conn: datagram_sent: len=1057 gso_offset=0 id=0 2.930511894s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x38665077b51b60704158d66aa2eb9757, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=33.03ms smoothed_rtt=34.399435ms latest_rtt=37.604ms rtt_variance=5.898408ms max_ack_delay=25ms pto_count=0 congestion_window=22759 bytes_in_flight=6842 congestion_limited=false id=0 2.930543793s s2n_quic:server:conn: tx_stream_progress: bytes=1024 id=0 2.930584640s s2n_quic:server: platform_event_loop_sleep: timeout=Some(82.727ms) processing_duration=372µs 2.959015647s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.959101748s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 2.959121074s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.959197858s s2n_quic:server:conn: datagram_received: len=69 id=0 2.959264462s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 2.959286804s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x38665077b51b60704158d66aa2eb9757 current=0x3913b5dbaa0853df57bb9f77be7a099d id=0 2.959324184s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 2.959368557s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } ack_range=0..=1 id=0 2.959410786s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 2.959432647s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 2.959555698s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.658ms, delivered_bytes: 1559, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 10439, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 47737 } id=0 2.959597856s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=32.658ms smoothed_rtt=34.181753ms latest_rtt=32.658ms rtt_variance=4.859164ms max_ack_delay=25ms pto_count=0 congestion_window=28382 bytes_in_flight=5283 congestion_limited=false id=0 2.959630848s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 2.959677465s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=RetireConnectionId id=0 2.959793282s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Ping id=0 2.959850309s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Padding id=0 2.959888049s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 7 } packet_len=5202 id=0 2.959904150s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 2.959939135s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=32.658ms smoothed_rtt=34.181753ms latest_rtt=32.658ms rtt_variance=4.859164ms max_ack_delay=25ms pto_count=0 congestion_window=28382 bytes_in_flight=10485 congestion_limited=false id=0 2.960003024s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.155ms) processing_duration=1.001ms 2.961375993s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.961414245s s2n_quic:server: platform_tx_error: errno=90 2.961426849s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 2.961467074s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.961504284s s2n_quic:server:conn: datagram_received: len=39 id=0 2.961536304s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 2.961557183s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 2.961579254s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } ack_range=0..=3 id=0 2.961632754s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.658ms, delivered_bytes: 4023, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 10439, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 123185 } id=0 2.961662750s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=32.658ms smoothed_rtt=34.076658ms latest_rtt=33.341ms rtt_variance=3.854561ms max_ack_delay=25ms pto_count=0 congestion_window=30846 bytes_in_flight=8021 congestion_limited=false id=0 2.961723454s s2n_quic:server: platform_event_loop_sleep: timeout=Some(22.434ms) processing_duration=348µs 2.962806941s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.962836837s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.962871462s s2n_quic:server:conn: datagram_received: len=39 id=0 2.962905255s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 2.962937596s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 5, ack_range_count: 1 } id=0 2.962960819s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } ack_range=0..=5 id=0 2.963011955s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.658ms, delivered_bytes: 5785, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 10439, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 177138 } id=0 2.963041490s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } min_rtt=32.658ms smoothed_rtt=34.155699ms latest_rtt=34.709ms rtt_variance=3.049005ms max_ack_delay=25ms pto_count=0 congestion_window=32608 bytes_in_flight=6259 congestion_limited=false id=0 2.963102063s s2n_quic:server: platform_event_loop_sleep: timeout=Some(21.055ms) processing_duration=296µs 2.963773219s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 2.963803807s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 2.963836918s s2n_quic:server:conn: datagram_received: len=38 id=0 2.963867956s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 2.963887513s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=ConnectionClose id=0 2.963912390s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: 193.167.100.100:443, local_cid: 0x3913b5dbaa0853df57bb9f77be7a099d, remote_addr: [::ffff:193.167.0.100]:43809, remote_cid: 0x03c317bfcecf983b, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: Some(0), reason: None } id=0 2.963937787s s2n_quic:server:conn: connection_closed: error=Closed { initiator: Remote, source: Location { file: "/app/quic/s2n-quic-transport/src/space/mod.rs", line: 966, col: 32 } } id=0 2.964009942s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=238µs 2.964056990s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 18, stream_requests: 1 } 2.984370121s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 2.984514761s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=155µs