mirror of
https://github.com/brain-hackers/u-boot-brain
synced 2024-08-16 23:18:51 +09:00
![Patrick Delaunay](/assets/img/avatar_default.png)
Reduce the log overhead when the traces are filtered, by moving the vsnprintf call from _log() to log_dispatch(). This patch avoids the printf treatment when LOG features is activated, but trace is filtered, for example when MAX_LOG_LEVEL=8 and LOG_DEFAULT_LEVEL=6. Reviewed-by: Simon Glass <sjg@chromium.org> Signed-off-by: Patrick Delaunay <patrick.delaunay@st.com>
424 lines
8.8 KiB
C
424 lines
8.8 KiB
C
// SPDX-License-Identifier: GPL-2.0+
|
|
/*
|
|
* Logging support
|
|
*
|
|
* Copyright (c) 2017 Google, Inc
|
|
* Written by Simon Glass <sjg@chromium.org>
|
|
*/
|
|
|
|
#include <common.h>
|
|
#include <log.h>
|
|
#include <malloc.h>
|
|
#include <dm/uclass.h>
|
|
|
|
DECLARE_GLOBAL_DATA_PTR;
|
|
|
|
static const char *const log_cat_name[] = {
|
|
"none",
|
|
"arch",
|
|
"board",
|
|
"core",
|
|
"driver-model",
|
|
"device-tree",
|
|
"efi",
|
|
"alloc",
|
|
"sandbox",
|
|
"bloblist",
|
|
"devres",
|
|
"acpi",
|
|
"boot",
|
|
};
|
|
|
|
_Static_assert(ARRAY_SIZE(log_cat_name) == LOGC_COUNT - LOGC_NONE,
|
|
"log_cat_name size");
|
|
|
|
static const char *const log_level_name[] = {
|
|
"EMERG",
|
|
"ALERT",
|
|
"CRIT",
|
|
"ERR",
|
|
"WARNING",
|
|
"NOTICE",
|
|
"INFO",
|
|
"DEBUG",
|
|
"CONTENT",
|
|
"IO",
|
|
};
|
|
|
|
_Static_assert(ARRAY_SIZE(log_level_name) == LOGL_COUNT, "log_level_name size");
|
|
|
|
/* All error responses MUST begin with '<' */
|
|
const char *log_get_cat_name(enum log_category_t cat)
|
|
{
|
|
const char *name;
|
|
|
|
if (cat < 0 || cat >= LOGC_COUNT)
|
|
return "<invalid>";
|
|
if (cat >= LOGC_NONE)
|
|
return log_cat_name[cat - LOGC_NONE];
|
|
|
|
#if CONFIG_IS_ENABLED(DM)
|
|
name = uclass_get_name((enum uclass_id)cat);
|
|
#else
|
|
name = NULL;
|
|
#endif
|
|
|
|
return name ? name : "<missing>";
|
|
}
|
|
|
|
enum log_category_t log_get_cat_by_name(const char *name)
|
|
{
|
|
enum uclass_id id;
|
|
int i;
|
|
|
|
for (i = LOGC_NONE; i < LOGC_COUNT; i++)
|
|
if (!strcmp(name, log_cat_name[i - LOGC_NONE]))
|
|
return i;
|
|
id = uclass_get_by_name(name);
|
|
if (id != UCLASS_INVALID)
|
|
return (enum log_category_t)id;
|
|
|
|
return LOGC_NONE;
|
|
}
|
|
|
|
const char *log_get_level_name(enum log_level_t level)
|
|
{
|
|
if (level >= LOGL_COUNT)
|
|
return "INVALID";
|
|
return log_level_name[level];
|
|
}
|
|
|
|
enum log_level_t log_get_level_by_name(const char *name)
|
|
{
|
|
int i;
|
|
|
|
for (i = 0; i < LOGL_COUNT; i++) {
|
|
if (!strcasecmp(log_level_name[i], name))
|
|
return i;
|
|
}
|
|
|
|
return LOGL_NONE;
|
|
}
|
|
|
|
struct log_device *log_device_find_by_name(const char *drv_name)
|
|
{
|
|
struct log_device *ldev;
|
|
|
|
list_for_each_entry(ldev, &gd->log_head, sibling_node) {
|
|
if (!strcmp(drv_name, ldev->drv->name))
|
|
return ldev;
|
|
}
|
|
|
|
return NULL;
|
|
}
|
|
|
|
bool log_has_cat(enum log_category_t cat_list[], enum log_category_t cat)
|
|
{
|
|
int i;
|
|
|
|
for (i = 0; i < LOGF_MAX_CATEGORIES && cat_list[i] != LOGC_END; i++) {
|
|
if (cat_list[i] == cat)
|
|
return true;
|
|
}
|
|
|
|
return false;
|
|
}
|
|
|
|
bool log_has_file(const char *file_list, const char *file)
|
|
{
|
|
int file_len = strlen(file);
|
|
const char *s, *p;
|
|
int substr_len;
|
|
|
|
for (s = file_list; *s; s = p + (*p != '\0')) {
|
|
p = strchrnul(s, ',');
|
|
substr_len = p - s;
|
|
if (file_len >= substr_len &&
|
|
!strncmp(file + file_len - substr_len, s, substr_len))
|
|
return true;
|
|
}
|
|
|
|
return false;
|
|
}
|
|
|
|
/**
|
|
* log_passes_filters() - check if a log record passes the filters for a device
|
|
*
|
|
* @ldev: Log device to check
|
|
* @rec: Log record to check
|
|
* @return true if @rec is not blocked by the filters in @ldev, false if it is
|
|
*/
|
|
static bool log_passes_filters(struct log_device *ldev, struct log_rec *rec)
|
|
{
|
|
struct log_filter *filt;
|
|
|
|
if (rec->force_debug)
|
|
return true;
|
|
|
|
/* If there are no filters, filter on the default log level */
|
|
if (list_empty(&ldev->filter_head)) {
|
|
if (rec->level > gd->default_log_level)
|
|
return false;
|
|
return true;
|
|
}
|
|
|
|
list_for_each_entry(filt, &ldev->filter_head, sibling_node) {
|
|
if (filt->flags & LOGFF_LEVEL_MIN) {
|
|
if (rec->level < filt->level)
|
|
continue;
|
|
} else if (rec->level > filt->level) {
|
|
continue;
|
|
}
|
|
|
|
if ((filt->flags & LOGFF_HAS_CAT) &&
|
|
!log_has_cat(filt->cat_list, rec->cat))
|
|
continue;
|
|
|
|
if (filt->file_list &&
|
|
!log_has_file(filt->file_list, rec->file))
|
|
continue;
|
|
|
|
if (filt->flags & LOGFF_DENY)
|
|
return false;
|
|
else
|
|
return true;
|
|
}
|
|
|
|
return false;
|
|
}
|
|
|
|
/**
|
|
* log_dispatch() - Send a log record to all log devices for processing
|
|
*
|
|
* The log record is sent to each log device in turn, skipping those which have
|
|
* filters which block the record.
|
|
*
|
|
* All log messages created while processing log record @rec are ignored.
|
|
*
|
|
* @rec: log record to dispatch
|
|
* Return: 0 msg sent, 1 msg not sent while already dispatching another msg
|
|
*/
|
|
static int log_dispatch(struct log_rec *rec, const char *fmt, va_list args)
|
|
{
|
|
struct log_device *ldev;
|
|
char buf[CONFIG_SYS_CBSIZE];
|
|
|
|
/*
|
|
* When a log driver writes messages (e.g. via the network stack) this
|
|
* may result in further generated messages. We cannot process them here
|
|
* as this might result in infinite recursion.
|
|
*/
|
|
if (gd->processing_msg)
|
|
return 1;
|
|
|
|
/* Emit message */
|
|
gd->processing_msg = true;
|
|
list_for_each_entry(ldev, &gd->log_head, sibling_node) {
|
|
if ((ldev->flags & LOGDF_ENABLE) &&
|
|
log_passes_filters(ldev, rec)) {
|
|
if (!rec->msg) {
|
|
vsnprintf(buf, sizeof(buf), fmt, args);
|
|
rec->msg = buf;
|
|
}
|
|
ldev->drv->emit(ldev, rec);
|
|
}
|
|
}
|
|
gd->processing_msg = false;
|
|
return 0;
|
|
}
|
|
|
|
int _log(enum log_category_t cat, enum log_level_t level, const char *file,
|
|
int line, const char *func, const char *fmt, ...)
|
|
{
|
|
struct log_rec rec;
|
|
va_list args;
|
|
|
|
if (!gd)
|
|
return -ENOSYS;
|
|
|
|
/* Check for message continuation */
|
|
if (cat == LOGC_CONT)
|
|
cat = gd->logc_prev;
|
|
if (level == LOGL_CONT)
|
|
level = gd->logl_prev;
|
|
|
|
rec.cat = cat;
|
|
rec.level = level & LOGL_LEVEL_MASK;
|
|
rec.force_debug = level & LOGL_FORCE_DEBUG;
|
|
rec.file = file;
|
|
rec.line = line;
|
|
rec.func = func;
|
|
rec.msg = NULL;
|
|
|
|
if (!(gd->flags & GD_FLG_LOG_READY)) {
|
|
gd->log_drop_count++;
|
|
|
|
/* display dropped traces with console puts and DEBUG_UART */
|
|
if (rec.level <= CONFIG_LOG_DEFAULT_LEVEL || rec.force_debug) {
|
|
char buf[CONFIG_SYS_CBSIZE];
|
|
|
|
va_start(args, fmt);
|
|
vsnprintf(buf, sizeof(buf), fmt, args);
|
|
puts(buf);
|
|
va_end(args);
|
|
}
|
|
|
|
return -ENOSYS;
|
|
}
|
|
va_start(args, fmt);
|
|
if (!log_dispatch(&rec, fmt, args)) {
|
|
gd->logc_prev = cat;
|
|
gd->logl_prev = level;
|
|
}
|
|
va_end(args);
|
|
|
|
return 0;
|
|
}
|
|
|
|
int log_add_filter_flags(const char *drv_name, enum log_category_t cat_list[],
|
|
enum log_level_t level, const char *file_list,
|
|
int flags)
|
|
{
|
|
struct log_filter *filt;
|
|
struct log_device *ldev;
|
|
int ret;
|
|
int i;
|
|
|
|
ldev = log_device_find_by_name(drv_name);
|
|
if (!ldev)
|
|
return -ENOENT;
|
|
filt = calloc(1, sizeof(*filt));
|
|
if (!filt)
|
|
return -ENOMEM;
|
|
|
|
filt->flags = flags;
|
|
if (cat_list) {
|
|
filt->flags |= LOGFF_HAS_CAT;
|
|
for (i = 0; ; i++) {
|
|
if (i == ARRAY_SIZE(filt->cat_list)) {
|
|
ret = -ENOSPC;
|
|
goto err;
|
|
}
|
|
filt->cat_list[i] = cat_list[i];
|
|
if (cat_list[i] == LOGC_END)
|
|
break;
|
|
}
|
|
}
|
|
filt->level = level;
|
|
if (file_list) {
|
|
filt->file_list = strdup(file_list);
|
|
if (!filt->file_list) {
|
|
ret = -ENOMEM;
|
|
goto err;
|
|
}
|
|
}
|
|
filt->filter_num = ldev->next_filter_num++;
|
|
/* Add deny filters to the beginning of the list */
|
|
if (flags & LOGFF_DENY)
|
|
list_add(&filt->sibling_node, &ldev->filter_head);
|
|
else
|
|
list_add_tail(&filt->sibling_node, &ldev->filter_head);
|
|
|
|
return filt->filter_num;
|
|
|
|
err:
|
|
free(filt);
|
|
return ret;
|
|
}
|
|
|
|
int log_remove_filter(const char *drv_name, int filter_num)
|
|
{
|
|
struct log_filter *filt;
|
|
struct log_device *ldev;
|
|
|
|
ldev = log_device_find_by_name(drv_name);
|
|
if (!ldev)
|
|
return -ENOENT;
|
|
|
|
list_for_each_entry(filt, &ldev->filter_head, sibling_node) {
|
|
if (filt->filter_num == filter_num) {
|
|
list_del(&filt->sibling_node);
|
|
free(filt);
|
|
|
|
return 0;
|
|
}
|
|
}
|
|
|
|
return -ENOENT;
|
|
}
|
|
|
|
/**
|
|
* log_find_device_by_drv() - Find a device by its driver
|
|
*
|
|
* @drv: Log driver
|
|
* @return Device associated with that driver, or NULL if not found
|
|
*/
|
|
static struct log_device *log_find_device_by_drv(struct log_driver *drv)
|
|
{
|
|
struct log_device *ldev;
|
|
|
|
list_for_each_entry(ldev, &gd->log_head, sibling_node) {
|
|
if (ldev->drv == drv)
|
|
return ldev;
|
|
}
|
|
/*
|
|
* It is quite hard to pass an invalid driver since passing an unknown
|
|
* LOG_GET_DRIVER(xxx) would normally produce a compilation error. But
|
|
* it is possible to pass NULL, for example, so this
|
|
*/
|
|
|
|
return NULL;
|
|
}
|
|
|
|
int log_device_set_enable(struct log_driver *drv, bool enable)
|
|
{
|
|
struct log_device *ldev;
|
|
|
|
ldev = log_find_device_by_drv(drv);
|
|
if (!ldev)
|
|
return -ENOENT;
|
|
if (enable)
|
|
ldev->flags |= LOGDF_ENABLE;
|
|
else
|
|
ldev->flags &= ~LOGDF_ENABLE;
|
|
|
|
return 0;
|
|
}
|
|
|
|
int log_init(void)
|
|
{
|
|
struct log_driver *drv = ll_entry_start(struct log_driver, log_driver);
|
|
const int count = ll_entry_count(struct log_driver, log_driver);
|
|
struct log_driver *end = drv + count;
|
|
|
|
/*
|
|
* We cannot add runtime data to the driver since it is likely stored
|
|
* in rodata. Instead, set up a 'device' corresponding to each driver.
|
|
* We only support having a single device.
|
|
*/
|
|
INIT_LIST_HEAD((struct list_head *)&gd->log_head);
|
|
while (drv < end) {
|
|
struct log_device *ldev;
|
|
|
|
ldev = calloc(1, sizeof(*ldev));
|
|
if (!ldev) {
|
|
debug("%s: Cannot allocate memory\n", __func__);
|
|
return -ENOMEM;
|
|
}
|
|
INIT_LIST_HEAD(&ldev->filter_head);
|
|
ldev->drv = drv;
|
|
ldev->flags = drv->flags;
|
|
list_add_tail(&ldev->sibling_node,
|
|
(struct list_head *)&gd->log_head);
|
|
drv++;
|
|
}
|
|
gd->flags |= GD_FLG_LOG_READY;
|
|
if (!gd->default_log_level)
|
|
gd->default_log_level = CONFIG_LOG_DEFAULT_LEVEL;
|
|
gd->log_fmt = log_get_default_format();
|
|
gd->logc_prev = LOGC_NONE;
|
|
gd->logl_prev = LOGL_INFO;
|
|
|
|
return 0;
|
|
}
|