{ "qlog_version": "draft-00", "title": "picoquic", "traces": [
{ "vantage_point": { "name": "backend-67", "type": "server" },
"title": "picoquic", "description": "c44fc12f6d08d677","event_fields": ["relative_time", "path_id", "category", "event", "data"],
"configuration": {"time_units": "us"},
"common_fields": { "protocol_type": "QUIC_HTTP3", "reference_time": "1748512830097"},
"events": [
[0, 0, "transport", "datagram_received", { "byte_length": 1220, "addr_from" : {"ip_v4": "223.191.90.43", "port_v4":38675}, "addr_to" : {"ip_v4": "172.31.61.32", "port_v4":21009}, "ecn" : "Not-ECT"}],
[0, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 1220, "packet_number": 166, "version": "00000001", "payload_length": 1130, "dcid": "c44fc12f6d08d677", "token": "8d4af867233d45e2478bbffec0ff6197da5d272447c77f0567cfc12fd05c7d72e66fe2e6cdc20cc68aa96df790a9a3aa8359dc3e" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 1126}]}],
[177, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 28, "packet_number": 114063, "payload_length": 6, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 22, "acked_ranges": [[166, 166]]}]}],
[177, 0, "transport", "datagram_sent", { "byte_length": 44}],
[485, 0, "transport", "datagram_received", { "byte_length": 1220}],
[485, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 1220, "packet_number": 167, "payload_length": 1130, "dcid": "c44fc12f6d08d677", "token": "8d4af867233d45e2478bbffec0ff6197da5d272447c77f0567cfc12fd05c7d72e66fe2e6cdc20cc68aa96df790a9a3aa8359dc3e" }, "frames": [{ 
    "frame_type": "crypto", "offset": 1126, "length": 1125}]}],
[499, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 28, "packet_number": 114064, "payload_length": 6, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 1, "acked_ranges": [[166, 167]]}]}],
[499, 0, "transport", "datagram_sent", { "byte_length": 44}],
[5394, 0, "transport", "datagram_received", { "byte_length": 1220}],
[5394, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 1220, "packet_number": 168, "payload_length": 1130, "dcid": "c44fc12f6d08d677", "token": "8d4af867233d45e2478bbffec0ff6197da5d272447c77f0567cfc12fd05c7d72e66fe2e6cdc20cc68aa96df790a9a3aa8359dc3e" }, "frames": [{ 
    "frame_type": "crypto", "offset": 2251, "length": 411}, { 
    "frame_type": "ping"}]}],
[5420, 0, "transport", "parameters_set", {
    "owner": "remote",
    "sni": "test.privateoctopus.com",
    "proposed_alpn": ["hq-interop", "h3", "hq-29", "h3-29"],
    "alpn": "hq-interop"}],
[5423, 0, "transport", "parameters_set", {
    "owner": "remote",
    "idle_timeout" : 10000,
    "max_packet_size" : 1472,
    "initial_max_data" : 16777216,
    "initial_max_stream_data_bidi_local" : 65536,
    "initial_max_stream_data_bidi_remote" : 65536,
    "initial_max_stream_data_uni" : 65536,
    "initial_max_streams_uni" : 3,
    "ack_delay_exponent" : 8,
    "max_ack_delay" : 26,
    "active_connection_id_limit" : 4,
    "handshake_connection_id": "",
    "min_ack_delay" : 1000,
    "4d": "0000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000"}],
[5558, 0, "transport", "parameters_set", {
    "owner": "local",
    "initial_max_stream_data_bidi_local" : 2097152,
    "initial_max_data" : 1048576,
    "initial_max_streams_bidi" : 512,
    "idle_timeout" : 30000,
    "max_packet_size" : 1440,
    "initial_max_streams_uni" : 512,
    "initial_max_stream_data_bidi_remote" : 65635,
    "initial_max_stream_data_uni" : 65535,
    "active_connection_id_limit" : 8,
    "max_ack_delay" : 10,
    "handshake_connection_id": "67ee3b24740dbe5c",
    "original_connection_id": "e93c2f57b8869f91",
    "retry_connection_id": "c44fc12f6d08d677",
    "stateless_reset_token": "f8e0ba033dc021cad569167aa9133064",
    "max_datagram_frame_size" : 1536,
    "min_ack_delay" : 1000,
    "address_discovery" : 0,
    "reset_stream_at" : "invalid"}],
[5886, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 122, "packet_number": 114065, "payload_length": 100, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 61, "acked_ranges": [[166, 168]]}, { 
    "frame_type": "crypto", "offset": 0, "length": 90}]}],
[5886, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1098, "packet_number": 0, "payload_length": 1077, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 1073}]}],
[5886, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[5900, 0, "info", "message", { "message": "Server CB, Stream: 0, 0 bytes, fin=9\u000a"}],
[5886, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 186, "packet_number": 1, "payload_length": 165, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 1073, "length": 160}]}],
[5886, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 423, "packet_number": 0, "key_phase": 0 }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 165}, { 
    "frame_type": "new_token", "new_token": "fefb08926d8700637d21ab13df7cd5f0b924d8c7d9269cc4797fe066fcc34f78702f3896baf3721335aa2d262929144eb475"}, { 
    "frame_type": "new_connection_id", "sequence_number": 1, "retire_before": 0, "connection_id": "fb3fae1087630c01", "reset_token": "f8d51ccbcadcf8bdc821165fc013a84d"}, { 
    "frame_type": "new_connection_id", "sequence_number": 2, "retire_before": 0, "connection_id": "201dfe4b2c87d280", "reset_token": "f8bb00288c43d264a68efefb43d2d9eb"}, { 
    "frame_type": "new_connection_id", "sequence_number": 3, "retire_before": 0, "connection_id": "6f9068ca59621487", "reset_token": "6da04ffb072bd501b25d1e66ad1f4d69"}, { 
    "frame_type": "padding"}]}],
[5886, 0, "recovery", "metrics_updated", {"cwnd": 15360,"bytes_in_flight": 1981}],
[5886, 0, "transport", "datagram_sent", { "byte_length": 641}],
[5886, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 1456, "packet_number": 1 }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[5886, 0, "recovery", "metrics_updated", {"bytes_in_flight": 3453}],
[5886, 0, "transport", "datagram_sent", { "byte_length": 1472}],
[256453, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114063,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114063,
        "packet_size" : 28}}],
[505889, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114064,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114064,
        "packet_size" : 28}}],
[505889, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114065,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114065,
        "packet_size" : 122}}],
[505889, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 167, "packet_number": 114066, "payload_length": 145, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 90}, { 
    "frame_type": "ack", "ack_delay": 62561, "acked_ranges": [[166, 168]]}]}],
[505889, 0, "recovery", "metrics_updated", {"bytes_in_flight": 3410}],
[505889, 0, "recovery", "packet_lost", {
    "packet_type" : "handshake",
    "packet_number" : 0,
    "trigger": "timer",
    "header": {
        "packet_type" : "handshake",
        "packet_number" : 0,
        "packet_size" : 1098}}],
[505889, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1053, "packet_number": 2, "payload_length": 1032, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[505889, 0, "recovery", "metrics_updated", {"bytes_in_flight": 3365}],
[505889, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[1005889, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114066,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114066,
        "packet_size" : 167}}],
[1005889, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 167, "packet_number": 114067, "payload_length": 145, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 90}, { 
    "frame_type": "ack", "ack_delay": 125061, "acked_ranges": [[166, 168]]}]}],
[1005889, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1053, "packet_number": 3, "payload_length": 1032, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[1005889, 0, "recovery", "metrics_updated", {"bytes_in_flight": 4434}],
[1005889, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[1631346, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114067,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114067,
        "packet_size" : 167}}],
[1631346, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 167, "packet_number": 114068, "payload_length": 145, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 90}, { 
    "frame_type": "ack", "ack_delay": 203244, "acked_ranges": [[166, 168]]}]}],
[1631346, 0, "recovery", "packet_lost", {
    "packet_type" : "handshake",
    "packet_number" : 1,
    "trigger": "timer",
    "header": {
        "packet_type" : "handshake",
        "packet_number" : 1,
        "packet_size" : 186}}],
[1631346, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1053, "packet_number": 4, "payload_length": 1032, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 1073, "length": 160}, { 
    "frame_type": "padding"}]}],
[1631346, 0, "recovery", "metrics_updated", {"bytes_in_flight": 5301}],
[1631346, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[2256463, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114068,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114068,
        "packet_size" : 167}}],
[2256463, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 167, "packet_number": 114069, "payload_length": 145, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 90}]}],
[2256463, 0, "recovery", "packet_lost", {
    "packet_type" : "handshake",
    "packet_number" : 2,
    "trigger": "timer",
    "header": {
        "packet_type" : "handshake",
        "packet_number" : 2,
        "packet_size" : 1053}}],
[2256463, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1053, "packet_number": 5, "payload_length": 1032, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[2256463, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[2881555, 0, "recovery", "packet_lost", {
    "packet_type" : "initial",
    "packet_number" : 114069,
    "trigger": "timer",
    "header": {
        "packet_type" : "initial",
        "packet_number" : 114069,
        "packet_size" : 167}}],
[2881555, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 167, "packet_number": 114070, "payload_length": 145, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 90}]}],
[2881555, 0, "recovery", "packet_lost", {
    "packet_type" : "handshake",
    "packet_number" : 3,
    "trigger": "timer",
    "header": {
        "packet_type" : "handshake",
        "packet_number" : 3,
        "packet_size" : 1053}}],
[2881555, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1053, "packet_number": 6, "payload_length": 1032, "scid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[2881555, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[3485504, 0, "transport", "datagram_received", { "byte_length": 1220}],
[3485504, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 101, "packet_number": 169, "payload_length": 11, "dcid": "67ee3b24740dbe5c", "token": "8d4af867233d45e2478bbffec0ff6197da5d272447c77f0567cfc12fd05c7d72e66fe2e6cdc20cc68aa96df790a9a3aa8359dc3e" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 0, "acked_ranges": [[114063, 114070]], "ect0": 8, "ect1": 0, "ce": 0}]}],
[3485504, 0, "transport", "packet_received", { "packet_type": "handshake", "header": { "packet_size": 100, "packet_number": 170, "payload_length": 63, "dcid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 0, "acked_ranges": [[0, 6]], "ect0": 7, "ect1": 0, "ce": 0}, { 
    "frame_type": "crypto", "offset": 0, "length": 52}]}],
[3485592, 0, "info", "message", { "message": "Server CB, Stream: 0, 0 bytes, fin=10\u000a"}],
[3485504, 0, "transport", "packet_received", { "packet_type": "1RTT", "header": { "packet_size": 1019, "packet_number": 171, "dcid": "67ee3b24740dbe5c", "key_phase": 0 }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 2, "acked_ranges": [[0, 1]], "ect0": 2, "ect1": 0, "ce": 0}, { 
    "frame_type": "padding"}]}],
[3485504, 0, "recovery", "congestion_state_updated", {"old": "0","new": "7","cc_param": 5507}],
[3485504, 0, "recovery", "metrics_updated", {"cwnd": 92766,"pacing_rate": 962956,"bytes_in_flight": 0,"smoothed_rtt": 963343,"min_rtt": 603949,"latest_rtt": 3479106,"app_limited": 1}],
[3485609, 0, "transport", "spin_bit_updated", { "state": true }],
[3485609, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 39, "packet_number": 2 }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 13, "acked_ranges": [[171, 171]]}, { 
    "frame_type": "ack_frequency", "sequence_number": 0, "packet_tolerance": 8, "max_ack_delay": 10000, "reordering_threshold": 0}, { 
    "frame_type": "handshake_done"}, { 
    "frame_type": "padding"}]}],
[3485609, 0, "recovery", "metrics_updated", {"bytes_in_flight": 55,"smoothed_rtt": 963343}],
[3485609, 0, "transport", "datagram_sent", { "byte_length": 55}],
[3489991, 0, "transport", "datagram_received", { "byte_length": 1252}],
[3489991, 0, "transport", "packet_received", { "packet_type": "1RTT", "header": { "packet_size": 1252, "packet_number": 172, "dcid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[3491087, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 39, "packet_number": 3 }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 137, "acked_ranges": [[171, 172]]}, { 
    "frame_type": "padding"}]}],
[3491087, 0, "recovery", "metrics_updated", {"bytes_in_flight": 110,"smoothed_rtt": 963343}],
[3491087, 0, "transport", "datagram_sent", { "byte_length": 55}],
[3495431, 0, "transport", "datagram_received", { "byte_length": 73}],
[3495431, 0, "transport", "packet_dropped", {
    "packet_type" : "handshake",
    "packet_size" : 73,
    "trigger": "aead not ready"}],
[3495431, 0, "transport", "packet_received", { "packet_type": "1RTT", "header": { "packet_size": 32, "packet_number": 174, "dcid": "67ee3b24740dbe5c" }, "frames": [{ 
    "frame_type": "connection_close", "error_space": "application", "error_code": 0}]}],
[3495471, 0, "info", "message", { "message": "Server CB, Stream: 0, 0 bytes, fin=6\u000a"}],
[3495479, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 6, "packet_number": 4 }, "frames": [{ 
    "frame_type": "connection_close", "error_space": "transport", "error_code": 0}]}],
[3495479, 0, "transport", "datagram_sent", { "byte_length": 22}],
[14451485, 0, "info", "message", { "message": "Closed. Retrans= 11, spurious= 9, max sp gap = 6, max sp delay = 3479618, dg-coal: 1.083333"}]]}]}