mirror of https://github.com/openssl/openssl
249 lines
9.0 KiB
C
249 lines
9.0 KiB
C
/*
|
|
* Copyright 2024 The OpenSSL Project Authors. All Rights Reserved.
|
|
*
|
|
* Licensed under the Apache License 2.0 (the "License"). You may not use
|
|
* this file except in compliance with the License. You can obtain a copy
|
|
* in the file LICENSE in the source distribution or at
|
|
* https://www.openssl.org/source/license.html
|
|
*/
|
|
|
|
#include "internal/qlog.h"
|
|
#include "testutil.h"
|
|
|
|
/*
|
|
* Unfortunately, this must be expressed as an array and not a string literal as
|
|
* ANSI C only guarantees support for up to 509 characters in a string literal.
|
|
*/
|
|
static const char expected[] = {
|
|
30, '{', '"', 'q', 'l', 'o', 'g', '_', 'v', 'e', 'r', 's', 'i', 'o', 'n',
|
|
'"', ':', '"', '0', '.', '3', '"', ',', '"', 'q', 'l', 'o', 'g', '_', 'f',
|
|
'o', 'r', 'm', 'a', 't', '"', ':', '"', 'J', 'S', 'O', 'N', '-', 'S', 'E',
|
|
'Q', '"', ',', '"', 't', 'i', 't', 'l', 'e', '"', ':', '"', 't', 'e', 's',
|
|
't', ' ', 't', 'i', 't', 'l', 'e', '"', ',', '"', 'd', 'e', 's', 'c', 'r',
|
|
'i', 'p', 't', 'i', 'o', 'n', '"', ':', '"', 't', 'e', 's', 't', ' ', 'd',
|
|
'e', 's', 'c', 'r', 'i', 'p', 't', 'i', 'o', 'n', '"', ',', '"', 't', 'r',
|
|
'a', 'c', 'e', '"', ':', '{', '"', 'c', 'o', 'm', 'm', 'o', 'n', '_', 'f',
|
|
'i', 'e', 'l', 'd', 's', '"', ':', '{', '"', 't', 'i', 'm', 'e', '_', 'f',
|
|
'o', 'r', 'm', 'a', 't', '"', ':', '"', 'd', 'e', 'l', 't', 'a', '"', ',',
|
|
'"', 'p', 'r', 'o', 't', 'o', 'c', 'o', 'l', '_', 't', 'y', 'p', 'e', '"',
|
|
':', '[', '"', 'Q', 'U', 'I', 'C', '"', ']', ',', '"', 'g', 'r', 'o', 'u',
|
|
'p', '_', 'i', 'd', '"', ':', '"', 't', 'e', 's', 't', ' ', 'g', 'r', 'o',
|
|
'u', 'p', ' ', 'I', 'D', '"', ',', '"', 's', 'y', 's', 't', 'e', 'm', '_',
|
|
'i', 'n', 'f', 'o', '"', ':', '{', '"', 'p', 'r', 'o', 'c', 'e', 's', 's',
|
|
'_', 'i', 'd', '"', ':', '1', '2', '3', '}', '}', ',', '"', 'v', 'a', 'n',
|
|
't', 'a', 'g', 'e', '_', 'p', 'o', 'i', 'n', 't', '"', ':', '{', '"', 't',
|
|
'y', 'p', 'e', '"', ':', '"', 'c', 'l', 'i', 'e', 'n', 't', '"', ',', '"',
|
|
'n', 'a', 'm', 'e', '"', ':', '"', 'O', 'p', 'e', 'n', 'S', 'S', 'L', '/',
|
|
'x', '.', 'y', '.', 'z', '"', '}', '}', '}', 10, 30, '{', '"', 'n', 'a',
|
|
'm', 'e', '"', ':', '"', 't', 'r', 'a', 'n', 's', 'p', 'o', 'r', 't', ':',
|
|
'p', 'a', 'c', 'k', 'e', 't', '_', 's', 'e', 'n', 't', '"', ',', '"', 'd',
|
|
'a', 't', 'a', '"', ':', '{', '"', 'f', 'i', 'e', 'l', 'd', '1', '"', ':',
|
|
'"', 'f', 'o', 'o', '"', ',', '"', 'f', 'i', 'e', 'l', 'd', '2', '"', ':',
|
|
'"', 'b', 'a', 'r', '"', ',', '"', 'f', 'i', 'e', 'l', 'd', '3', '"', ':',
|
|
'4', '2', ',', '"', 'f', 'i', 'e', 'l', 'd', '4', '"', ':', '"', '1', '1',
|
|
'5', '2', '9', '2', '1', '5', '0', '4', '6', '0', '6', '8', '4', '6', '9',
|
|
'7', '6', '"', ',', '"', 'f', 'i', 'e', 'l', 'd', '5', '"', ':', '"', '1',
|
|
'8', '4', '4', '6', '7', '4', '4', '0', '7', '3', '7', '0', '9', '5', '5',
|
|
'1', '6', '1', '5', '"', ',', '"', 'f', 'i', 'e', 'l', 'd', '6', '"', ':',
|
|
'f', 'a', 'l', 's', 'e', ',', '"', 'f', 'i', 'e', 'l', 'd', '7', '"', ':',
|
|
't', 'r', 'u', 'e', ',', '"', 'f', 'i', 'e', 'l', 'd', '8', '"', ':', '"',
|
|
'0', '1', 'a', 'f', '"', ',', '"', 'f', 'i', 'e', 'l', 'd', '9', '"', ':',
|
|
'"', '5', '5', '"', ',', '"', 's', 'u', 'b', 'g', 'r', 'o', 'u', 'p', '"',
|
|
':', '{', '"', 'f', 'i', 'e', 'l', 'd', '1', '0', '"', ':', '"', 'b', 'a',
|
|
'z', '"', '}', ',', '"', 'a', 'r', 'r', 'a', 'y', '"', ':', '[', '"', 'a',
|
|
'"', ',', '"', 'b', '"', ']', '}', ',', '"', 't', 'i', 'm', 'e', '"', ':',
|
|
'1', '7', '0', '6', '5', '3', '1', '1', '7', '0', '0', '0', '}', 10, 30,
|
|
'{', '"', 'n', 'a', 'm', 'e', '"', ':', '"', 't', 'r', 'a', 'n', 's', 'p',
|
|
'o', 'r', 't', ':', 'p', 'a', 'c', 'k', 'e', 't', '_', 's', 'e', 'n', 't',
|
|
'"', ',', '"', 'd', 'a', 't', 'a', '"', ':', '{', '"', 'f', 'i', 'e', 'l',
|
|
'd', '1', '"', ':', '"', 'b', 'a', 'r', '"', '}', ',', '"', 't', 'i', 'm',
|
|
'e', '"', ':', '1', '0', '0', '0', '}', 10
|
|
};
|
|
|
|
static const unsigned char bin_buf[] = {
|
|
0x01, 0xaf
|
|
};
|
|
|
|
static OSSL_TIME last_time;
|
|
|
|
static OSSL_TIME now(void *arg)
|
|
{
|
|
OSSL_TIME t = last_time;
|
|
|
|
last_time = ossl_time_add(t, ossl_ms2time(1000));
|
|
return t;
|
|
}
|
|
|
|
static int test_qlog(void)
|
|
{
|
|
int testresult = 0;
|
|
QLOG_TRACE_INFO qti = {0};
|
|
QLOG *qlog;
|
|
BIO *bio;
|
|
char *buf = NULL;
|
|
size_t buf_len = 0;
|
|
|
|
last_time = ossl_time_from_time_t(170653117);
|
|
|
|
qti.odcid.id_len = 1;
|
|
qti.odcid.id[0] = 0x55;
|
|
qti.title = "test title";
|
|
qti.description = "test description";
|
|
qti.group_id = "test group ID";
|
|
qti.override_process_id = 123;
|
|
qti.now_cb = now;
|
|
qti.override_impl_name = "OpenSSL/x.y.z";
|
|
|
|
if (!TEST_ptr(qlog = ossl_qlog_new(&qti)))
|
|
goto err;
|
|
|
|
if (!TEST_true(ossl_qlog_set_event_type_enabled(qlog, QLOG_EVENT_TYPE_transport_packet_sent, 1)))
|
|
goto err;
|
|
|
|
if (!TEST_ptr(bio = BIO_new(BIO_s_mem())))
|
|
goto err;
|
|
|
|
if (!TEST_true(ossl_qlog_set_sink_bio(qlog, bio)))
|
|
goto err;
|
|
|
|
QLOG_EVENT_BEGIN(qlog, transport, packet_sent)
|
|
QLOG_STR("field1", "foo");
|
|
QLOG_STR_LEN("field2", "bar", 3);
|
|
QLOG_I64("field3", 42);
|
|
QLOG_I64("field4", 1ULL << 60);
|
|
QLOG_U64("field5", UINT64_MAX);
|
|
QLOG_BOOL("field6", 0);
|
|
QLOG_BOOL("field7", 1);
|
|
QLOG_BIN("field8", bin_buf, sizeof(bin_buf));
|
|
QLOG_CID("field9", &qti.odcid);
|
|
QLOG_BEGIN("subgroup")
|
|
QLOG_STR("field10", "baz");
|
|
QLOG_END()
|
|
QLOG_BEGIN_ARRAY("array")
|
|
QLOG_STR(NULL, "a");
|
|
QLOG_STR(NULL, "b");
|
|
QLOG_END_ARRAY()
|
|
QLOG_EVENT_END()
|
|
|
|
/* not enabled */
|
|
QLOG_EVENT_BEGIN(qlog, transport, packet_received)
|
|
QLOG_STR("field1", "foo");
|
|
QLOG_EVENT_END()
|
|
|
|
/* test delta time calculation */
|
|
QLOG_EVENT_BEGIN(qlog, transport, packet_sent)
|
|
QLOG_STR("field1", "bar");
|
|
QLOG_EVENT_END()
|
|
|
|
if (!TEST_true(ossl_qlog_flush(qlog)))
|
|
goto err;
|
|
|
|
buf_len = BIO_get_mem_data(bio, &buf);
|
|
if (!TEST_size_t_gt(buf_len, 0))
|
|
goto err;
|
|
|
|
if (!TEST_mem_eq(buf, buf_len, expected, sizeof(expected)))
|
|
goto err;
|
|
|
|
testresult = 1;
|
|
err:
|
|
ossl_qlog_free(qlog);
|
|
return testresult;
|
|
}
|
|
|
|
struct filter_spec {
|
|
const char *filter;
|
|
int expect_ok;
|
|
uint32_t expect_event_type;
|
|
int expect_event_enable;
|
|
};
|
|
|
|
static const struct filter_spec filters[] = {
|
|
{ "*", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 1 },
|
|
{ "-*", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 0 },
|
|
{ "+*", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 1 },
|
|
{ "* *", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_received, 1 },
|
|
{ "-* +*", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_received, 1 },
|
|
{ "-* +* -*", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_received, 0 },
|
|
{ " *", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 1 },
|
|
{ " ", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 0 },
|
|
{ "", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 0 },
|
|
{ "transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 1 },
|
|
{ "transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_received, 0 },
|
|
{ "* -transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_received, 1 },
|
|
{ "* -transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 0 },
|
|
{ "unknown:event", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 0 },
|
|
{ "unknown:event +transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 1 },
|
|
{ "unknown:event transport:*", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 1 },
|
|
{ "unknown:event +transport:* -transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_received, 1 },
|
|
{ "unknown:event transport:* -transport:packet_sent", 1,
|
|
QLOG_EVENT_TYPE_transport_packet_sent, 0 },
|
|
{ "* -transport:*", 1,
|
|
QLOG_EVENT_TYPE_connectivity_connection_started, 1 },
|
|
{ "* -transport:*", 1,
|
|
QLOG_EVENT_TYPE_transport_parameters_set, 0 },
|
|
{ "&", 0 },
|
|
{ "event_name_without_category", 0 },
|
|
{ "event_name_with_@badchar:foo", 0 },
|
|
{ "event_name_with_badchar:f@oo", 0 },
|
|
{ "category:", 0 },
|
|
{ ":name", 0 },
|
|
{ ":", 0 },
|
|
{ "**", 0 },
|
|
{ "foo:bar*", 0 },
|
|
{ "foo:*bar", 0 },
|
|
{ "foo*:bar", 0 },
|
|
{ "*foo:bar", 0 },
|
|
};
|
|
|
|
static int test_qlog_filter(int idx)
|
|
{
|
|
int testresult = 0;
|
|
QLOG_TRACE_INFO qti = {0};
|
|
QLOG *qlog;
|
|
|
|
qti.odcid.id_len = 1;
|
|
qti.odcid.id[0] = 0x55;
|
|
|
|
if (!TEST_ptr(qlog = ossl_qlog_new(&qti)))
|
|
goto err;
|
|
|
|
if (!TEST_int_eq(ossl_qlog_set_filter(qlog, filters[idx].filter),
|
|
filters[idx].expect_ok))
|
|
goto err;
|
|
|
|
if (filters[idx].expect_event_type != QLOG_EVENT_TYPE_NONE)
|
|
if (!TEST_int_eq(ossl_qlog_enabled(qlog, filters[idx].expect_event_type),
|
|
filters[idx].expect_event_enable))
|
|
goto err;
|
|
|
|
testresult = 1;
|
|
err:
|
|
ossl_qlog_free(qlog);
|
|
return testresult;
|
|
}
|
|
|
|
int setup_tests(void)
|
|
{
|
|
ADD_TEST(test_qlog);
|
|
ADD_ALL_TESTS(test_qlog_filter, OSSL_NELEM(filters));
|
|
return 1;
|
|
}
|