{ "qlog_version": "draft-00", "title": "picoquic", "traces": [
{ "vantage_point": { "name": "backend-67", "type": "server" },
"title": "picoquic", "description": "f67ae7b3e25c95b22bacdc6e8e9d6edb17af70ff","event_fields": ["relative_time", "path_id", "category", "event", "data"],
"configuration": {"time_units": "us"},
"common_fields": { "protocol_type": "QUIC_HTTP3", "reference_time": "1221552406505"},
"events": [
[0, 0, "transport", "datagram_received", { "byte_length": 1200, "addr_from" : {"ip_v4": "200.199.155.164", "port_v4":32220}, "addr_to" : {"ip_v4": "172.31.61.32", "port_v4":20753}}],
[0, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 1200, "packet_number": 0, "version": "00000001", "payload_length": 1131, "scid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "dcid": "f67ae7b3e25c95b22bacdc6e8e9d6edb17af70ff" }, "frames": [{ 
    "frame_type": "crypto", "offset": 71, "length": 18}, { 
    "frame_type": "crypto", "offset": 616, "length": 230}, { 
    "frame_type": "crypto", "offset": 156, "length": 460}, { 
    "frame_type": "crypto", "offset": 961, "length": 116}, { 
    "frame_type": "crypto", "offset": 107, "length": 18}, { 
    "frame_type": "crypto", "offset": 846, "length": 115}, { 
    "frame_type": "ping"}, { 
    "frame_type": "crypto", "offset": 125, "length": 18}, { 
    "frame_type": "crypto", "offset": 89, "length": 18}, { 
    "frame_type": "crypto", "offset": 35, "length": 36}, { 
    "frame_type": "crypto", "offset": 0, "length": 17}, { 
    "frame_type": "crypto", "offset": 17, "length": 18}]}],
[112, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 47, "packet_number": 98260, "payload_length": 5, "scid": "fe7b93ef3138174d", "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 14, "acked_ranges": [[0, 0]]}]}],
[112, 0, "transport", "datagram_sent", { "byte_length": 63}],
[465, 0, "transport", "datagram_received", { "byte_length": 1200}],
[465, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 1200, "packet_number": 1, "payload_length": 1131, "scid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "dcid": "f67ae7b3e25c95b22bacdc6e8e9d6edb17af70ff" }, "frames": [{ 
    "frame_type": "crypto", "offset": 153, "length": 1}, { 
    "frame_type": "crypto", "offset": 146, "length": 3}, { 
    "frame_type": "crypto", "offset": 150, "length": 1}, { 
    "frame_type": "crypto", "offset": 151, "length": 1}, { 
    "frame_type": "crypto", "offset": 144, "length": 2}, { 
    "frame_type": "crypto", "offset": 152, "length": 1}, { 
    "frame_type": "crypto", "offset": 143, "length": 1}, { 
    "frame_type": "crypto", "offset": 155, "length": 1}, { 
    "frame_type": "crypto", "offset": 154, "length": 1}, { 
    "frame_type": "crypto", "offset": 149, "length": 1}, { 
    "frame_type": "crypto", "offset": 1106, "length": 29}, { 
    "frame_type": "crypto", "offset": 1193, "length": 29}, { 
    "frame_type": "crypto", "offset": 1135, "length": 29}, { 
    "frame_type": "crypto", "offset": 1236, "length": 15}, { 
    "frame_type": "crypto", "offset": 1309, "length": 116}, { 
    "frame_type": "crypto", "offset": 1251, "length": 58}, { 
    "frame_type": "crypto", "offset": 1222, "length": 14}, { 
    "frame_type": "crypto", "offset": 1077, "length": 29}, { 
    "frame_type": "crypto", "offset": 1178, "length": 15}, { 
    "frame_type": "crypto", "offset": 1425, "length": 117}, { 
    "frame_type": "crypto", "offset": 1164, "length": 14}]}],
[505, 0, "transport", "parameters_set", {
    "owner": "remote",
    "sni": "test.privateoctopus.com",
    "proposed_alpn": ["h3", "h3-29"],
    "alpn": "h3"}],
[508, 0, "transport", "parameters_set", {
    "owner": "remote",
    "handshake_connection_id": "2f3263a071aee1e422bcfb5b52c70140f6661fb6",
    "initial_max_stream_data_bidi_local" : 32768,
    "initial_max_stream_data_bidi_remote" : 32768,
    "initial_max_stream_data_uni" : 1048576000,
    "initial_max_data" : 1048576000,
    "initial_max_streams_bidi" : 262144,
    "initial_max_streams_uni" : 262144,
    "version_negotiation": {"chosen": "00000001", "others": ["00000001"]}}],
[527, 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": "fe7b93ef3138174d",
    "original_connection_id": "f67ae7b3e25c95b22bacdc6e8e9d6edb17af70ff",
    "stateless_reset_token": "56b16ffcd11c78f13742b531cb703ac9",
    "max_datagram_frame_size" : 1536,
    "version_negotiation": {"chosen": "00000001", "others": ["00000001","6b3343cf","709a50c4","ff000022","ff000021","ff000020","ff00001f","ff00001d","ff00001e","ff00001c","ff00001b","50435131","50435130"]},
    "address_discovery" : 0,
    "reset_stream_at" : "invalid"}],
[795, 0, "transport", "packet_sent", { "packet_type": "initial", "header": { "packet_size": 141, "packet_number": 98261, "payload_length": 99, "scid": "fe7b93ef3138174d", "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 41, "acked_ranges": [[0, 1]]}, { 
    "frame_type": "crypto", "offset": 0, "length": 90}]}],
[795, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 1079, "packet_number": 0, "payload_length": 1038, "scid": "fe7b93ef3138174d", "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 1034}]}],
[795, 0, "transport", "datagram_sent", { "byte_length": 1252}],
[795, 0, "transport", "packet_sent", { "packet_type": "handshake", "header": { "packet_size": 289, "packet_number": 1, "payload_length": 248, "scid": "fe7b93ef3138174d", "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "crypto", "offset": 1034, "length": 243}]}],
[795, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 423, "packet_number": 0, "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "key_phase": 0 }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 157}, { 
    "frame_type": "new_token", "new_token": "7f9edc2253e6e49ba284e2babbc2cf698bf1fd4427ec16b0f39b505aef84205059bd188a05dd61f867a711480e7573da22ed"}, { 
    "frame_type": "new_connection_id", "sequence_number": 1, "retire_before": 0, "connection_id": "89869523233cb9ac", "reset_token": "83750b8748066b7f56266b0e3a486427"}, { 
    "frame_type": "stream", "id": 3, "offset": 0, "length": 40, "fin": false , "begins_with": "0004250100068001"}, { 
    "frame_type": "stream", "id": 7, "offset": 0, "length": 1, "fin": false , "begins_with": "02"}, { 
    "frame_type": "stream", "id": 11, "offset": 0, "length": 1, "fin": false , "begins_with": "03"}, { 
    "frame_type": "padding"}]}],
[795, 0, "recovery", "metrics_updated", {"cwnd": 15360,"bytes_in_flight": 2059}],
[795, 0, "transport", "datagram_sent", { "byte_length": 744}],
[795, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 1424, "packet_number": 1, "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[795, 0, "recovery", "metrics_updated", {"bytes_in_flight": 3499}],
[795, 0, "transport", "datagram_sent", { "byte_length": 1440}],
[156820, 0, "transport", "datagram_received", { "byte_length": 1200}],
[156820, 0, "transport", "packet_received", { "packet_type": "initial", "header": { "packet_size": 65, "packet_number": 2, "payload_length": 8, "scid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "dcid": "fe7b93ef3138174d" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 0, "acked_ranges": [[98260, 98261]]}]}],
[156820, 0, "transport", "packet_received", { "packet_type": "handshake", "header": { "packet_size": 1135, "packet_number": 0, "payload_length": 1079, "scid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "dcid": "fe7b93ef3138174d" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 0, "acked_ranges": [[0, 0]]}, { 
    "frame_type": "padding"}]}],
[156852, 0, "transport", "datagram_received", { "byte_length": 61}],
[156852, 0, "transport", "packet_received", { "packet_type": "handshake", "header": { "packet_size": 61, "packet_number": 1, "payload_length": 5, "scid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "dcid": "fe7b93ef3138174d" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 0, "acked_ranges": [[0, 1]]}]}],
[160205, 0, "transport", "datagram_received", { "byte_length": 577}],
[160205, 0, "transport", "packet_received", { "packet_type": "handshake", "header": { "packet_size": 111, "packet_number": 2, "payload_length": 55, "scid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6", "dcid": "fe7b93ef3138174d" }, "frames": [{ 
    "frame_type": "crypto", "offset": 0, "length": 52}]}],
[160205, 0, "transport", "packet_received", { "packet_type": "1RTT", "header": { "packet_size": 466, "packet_number": 0, "dcid": "fe7b93ef3138174d", "key_phase": 0 }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 1164, "acked_ranges": [[0, 1]]}, { 
    "frame_type": "new_connection_id", "sequence_number": 7, "retire_before": 0, "connection_id": "772fe2bd910c99dfbcf6f53fe8d41ab6949b6578", "reset_token": "b366a053adc98733961401e25aed77a8"}, { 
    "frame_type": "new_connection_id", "sequence_number": 6, "retire_before": 0, "connection_id": "c15d67977649191eb6a6ce6231d265db53de121a", "reset_token": "068cf7764e95a1019ea79ee93772bd8f"}, { 
    "frame_type": "new_connection_id", "sequence_number": 5, "retire_before": 0, "connection_id": "72fd86b55956542b2efcfd9d426d29e2a89a3776", "reset_token": "521dd54678850b5ffef2ef41768ee245"}, { 
    "frame_type": "new_connection_id", "sequence_number": 4, "retire_before": 0, "connection_id": "2166844dc4a0f2af5ddd0e391da629459c64b558", "reset_token": "5df2d150439ed3eb80954687042d8373"}, { 
    "frame_type": "new_connection_id", "sequence_number": 3, "retire_before": 0, "connection_id": "b6da65c787b897fcaef8ec7ffda3655f426fd699", "reset_token": "98a4c3f4288274ec79072152c7b1fbab"}, { 
    "frame_type": "new_connection_id", "sequence_number": 2, "retire_before": 0, "connection_id": "dd0acd5ddc5c4602345e90ecc1dd258bcf012693", "reset_token": "d096b02a4946a75c8eb204c4c189ebf6"}, { 
    "frame_type": "new_connection_id", "sequence_number": 1, "retire_before": 0, "connection_id": "a3ac43b99c48f8605a3ad784f22bc05fb1eab3c6", "reset_token": "3c8728ccb4fe8f1da72dcfad71489100"}, { 
    "frame_type": "stream", "id": 2, "offset": 0, "length": 16, "fin": false , "begins_with": "00040d06ffffffff"}, { 
    "frame_type": "stream", "id": 10, "offset": 0, "length": 1, "fin": false , "begins_with": "03"}, { 
    "frame_type": "stream", "id": 6, "offset": 0, "length": 1, "fin": false , "begins_with": "02"}, { 
    "frame_type": "stream", "id": 0, "offset": 0, "length": 123, "fin": true , "begins_with": "0140780000d1d750"}]}],
[160257, 0, "info", "message", { "message": "H3 control frame: 06ffffffffffffffff01000700"}],
[160267, 0, "info", "message", { "message": "Stream 0 marked active: wake time forced to now, is_output_stream=1"}],
[160205, 0, "recovery", "metrics_updated", {"cwnd": 18763,"pacing_rate": 1361380,"bytes_in_flight": 0,"smoothed_rtt": 156451,"min_rtt": 156025,"latest_rtt": 159410,"app_limited": 1}],
[160273, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 423, "packet_number": 2, "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 8, "acked_ranges": [[0, 0]]}, { 
    "frame_type": "handshake_done"}, { 
    "frame_type": "stream", "id": 0, "offset": 0, "length": 23, "fin": false , "begins_with": "0140110000d95f4d"}, { 
    "frame_type": "stream", "id": 0, "offset": 23, "length": 256, "fin": true , "begins_with": "5a5a5a5a5a5a5a5a"}, { 
    "frame_type": "padding"}]}],
[160273, 0, "recovery", "metrics_updated", {"bytes_in_flight": 439,"smoothed_rtt": 156451}],
[160273, 0, "transport", "datagram_sent", { "byte_length": 439}],
[161721, 0, "transport", "datagram_received", { "byte_length": 1406}],
[161721, 0, "transport", "packet_received", { "packet_type": "1RTT", "header": { "packet_size": 1406, "packet_number": 1, "dcid": "fe7b93ef3138174d" }, "frames": [{ 
    "frame_type": "ping"}, { 
    "frame_type": "padding"}]}],
[171810, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 39, "packet_number": 3, "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "ack", "ack_delay": 1261, "acked_ranges": [[0, 1]]}, { 
    "frame_type": "padding"}]}],
[171810, 0, "recovery", "metrics_updated", {"bytes_in_flight": 494,"smoothed_rtt": 156451}],
[171810, 0, "transport", "datagram_sent", { "byte_length": 55}],
[304218, 0, "transport", "datagram_received", { "byte_length": 42}],
[304218, 0, "transport", "packet_received", { "packet_type": "1RTT", "header": { "packet_size": 42, "packet_number": 2, "dcid": "fe7b93ef3138174d" }, "frames": [{ 
    "frame_type": "connection_close", "error_space": "transport", "error_code": 0}, { 
    "frame_type": "padding"}]}],
[304228, 0, "transport", "packet_sent", { "packet_type": "1RTT", "header": { "packet_size": 26, "packet_number": 4, "dcid": "2f3263a071aee1e422bcfb5b52c70140f6661fb6" }, "frames": [{ 
    "frame_type": "connection_close", "error_space": "transport", "error_code": 0}]}],
[304228, 0, "transport", "datagram_sent", { "byte_length": 42}],
[1008914, 0, "info", "message", { "message": "Clearing context on connection close (5)"}],
[1008924, 0, "info", "message", { "message": "Closed. Retrans= 0, spurious= 0, max sp gap = 0, max sp delay = 0, dg-coal: 1.166667"}]]}]}