0.046626864s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.046767276s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.046789197s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.046799266s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.046893793s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.046916224s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.048382443s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.048507476s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.048547170s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.048594589s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=92µs 0.813022074s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.813122662s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.813206719s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.813240322s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.813269336s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.813286628s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.813308419s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.813324740s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.813377188s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.813401343s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.813419306s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.813431930s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.813447659s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.813459762s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.813481282s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=475µs 1.047946910s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.048027801s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.048066623s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=130µs 1.090619994s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.090676670s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.090753403s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.091089932s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.091159892s s2n_quic:server:conn: connection_started: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } id=0 1.091194177s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.091238189s s2n_quic:server:conn: datagram_received: len=1232 id=0 1.091286769s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Crypto { offset: 0, len: 287 } id=0 1.091361639s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 164, 96, 132, 206, 130, 8, 28, 251, 217, 8, 156, 169, 72, 108, 198, 171, 214, 100, 179, 255, 5, 63, 246, 140, 202, 43, 11, 152, 120, 215, 207, 171, 0, 0, 6, 19, 1, 19, 2, 19, 3, 1, 0, 0, 236, 0, 43, 0, 3, 2, 3, 4, 0, 10, 0, 10, 0, 8, 0, 23, 0, 29, 0, 24, 0, 25, 0, 51, 0, 71, 0, 69, 0, 23, 0, 65, 4, 166, 164, 152, 83, 255, 6, 154, 188, 13, 43, 230, 9, 132, 180, 95, 235, 32, 47, 21, 246, 9, 118, 253, 190, 100, 90, 245, 84, 19, 137, 107, 149, 248, 49, 202, 75, 94, 32, 70, 110, 85, 224, 14, 34, 182, 211, 90, 160, 137, 135, 162, 143, 168, 140, 95, 248, 95, 233, 217, 195, 20, 40, 107, 253, 0, 13, 0, 20, 0, 18, 4, 3, 5, 3, 6, 3, 8, 9, 8, 10, 8, 11, 8, 4, 8, 5, 8, 6, 0, 0, 0, 12, 0, 10, 0, 0, 7, 115, 101, 114, 118, 101, 114, 54, 0, 16, 0, 13, 0, 11, 10, 104, 113, 45, 105, 110, 116, 101, 114, 111, 112, 0, 35, 0, 0, 0, 11, 0, 2, 1, 0, 0, 57, 0, 59, 1, 4, 128, 4, 147, 224, 4, 4, 128, 57, 56, 112, 5, 4, 128, 57, 56, 112, 6, 4, 128, 57, 56, 112, 7, 4, 128, 57, 56, 112, 8, 2, 64, 100, 9, 2, 64, 100, 14, 1, 3, 15, 16, 191, 91, 24, 138, 96, 71, 127, 188, 5, 166, 139, 234, 130, 89, 9, 249, 0, 45, 0, 2, 1, 1, 0, 23, 0, 0]] id=0 1.091427021s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Padding id=0 1.091775933s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.091934299s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.091962601s s2n_quic:server:conn: server_name_information: chosen_server_name="server6" id=0 1.091977650s s2n_quic:server:conn: key_exchange_group: chosen_group_name="secp256r1" contains_kem=false id=0 1.092013777s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0xbf5b188a60477fbc05a68bea825909f9), retry_source_connection_id: None, stateless_reset_token: None, preferred_address: None, migration_support: true, max_idle_timeout: 300s, ack_delay_exponent: 3, max_ack_delay: 25ms, max_udp_payload_size: 65527, active_connection_id_limit: 3, initial_max_stream_data_bidi_local: 3750000, initial_max_stream_data_bidi_remote: 3750000, initial_max_stream_data_uni: 3750000, initial_max_streams_bidi: 100, initial_max_streams_uni: 100, max_datagram_frame_size: 0, dc_supported_versions: [] } id=0 1.092076584s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.092268933s 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: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 1.092301053s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 1.092329998s 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.092370994s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=195 id=0 1.092402152s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 685 } id=0 1.092424995s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 1.092455843s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1037 id=0 1.092495376s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.092544007s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=333ms smoothed_rtt=333ms latest_rtt=333ms rtt_variance=166.5ms max_ack_delay=25ms pto_count=0 congestion_window=12320 bytes_in_flight=1232 congestion_limited=false id=0 1.092616703s s2n_quic:server: platform_event_loop_sleep: timeout=Some(998.595ms) processing_duration=2.004ms 1.127366945s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.127409314s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.127426125s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.127456933s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.127495024s s2n_quic:server:conn: datagram_received: len=1232 id=0 1.127538445s s2n_quic:server:conn: packet_received: packet_header=Initial { number: 1, version: 1 } id=0 1.127569322s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 1.127614767s s2n_quic:server:conn: ack_range_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } ack_range=0..=0 id=0 1.127666344s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=958770 burst_size=12320 pacing_gain=2.77 id=0 1.127741584s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 35.238ms, delivered_bytes: 195, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 195, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 5533 } id=0 1.127796277s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=12515 bytes_in_flight=1037 congestion_limited=false id=0 1.127834939s s2n_quic:server:conn: frame_received: packet_header=Initial { number: 1, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Padding id=0 1.127906983s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 0, version: 1 } id=0 1.127946918s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 1.127990800s s2n_quic:server:conn: ack_range_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } ack_range=0..=0 id=0 1.128045632s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 35.238ms, delivered_bytes: 1232, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 1232, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 34962 } id=0 1.128080698s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.128116865s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 1.128180264s s2n_quic:server:conn: frame_received: packet_header=Handshake { number: 0, version: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Padding id=0 1.128235948s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 1.128254913s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.128376791s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 1.128405564s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 1.128429810s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.128478781s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 1.128499740s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.128683844s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 1.128736593s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 1.128778391s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 1.128800893s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.128832802s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 1.128857759s 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.128871935s 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.128884629s 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.128923191s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=143 id=0 1.128939982s s2n_quic:server:conn: datagram_sent: len=143 gso_offset=0 id=0 1.128971341s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1595 congestion_limited=false id=0 1.129032355s s2n_quic:server: platform_event_loop_sleep: timeout=Some(130.346ms) processing_duration=1.667ms Accepted a QUIC connection from [fd00:cafe:cafe::100]:56077 on [fd00:cafe:cafe:100::100]:443 1.129207462s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.129236687s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.129249150s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.129280809s s2n_quic:server:conn: datagram_received: len=77 id=0 1.129318730s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 1.129342725s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 0, is_fin: false } id=0 1.129389893s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 1.129424728s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 0 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 17, is_fin: true } id=0 1.129477567s s2n_quic:server:conn: rx_stream_progress: bytes=34 id=0 1.129531888s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.737ms) processing_duration=326µs 1.130051719s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.130111280s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.130197171s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.130261581s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 1, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 0, ack_range_count: 1 } id=0 1.130289153s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 2 } path_id=0 ack_range=0..=0 id=0 1.130303660s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 1.130334267s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 4, offset: 0, len: 1186, is_fin: false } id=0 1.130376095s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1232 id=0 1.130393537s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.130424034s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 1.130455563s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 4, offset: 1186, len: 1193, is_fin: false } id=0 1.130491811s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=1232 id=0 1.130508482s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.130537286s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=HandshakeDone id=0 1.130568063s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Stream { id: 4, offset: 2379, len: 1193, is_fin: false } id=0 1.130603469s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=1232 id=0 1.130619620s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.130648063s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=HandshakeDone id=0 1.130679712s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Stream { id: 4, offset: 3572, len: 524, is_fin: false } id=0 1.130740235s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=565 id=0 1.130766213s s2n_quic:server:conn: datagram_sent: len=565 gso_offset=0 id=0 1.130802832s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=5856 congestion_limited=false id=0 1.130838007s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.130874876s s2n_quic:server: platform_event_loop_sleep: timeout=Some(130.074ms) processing_duration=679µs 1.130918698s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.130952612s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.131085059s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.131115345s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.131152104s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=HandshakeDone id=0 1.131187190s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Stream { id: 4, offset: 4096, len: 1193, is_fin: false } id=0 1.131228166s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=1232 id=0 1.131245288s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.131274994s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=HandshakeDone id=0 1.131312634s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Stream { id: 4, offset: 5289, len: 1193, is_fin: false } id=0 1.131354031s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } state=Unknown id=0 1.131378337s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 7 } packet_len=1232 id=0 1.131390670s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.131420806s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=HandshakeDone id=0 1.131452626s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=Stream { id: 4, offset: 6482, len: 1193, is_fin: false } id=0 1.131494714s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 8 } packet_len=1232 id=0 1.131511676s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.131539918s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=HandshakeDone id=0 1.131571397s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=Stream { id: 4, offset: 7675, len: 517, is_fin: false } id=0 1.131608086s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 9 } packet_len=558 id=0 1.131624787s s2n_quic:server:conn: datagram_sent: len=558 gso_offset=0 id=0 1.131656316s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=10110 congestion_limited=false id=0 1.131687033s s2n_quic:server:conn: tx_stream_progress: bytes=4096 id=0 1.131742296s s2n_quic:server: platform_event_loop_sleep: timeout=Some(130.106ms) processing_duration=658µs 1.131863904s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 1.131903748s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 1.131976694s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.132006400s s2n_quic:server: platform_tx: count=4 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.132043419s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=HandshakeDone id=0 1.132078544s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1195, is_fin: false } id=0 1.132118880s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 10 } packet_len=1232 id=0 1.132135822s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.132164545s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=HandshakeDone id=0 1.132195453s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=Stream { id: 0, offset: 1195, len: 1193, is_fin: false } id=0 1.132230799s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 11 } packet_len=1232 id=0 1.132246819s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.132276945s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x0c532b679b423ccf3aeb037ffdb0e660, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=35.238ms smoothed_rtt=35.238ms latest_rtt=35.238ms rtt_variance=17.619ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=12574 congestion_limited=true id=0 1.132313674s s2n_quic:server:conn: tx_stream_progress: bytes=2392 id=0 1.132351675s s2n_quic:server: platform_event_loop_sleep: timeout=Some(130.386ms) processing_duration=377µs 1.132446231s s2n_quic_qns::server::h09: 2048 bytes ready to send on Stream(4) 1.132482429s s2n_quic_qns::server::h09: 2048 bytes sent on Stream(4) 1.132524107s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(0) 1.132547580s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(0) 1.161958632s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.162004838s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.162022771s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.162065431s s2n_quic:server:conn: datagram_received: len=152 id=0 1.162108472s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 1.162134079s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x0c532b679b423ccf3aeb037ffdb0e660 current=0x4e54da74a8b3eb110fa1e921f716bf48 id=0 1.162165047s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 2, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 1, ack_range_count: 1 } id=0 1.162203700s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } ack_range=0..=1 id=0 1.162236100s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 1.162256668s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 1.162308285s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } state=Capable id=0 1.162340275s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.385ms, delivered_bytes: 1595, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1595, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 47775 } id=0 1.162372274s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.006375ms latest_rtt=33.385ms rtt_variance=13.6775ms max_ack_delay=25ms pto_count=0 congestion_window=17567 bytes_in_flight=10979 congestion_limited=false id=0 1.162409404s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xbf5b188a60477fbc05a68bea825909f9, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 1 } id=0 1.162466971s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0xbf5b188a60477fbc05a68bea825909f9 current=0xc8d8c44d2fe546b47099614a176d10ba id=0 1.162497959s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 1 } id=0 1.162533886s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 1.162569112s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 1 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=RetireConnectionId id=0 1.162664801s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Ping id=0 1.162748707s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Padding id=0 1.162789023s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 12 } packet_len=5202 id=0 1.162805073s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.162839026s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.006375ms latest_rtt=33.385ms rtt_variance=13.6775ms max_ack_delay=25ms pto_count=0 congestion_window=17567 bytes_in_flight=16181 congestion_limited=true id=0 1.162900751s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.148ms) processing_duration=946µs 1.164287902s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.164321074s s2n_quic:server: platform_tx_error: errno=90 1.164333117s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.164345269s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.164376107s s2n_quic:server:conn: datagram_received: len=1452 id=0 1.164407465s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 1.164425800s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=Ping id=0 1.164471685s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 2 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=Padding id=0 1.164525857s s2n_quic:server: platform_event_loop_sleep: timeout=Some(22.523ms) processing_duration=239µs 1.171201064s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.171237672s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.171276245s s2n_quic:server:conn: datagram_received: len=53 id=0 1.171313824s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 1.171340094s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 8, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 11, ack_range_count: 1 } id=0 1.171368547s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } ack_range=0..=11 id=0 1.171440972s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 33.385ms, delivered_bytes: 12574, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1595, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 376636 } id=0 1.171475346s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=1032850 burst_size=2904 pacing_gain=2.77 id=0 1.171497939s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.532697ms latest_rtt=39.238ms rtt_variance=11.310781ms max_ack_delay=25ms pto_count=0 congestion_window=28546 bytes_in_flight=5202 congestion_limited=false id=0 1.171530369s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 3 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=Padding id=0 1.171616730s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 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.171647047s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 13 } path_id=0 ack_range=1..=3 id=0 1.171666904s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=RetireConnectionId id=0 1.171702470s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 4, offset: 8192, len: 1404, is_fin: false } id=0 1.171786748s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 13 } packet_len=1452 id=0 1.171807947s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.171855707s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 14 } path_id=0 frame=Stream { id: 0, offset: 2388, len: 1414, is_fin: false } id=0 1.171900591s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 14 } packet_len=1452 id=0 1.171918564s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.171962376s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 15 } path_id=0 frame=Stream { id: 4, offset: 9596, len: 644, is_fin: true } id=0 1.172000166s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 15 } path_id=0 frame=Stream { id: 0, offset: 3802, len: 764, is_fin: false } id=0 1.172037256s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 15 } packet_len=1452 id=0 1.172053977s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.172073083s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.532697ms latest_rtt=39.238ms rtt_variance=11.310781ms max_ack_delay=25ms pto_count=0 congestion_window=28546 bytes_in_flight=9558 congestion_limited=false id=0 1.172100384s s2n_quic:server:conn: tx_stream_progress: bytes=4226 id=0 1.172139426s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.261ms) processing_duration=940µs 1.174349414s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.174388527s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.174427159s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.532697ms latest_rtt=39.238ms rtt_variance=11.310781ms max_ack_delay=25ms pto_count=0 congestion_window=28546 bytes_in_flight=9558 congestion_limited=false id=0 1.174560018s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Stream { id: 0, offset: 4566, len: 554, is_fin: true } id=0 1.174633295s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 16 } packet_len=594 id=0 1.174655135s s2n_quic:server:conn: datagram_sent: len=594 gso_offset=0 id=0 1.174696583s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.532697ms latest_rtt=39.238ms rtt_variance=11.310781ms max_ack_delay=25ms pto_count=0 congestion_window=28546 bytes_in_flight=10152 congestion_limited=false id=0 1.174777925s s2n_quic:server:conn: tx_stream_progress: bytes=550 id=0 1.174829421s s2n_quic:server: platform_event_loop_sleep: timeout=Some(92.239ms) processing_duration=481µs 1.204973498s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.205016027s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.205032899s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.205071070s s2n_quic:server:conn: datagram_received: len=53 id=0 1.205109181s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 1.205136272s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=Ack { ecn_counts: Some(EcnCounts { ect_0_count: 9, ect_1_count: 0, ce_count: 0 }), largest_acknowledged: 13, ack_range_count: 2 } id=0 1.205165607s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } ack_range=13..=13 id=0 1.205239555s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } ack_range=2..=11 id=0 1.205304216s s2n_quic:server:conn: packet_lost: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } bytes_lost=5202 is_mtu_probe=true id=0 1.205343108s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 42.926ms, delivered_bytes: 1452, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: false, prior_delivered_bytes: 13806, bytes_in_flight: 6654, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 33825 } id=0 1.205374737s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.267234ms latest_rtt=33.467ms rtt_variance=9.014009ms max_ack_delay=25ms pto_count=0 congestion_window=29998 bytes_in_flight=3498 congestion_limited=false id=0 1.205407609s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 5 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=Padding id=0 1.205489622s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 17 } path_id=0 frame=Ping id=0 1.205556848s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 17 } path_id=0 frame=Padding id=0 1.205596161s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 17 } packet_len=5202 id=0 1.205615227s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.205655682s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } min_rtt=33.385ms smoothed_rtt=35.267234ms latest_rtt=33.467ms rtt_variance=9.014009ms max_ack_delay=25ms pto_count=0 congestion_window=29998 bytes_in_flight=8700 congestion_limited=false id=0 1.205749988s s2n_quic:server: platform_event_loop_sleep: timeout=Some(61.321ms) processing_duration=776µs 1.207592660s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.207623758s s2n_quic:server: platform_tx_error: errno=90 1.207635149s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.207647422s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.207678350s s2n_quic:server:conn: datagram_received: len=53 id=0 1.207710339s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 1.207766595s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=ConnectionClose id=0 1.207797532s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x4e54da74a8b3eb110fa1e921f716bf48, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:56077, remote_cid: 0xc8d8c44d2fe546b47099614a176d10ba, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: Some(0), reason: None } id=0 1.207823000s 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 1.207884715s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=293µs 1.207926243s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 20, stream_requests: 2 } 1.267212399s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.267263023s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=54µs