0.047463182s s2n_quic:server: platform_feature_configured: configuration=Gso { max_segments: 1 } 0.047632589s s2n_quic:server: platform_feature_configured: configuration=BaseMtu { mtu: 1228 } 0.047651174s s2n_quic:server: platform_feature_configured: configuration=InitialMtu { mtu: 1280 } 0.047660922s s2n_quic:server: platform_feature_configured: configuration=MaxMtu { mtu: 9000 } 0.047760458s s2n_quic:server: platform_feature_configured: configuration=Gro { enabled: true } 0.047784213s s2n_quic:server: platform_feature_configured: configuration=Ecn { enabled: true } 0.049402250s s2n_quic:server: platform_event_loop_started: local_address=[::]:443 0.049539958s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=true application_wakeup=false 0.049576416s s2n_quic:server: platform_rx: count=0 syscalls=1 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.049624426s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=90µs 0.840480960s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 0.840580737s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 0.840661288s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.840687757s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.840711331s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.840725057s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.840740516s s2n_quic:server: version_information: server_versions=[1] client_versions=[1463896404] chosen_version=None 0.840752398s s2n_quic:server: endpoint_datagram_dropped: len=1207 reason=UnsupportedVersion 0.840795299s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.840809625s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.840822720s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.840831997s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.840843910s s2n_quic:server: endpoint_packet_sent: packet_header=VersionNegotiation 0.840852856s s2n_quic:server: endpoint_datagram_sent: len=15 gso_offset=0 0.840869578s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=405µs 1.041806614s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.041896061s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.041912662s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.041962165s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.042367423s s2n_quic:server:conn: key_update: key_type=Initial cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.042445409s s2n_quic:server:conn: connection_started: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } id=0 1.042476998s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1232 cause=NewPath search_complete=false id=0 1.042515911s s2n_quic:server:conn: datagram_received: len=1200 id=0 1.042555345s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } frame=Crypto { offset: 0, len: 249 } id=0 1.042613374s s2n_quic:server:conn: tls_client_hello: payload=[[3, 3, 197, 10, 150, 224, 85, 232, 76, 83, 127, 212, 138, 220, 105, 109, 162, 122, 110, 208, 170, 96, 239, 202, 91, 47, 234, 1, 197, 236, 70, 8, 223, 157, 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, 54, 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, 88, 47, 49, 134, 10, 116, 46, 91, 204, 147, 105, 228, 164, 190, 67, 45, 133, 202, 171, 250, 157, 7, 236, 182, 228, 76, 74, 93, 217, 227, 160, 51, 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, 12, 155, 153, 208, 19, 29, 138, 115]] id=0 1.042943741s s2n_quic:server:conn: key_update: key_type=Handshake cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.043161850s s2n_quic:server:conn: application_protocol_information: chosen_application_protocol=[104, 113, 45, 105, 110, 116, 101, 114, 111, 112] id=0 1.043197797s s2n_quic:server:conn: server_name_information: chosen_server_name="server6" id=0 1.043213777s s2n_quic:server:conn: key_exchange_group: chosen_group_name="x25519" contains_kem=false id=0 1.043250816s s2n_quic:server:conn: transport_parameters_received: transport_parameters=TransportParameters { original_destination_connection_id: None, initial_source_connection_id: Some(0x0c9b99d0131d8a73), 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.043317992s s2n_quic:server:conn: key_update: key_type=OneRtt { generation: 0 } cipher_suite=TLS_AES_128_GCM_SHA256 id=0 1.043398492s s2n_quic:server:conn: packet_dropped: reason=DecodingFailed { path: Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } } id=0 1.043595681s 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.043630517s s2n_quic:server:conn: ack_range_sent: packet_header=Initial { number: 0, version: 1 } path_id=0 ack_range=0..=0 id=0 1.043671082s 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.043726386s s2n_quic:server:conn: packet_sent: packet_header=Initial { number: 0, version: 1 } packet_len=151 id=0 1.043761993s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Crypto { offset: 0, len: 686 } id=0 1.043783533s s2n_quic:server:conn: frame_sent: packet_header=Handshake { number: 0, version: 1 } path_id=0 frame=Padding id=0 1.043810704s s2n_quic:server:conn: packet_sent: packet_header=Handshake { number: 0, version: 1 } packet_len=1081 id=0 1.043852362s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.043911793s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, 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.043998225s s2n_quic:server: platform_event_loop_sleep: timeout=Some(998.526ms) processing_duration=2.205ms 1.077560897s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.077653651s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.077672366s s2n_quic:server: platform_rx: count=3 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.077725956s s2n_quic:server: version_information: server_versions=[1] client_versions=[] chosen_version=Some(1) 1.077790307s s2n_quic:server:conn: datagram_received: len=1200 id=0 1.077856170s s2n_quic:server:conn: packet_received: packet_header=Initial { number: 1, version: 1 } id=0 1.077889953s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.077938855s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } ack_range=0..=0 id=0 1.078005339s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=988333 burst_size=12320 pacing_gain=2.77 id=0 1.078050423s s2n_quic:server:conn: ecn_state_changed: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } state=Failed id=0 1.078078686s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 34.184ms, delivered_bytes: 151, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 0, bytes_in_flight: 151, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 4417 } id=0 1.078153657s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=12471 bytes_in_flight=1081 congestion_limited=false id=0 1.078238585s s2n_quic:server:conn: packet_received: packet_header=Handshake { number: 0, version: 1 } id=0 1.078269533s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 0, ack_range_count: 1 } id=0 1.078296243s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } ack_range=0..=0 id=0 1.078336108s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 34.184ms, 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: 36040 } id=0 1.078376113s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.078405588s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } frame=Crypto { offset: 0, len: 36 } id=0 1.078468345s s2n_quic:server:conn: key_space_discarded: space=Initial id=0 1.078484706s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.078603939s s2n_quic:server:conn: handshake_status_updated: status=Complete id=0 1.078626010s s2n_quic:server:conn: handshake_status_updated: status=Confirmed id=0 1.078650426s s2n_quic:server:conn: tls_exporter_ready: session=TlsSession { .. } id=0 1.078696262s s2n_quic:server:conn: key_space_discarded: space=Handshake id=0 1.078711931s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=0 congestion_limited=false id=0 1.078784397s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 0 } id=0 1.078811227s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x0c9b99d0131d8a73, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 1, retire_prior_to: 0 } id=0 1.078862853s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Local previous=0x0c9b99d0131d8a73 current=0x536be0ed8aac9efa id=0 1.078885506s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 2, retire_prior_to: 0 } id=0 1.078933756s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Padding id=0 1.079039985s s2n_quic:server:conn: datagram_received: len=54 id=0 1.079077165s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 1 } id=0 1.079120285s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Stream { id: 0, offset: 0, len: 17, is_fin: true } id=0 1.079192661s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 1.079247183s s2n_quic:server:conn: datagram_received: len=54 id=0 1.079280114s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 2 } id=0 1.079299370s 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: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Stream { id: 4, offset: 0, len: 17, is_fin: true } id=0 1.079349845s s2n_quic:server:conn: rx_stream_progress: bytes=17 id=0 1.079459801s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Ping id=0 1.079493484s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 0 } path_id=0 frame=Padding id=0 1.079532958s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 0 } packet_len=1452 id=0 1.079550400s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.079587349s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 2, ack_range_count: 1 } id=0 1.079604722s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 1 } path_id=0 ack_range=0..=2 id=0 1.079619099s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=HandshakeDone id=0 1.079639707s 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.079653433s 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.079669994s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 1 } path_id=0 frame=RetireConnectionId id=0 1.079718555s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 1 } packet_len=107 id=0 1.079738191s s2n_quic:server:conn: datagram_sent: len=107 gso_offset=0 id=0 1.079771584s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=1559 congestion_limited=false id=0 1.079837047s s2n_quic:server: platform_event_loop_sleep: timeout=Some(127.141ms) processing_duration=2.3ms Accepted a QUIC connection from [fd00:cafe:cafe::100]:55912 on [fd00:cafe:cafe:100::100]:443 1.080722774s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(4) 1.080793516s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(4) 1.080847377s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 1.080875410s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 1.080935652s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.080964556s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.081003659s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=HandshakeDone id=0 1.081048433s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 2 } path_id=0 frame=Stream { id: 4, offset: 0, len: 1203, is_fin: false } id=0 1.081120177s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 2 } packet_len=1232 id=0 1.081148060s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.081180410s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=HandshakeDone id=0 1.081212570s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 3 } path_id=0 frame=Stream { id: 0, offset: 0, len: 1203, is_fin: false } id=0 1.081251694s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 3 } packet_len=1232 id=0 1.081269016s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.081297760s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=HandshakeDone id=0 1.081328387s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 4 } path_id=0 frame=Stream { id: 4, offset: 1203, len: 1201, is_fin: false } id=0 1.081365647s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 4 } packet_len=1232 id=0 1.081382999s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.081410831s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=HandshakeDone id=0 1.081440797s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 5 } path_id=0 frame=Stream { id: 0, offset: 1203, len: 1201, is_fin: false } id=0 1.081477646s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 5 } packet_len=1232 id=0 1.081494718s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.081522420s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=HandshakeDone id=0 1.081552025s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 6 } path_id=0 frame=Stream { id: 4, offset: 2404, len: 1201, is_fin: false } id=0 1.081588474s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 6 } packet_len=1232 id=0 1.081605436s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.081633738s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=HandshakeDone id=0 1.081663614s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 7 } path_id=0 frame=Stream { id: 0, offset: 2404, len: 1201, is_fin: false } id=0 1.081700093s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 7 } packet_len=1232 id=0 1.081716864s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.081744516s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=HandshakeDone id=0 1.081775714s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=Stream { id: 4, offset: 3605, len: 491, is_fin: false } id=0 1.081800571s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 8 } path_id=0 frame=Stream { id: 0, offset: 3605, len: 491, is_fin: false } id=0 1.081841647s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 8 } packet_len=1021 id=0 1.081859511s s2n_quic:server:conn: datagram_sent: len=1021 gso_offset=0 id=0 1.081892002s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=9972 congestion_limited=false id=0 1.081931676s s2n_quic:server:conn: tx_stream_progress: bytes=8192 id=0 1.081969507s s2n_quic:server: platform_event_loop_sleep: timeout=Some(126.566ms) processing_duration=1.034ms 1.082108827s s2n_quic_qns::server::h09: 1024 bytes ready to send on Stream(4) 1.082156416s s2n_quic_qns::server::h09: 1024 bytes sent on Stream(4) 1.082229463s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.082260081s s2n_quic:server: platform_tx: count=7 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.082297440s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=HandshakeDone id=0 1.082334349s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 9 } path_id=0 frame=Stream { id: 4, offset: 4096, len: 1024, is_fin: false } id=0 1.082375967s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 9 } packet_len=1057 id=0 1.082394011s s2n_quic:server:conn: datagram_sent: len=1057 gso_offset=0 id=0 1.082427123s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=11029 congestion_limited=false id=0 1.082457610s s2n_quic:server:conn: tx_stream_progress: bytes=1024 id=0 1.082492425s s2n_quic:server: platform_event_loop_sleep: timeout=Some(127.338ms) processing_duration=264µs 1.082570050s s2n_quic_qns::server::h09: 4096 bytes ready to send on Stream(0) 1.082607941s s2n_quic_qns::server::h09: 4096 bytes sent on Stream(0) 1.082670108s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=false tx_ready=false application_wakeup=true 1.082697720s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.082734578s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=HandshakeDone id=0 1.082769173s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 10 } path_id=0 frame=Stream { id: 0, offset: 4096, len: 1201, is_fin: false } id=0 1.082809669s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 10 } packet_len=1232 id=0 1.082826691s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.082855865s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=HandshakeDone id=0 1.082886743s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 11 } path_id=0 frame=Stream { id: 0, offset: 5297, len: 1201, is_fin: false } id=0 1.082927399s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 11 } packet_len=1232 id=0 1.082945243s s2n_quic:server:conn: datagram_sent: len=1232 gso_offset=0 id=0 1.082976702s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0x284638eafbc0e730797921fee1d0520f, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=34.184ms smoothed_rtt=34.184ms latest_rtt=34.184ms rtt_variance=17.092ms max_ack_delay=25ms pto_count=0 congestion_window=13552 bytes_in_flight=13493 congestion_limited=true id=0 1.083006477s s2n_quic:server:conn: tx_stream_progress: bytes=2406 id=0 1.083041813s s2n_quic:server: platform_event_loop_sleep: timeout=Some(127.226ms) processing_duration=372µs 1.083209938s s2n_quic_qns::server::h09: 2048 bytes ready to send on Stream(0) 1.083244232s s2n_quic_qns::server::h09: 2048 bytes sent on Stream(0) 1.112032628s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.112149747s s2n_quic:server: platform_tx: count=2 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.112169985s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.112247109s s2n_quic:server:conn: datagram_received: len=69 id=0 1.112312010s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 3 } id=0 1.112333420s s2n_quic:server:conn: connection_id_updated: path_id=0 cid_consumer=Remote previous=0x284638eafbc0e730797921fee1d0520f current=0xf124e4563b92485762ee8282f1c0b00a id=0 1.112370650s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 1, ack_range_count: 1 } id=0 1.112413620s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=1 id=0 1.112456831s s2n_quic:server:conn: mtu_updated: path_id=0 mtu=1452 cause=ProbeAcknowledged search_complete=false id=0 1.112477841s s2n_quic:server:conn: handshake_status_updated: status=HandshakeDoneAcked id=0 1.112575413s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 1559, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 47559 } id=0 1.112623323s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=34.0085ms latest_rtt=32.78ms rtt_variance=13.17ms max_ack_delay=25ms pto_count=0 congestion_window=17531 bytes_in_flight=11934 congestion_limited=false id=0 1.112661845s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=NewConnectionId { sequence_number: 3, retire_prior_to: 1 } id=0 1.112705316s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=RetireConnectionId id=0 1.112831923s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Ping id=0 1.112902204s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 12 } path_id=0 frame=Padding id=0 1.112943862s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 12 } packet_len=5202 id=0 1.112963419s s2n_quic:server:conn: datagram_sent: len=5202 gso_offset=0 id=0 1.113003113s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=34.0085ms latest_rtt=32.78ms rtt_variance=13.17ms max_ack_delay=25ms pto_count=0 congestion_window=17531 bytes_in_flight=17136 congestion_limited=true id=0 1.113114522s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.094ms) processing_duration=1.094ms 1.114510594s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.114549928s s2n_quic:server: platform_tx_error: errno=90 1.114562461s s2n_quic:server: platform_tx: count=0 syscalls=1 blocked_syscalls=0 total_errors=1 dropped_errors=0 1.114574604s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.114606012s s2n_quic:server:conn: datagram_received: len=39 id=0 1.114637942s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 4 } id=0 1.114660024s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 3, ack_range_count: 1 } id=0 1.114682215s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 4 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=3 id=0 1.114736958s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 4023, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 122727 } id=0 1.114766663s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=33.958809ms latest_rtt=33.611ms rtt_variance=9.976875ms max_ack_delay=25ms pto_count=0 congestion_window=19995 bytes_in_flight=14672 congestion_limited=false id=0 1.114861020s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 4, ack_range_count: 1 } id=0 1.114889423s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 13 } path_id=0 ack_range=3..=4 id=0 1.114926492s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 4, offset: 5120, len: 0, is_fin: true } id=0 1.114961197s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 13 } path_id=0 frame=Stream { id: 0, offset: 6498, len: 1412, is_fin: false } id=0 1.115008676s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 13 } packet_len=1452 id=0 1.115028513s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.115078116s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 14 } path_id=0 frame=Stream { id: 0, offset: 7910, len: 1422, is_fin: false } id=0 1.115175077s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 14 } packet_len=1452 id=0 1.115195225s s2n_quic:server:conn: datagram_sent: len=1452 gso_offset=0 id=0 1.115248064s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 15 } path_id=0 frame=Stream { id: 0, offset: 9332, len: 908, is_fin: true } id=0 1.115313166s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 15 } packet_len=940 id=0 1.115334546s s2n_quic:server:conn: datagram_sent: len=940 gso_offset=0 id=0 1.115354954s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=33.958809ms latest_rtt=33.611ms rtt_variance=9.976875ms max_ack_delay=25ms pto_count=0 congestion_window=19995 bytes_in_flight=18516 congestion_limited=false id=0 1.115383518s s2n_quic:server:conn: tx_stream_progress: bytes=3738 id=0 1.115426819s s2n_quic:server: platform_event_loop_sleep: timeout=Some(2.347ms) processing_duration=917µs 1.116584895s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.116619049s s2n_quic:server: platform_tx: count=3 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.116632164s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.116664104s s2n_quic:server:conn: datagram_received: len=39 id=0 1.116694681s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 5 } id=0 1.116716061s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 5, ack_range_count: 1 } id=0 1.116738443s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=5 id=0 1.116805749s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 6487, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 197895 } id=0 1.116848399s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=34.172457ms latest_rtt=35.668ms rtt_variance=7.909951ms max_ack_delay=25ms pto_count=0 congestion_window=22459 bytes_in_flight=16052 congestion_limited=false id=0 1.116924100s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=34.172457ms latest_rtt=35.668ms rtt_variance=7.909951ms max_ack_delay=25ms pto_count=0 congestion_window=22459 bytes_in_flight=16052 congestion_limited=false id=0 1.117016132s s2n_quic:server: platform_event_loop_sleep: timeout=Some(88.628ms) processing_duration=433µs 1.118623700s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.118664477s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.118704732s s2n_quic:server:conn: datagram_received: len=39 id=0 1.118741260s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 6 } id=0 1.118792546s 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: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 7, ack_range_count: 1 } id=0 1.118830938s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 6 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=7 id=0 1.118892303s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 8951, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 273062 } id=0 1.118923251s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=34.614024ms latest_rtt=37.705ms rtt_variance=6.815596ms max_ack_delay=25ms pto_count=0 congestion_window=24923 bytes_in_flight=13588 congestion_limited=false id=0 1.119006026s s2n_quic:server: platform_event_loop_sleep: timeout=Some(82.708ms) processing_duration=380µs 1.119548240s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.119583236s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.119617400s s2n_quic:server:conn: datagram_received: len=44 id=0 1.119648608s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 7 } id=0 1.119670038s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 8, ack_range_count: 1 } id=0 1.119692540s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=8 id=0 1.119747744s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 9972, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 304209 } id=0 1.119777339s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=35.114021ms latest_rtt=38.621ms rtt_variance=6.111691ms max_ack_delay=25ms pto_count=0 congestion_window=25944 bytes_in_flight=12567 congestion_limited=false id=0 1.119804279s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 7 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=MaxData { value: 73728 } id=0 1.119873880s s2n_quic:server: platform_event_loop_sleep: timeout=Some(24.732ms) processing_duration=326µs 1.121362145s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.121400566s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.121437746s s2n_quic:server:conn: datagram_received: len=39 id=0 1.121471108s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 8 } id=0 1.121493280s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 8 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 10, ack_range_count: 1 } id=0 1.121516603s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 8 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=10 id=0 1.121576806s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 12261, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 374039 } id=0 1.121606522s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=1025728 burst_size=2904 pacing_gain=2.77 id=0 1.121626038s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=35.563264ms latest_rtt=38.708ms rtt_variance=5.48226ms max_ack_delay=25ms pto_count=0 congestion_window=28233 bytes_in_flight=10278 congestion_limited=false id=0 1.121690299s s2n_quic:server: platform_event_loop_sleep: timeout=Some(22.915ms) processing_duration=330µs 1.144903414s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.145041302s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=35.563264ms latest_rtt=38.708ms rtt_variance=5.48226ms max_ack_delay=25ms pto_count=0 congestion_window=28233 bytes_in_flight=10278 congestion_limited=false id=0 1.145204057s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Ack { ecn_counts: None, largest_acknowledged: 8, ack_range_count: 1 } id=0 1.145235475s s2n_quic:server:conn: ack_range_sent: packet_header=OneRtt { number: 16 } path_id=0 ack_range=3..=8 id=0 1.145272204s s2n_quic:server:conn: frame_sent: packet_header=OneRtt { number: 16 } path_id=0 frame=Padding id=0 1.145322077s s2n_quic:server:conn: packet_sent: packet_header=OneRtt { number: 16 } packet_len=45 id=0 1.145338919s s2n_quic:server:conn: datagram_sent: len=45 gso_offset=0 id=0 1.145375147s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=35.563264ms latest_rtt=38.708ms rtt_variance=5.48226ms max_ack_delay=25ms pto_count=0 congestion_window=28233 bytes_in_flight=10278 congestion_limited=false id=0 1.145454004s s2n_quic:server: platform_event_loop_sleep: timeout=Some(51.874ms) processing_duration=564µs 1.146767561s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.146806033s s2n_quic:server: platform_tx: count=1 syscalls=1 blocked_syscalls=0 total_errors=0 dropped_errors=0 1.146820540s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.146872237s s2n_quic:server:conn: datagram_received: len=40 id=0 1.146912642s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 9 } id=0 1.146939843s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 11, ack_range_count: 1 } id=0 1.146967044s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 9 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=11 id=0 1.147042124s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 32.78ms, delivered_bytes: 13493, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 1232, bytes_in_flight: 1559, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 411623 } id=0 1.147076659s s2n_quic:server:conn: pacing_rate_updated: path_id=0 bytes_per_second=1128795 burst_size=2904 pacing_gain=2.77 id=0 1.147128456s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.78ms smoothed_rtt=38.754606ms latest_rtt=64.13ms rtt_variance=10.494379ms max_ack_delay=25ms pto_count=0 congestion_window=29465 bytes_in_flight=9046 congestion_limited=false id=0 1.147204398s s2n_quic:server: platform_event_loop_sleep: timeout=Some(67.027ms) processing_duration=438µs 1.147291261s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.147316057s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.147348708s s2n_quic:server:conn: datagram_received: len=41 id=0 1.147381179s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 10 } id=0 1.147402539s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 13, ack_range_count: 2 } id=0 1.147424911s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=13..=13 id=0 1.147481747s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 10 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=11 id=0 1.147520730s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 35.41ms, delivered_bytes: 10922, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 5255, bytes_in_flight: 16124, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 308443 } id=0 1.147557108s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.502ms smoothed_rtt=37.973025ms latest_rtt=32.502ms rtt_variance=9.433933ms max_ack_delay=25ms pto_count=0 congestion_window=30917 bytes_in_flight=7594 congestion_limited=false id=0 1.147637057s s2n_quic:server: platform_event_loop_sleep: timeout=Some(7.877ms) processing_duration=346µs 1.148471709s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.148502267s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.148537032s s2n_quic:server:conn: datagram_received: len=47 id=0 1.148568050s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 11 } id=0 1.148590401s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=Ack { ecn_counts: None, largest_acknowledged: 14, ack_range_count: 2 } id=0 1.148613475s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=13..=14 id=0 1.148655884s s2n_quic:server:conn: ack_range_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } ack_range=0..=11 id=0 1.148692783s s2n_quic:server:conn: delivery_rate_sampled: path_id=0 rate_sample=RateSample { interval: 35.41ms, delivered_bytes: 12374, lost_bytes: 0, ecn_ce_count: 0, is_app_limited: true, prior_delivered_bytes: 5255, bytes_in_flight: 16124, prior_lost_bytes: 0, prior_ecn_ce_count: 0, delivery_rate_bytes_per_second: 349449 } id=0 1.148718661s s2n_quic:server:conn: recovery_metrics: path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } min_rtt=32.502ms smoothed_rtt=37.436021ms latest_rtt=33.688ms rtt_variance=8.149455ms max_ack_delay=25ms pto_count=0 congestion_window=32369 bytes_in_flight=6142 congestion_limited=false id=0 1.148745762s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 11 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=MaxStreamData { stream_type: Bidirectional, id: 0, value: 74868 } id=0 1.148817977s s2n_quic:server: platform_event_loop_sleep: timeout=Some(6.092ms) processing_duration=346µs 1.149184102s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=false rx_ready=true tx_ready=false application_wakeup=false 1.149219619s s2n_quic:server: platform_rx: count=1 syscalls=2 blocked_syscalls=1 total_errors=0 dropped_errors=0 1.149259423s s2n_quic:server:conn: datagram_received: len=38 id=0 1.149305019s s2n_quic:server:conn: packet_received: packet_header=OneRtt { number: 12 } id=0 1.149332770s s2n_quic:server:conn: frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=ConnectionClose id=0 1.149364340s s2n_quic:server:conn: connection_close_frame_received: packet_header=OneRtt { number: 12 } path=Path { local_addr: [fd00:cafe:cafe:100:0:0:0:100]:443, local_cid: 0xf124e4563b92485762ee8282f1c0b00a, remote_addr: [fd00:cafe:cafe:0:0:0:0:100]:55912, remote_cid: 0x536be0ed8aac9efa, id: 0, is_active: true } frame=ConnectionCloseFrame { error_code: 0, frame_type: Some(0), reason: None } id=0 1.149393524s 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.149466000s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=283µs 1.149519891s s2n_quic_qns::server::h09: Final stats: MyConnectionContext { packet_sent: 19, stream_requests: 2 } 1.155759236s s2n_quic:server: platform_event_loop_wakeup: timeout_expired=true rx_ready=false tx_ready=false application_wakeup=false 1.155815100s s2n_quic:server: platform_event_loop_sleep: timeout=None processing_duration=60µs