2018-10-30 09:00:30 +08:00
|
|
|
/*
|
2022-03-21 14:06:17 +08:00
|
|
|
* Copyright (c) 2006-2022, RT-Thread Development Team
|
2018-10-30 09:00:30 +08:00
|
|
|
*
|
|
|
|
* SPDX-License-Identifier: Apache-2.0
|
|
|
|
*
|
|
|
|
* Change Logs:
|
|
|
|
* Date Author Notes
|
|
|
|
* 2018-08-25 armink the first version
|
|
|
|
*/
|
|
|
|
|
|
|
|
#include <stdarg.h>
|
|
|
|
#include "ulog.h"
|
|
|
|
#include "rthw.h"
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_SYSLOG
|
|
|
|
#include <syslog.h>
|
|
|
|
#endif
|
|
|
|
|
|
|
|
#ifdef ULOG_TIME_USING_TIMESTAMP
|
2018-11-09 17:31:40 +08:00
|
|
|
#include <sys/time.h>
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
#include <rtdevice.h>
|
|
|
|
#endif
|
|
|
|
|
|
|
|
#ifdef RT_USING_ULOG
|
|
|
|
|
|
|
|
/* the number which is max stored line logs */
|
|
|
|
#ifndef ULOG_ASYNC_OUTPUT_STORE_LINES
|
2021-02-01 11:22:05 +08:00
|
|
|
#define ULOG_ASYNC_OUTPUT_STORE_LINES (ULOG_ASYNC_OUTPUT_BUF_SIZE * 3 / 2 / 80)
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_COLOR
|
|
|
|
/**
|
|
|
|
* CSI(Control Sequence Introducer/Initiator) sign
|
|
|
|
* more information on https://en.wikipedia.org/wiki/ANSI_escape_code
|
|
|
|
*/
|
|
|
|
#define CSI_START "\033["
|
|
|
|
#define CSI_END "\033[0m"
|
|
|
|
/* output log front color */
|
|
|
|
#define F_BLACK "30m"
|
|
|
|
#define F_RED "31m"
|
|
|
|
#define F_GREEN "32m"
|
|
|
|
#define F_YELLOW "33m"
|
|
|
|
#define F_BLUE "34m"
|
|
|
|
#define F_MAGENTA "35m"
|
|
|
|
#define F_CYAN "36m"
|
|
|
|
#define F_WHITE "37m"
|
|
|
|
|
|
|
|
/* output log default color definition */
|
|
|
|
#ifndef ULOG_COLOR_DEBUG
|
2022-03-21 14:06:17 +08:00
|
|
|
#define ULOG_COLOR_DEBUG RT_NULL
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif
|
|
|
|
#ifndef ULOG_COLOR_INFO
|
|
|
|
#define ULOG_COLOR_INFO (F_GREEN)
|
|
|
|
#endif
|
|
|
|
#ifndef ULOG_COLOR_WARN
|
|
|
|
#define ULOG_COLOR_WARN (F_YELLOW)
|
|
|
|
#endif
|
|
|
|
#ifndef ULOG_COLOR_ERROR
|
|
|
|
#define ULOG_COLOR_ERROR (F_RED)
|
|
|
|
#endif
|
|
|
|
#ifndef ULOG_COLOR_ASSERT
|
|
|
|
#define ULOG_COLOR_ASSERT (F_MAGENTA)
|
|
|
|
#endif
|
|
|
|
#endif /* ULOG_USING_COLOR */
|
|
|
|
|
|
|
|
#if ULOG_LINE_BUF_SIZE < 80
|
|
|
|
#error "the log line buffer size must more than 80"
|
|
|
|
#endif
|
|
|
|
|
|
|
|
struct rt_ulog
|
|
|
|
{
|
|
|
|
rt_bool_t init_ok;
|
2021-05-19 18:17:37 +08:00
|
|
|
rt_bool_t output_lock_enabled;
|
2022-03-21 14:06:17 +08:00
|
|
|
struct rt_mutex output_locker;
|
2018-10-30 09:00:30 +08:00
|
|
|
/* all backends */
|
|
|
|
rt_slist_t backend_list;
|
|
|
|
/* the thread log's line buffer */
|
2019-12-21 00:17:38 +08:00
|
|
|
char log_buf_th[ULOG_LINE_BUF_SIZE + 1];
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
#ifdef ULOG_USING_ISR_LOG
|
|
|
|
/* the ISR log's line buffer */
|
|
|
|
rt_base_t output_locker_isr_lvl;
|
2019-12-21 00:17:38 +08:00
|
|
|
char log_buf_isr[ULOG_LINE_BUF_SIZE + 1];
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif /* ULOG_USING_ISR_LOG */
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
2021-01-20 11:20:30 +08:00
|
|
|
rt_bool_t async_enabled;
|
2018-10-30 09:00:30 +08:00
|
|
|
rt_rbb_t async_rbb;
|
2021-02-01 11:22:05 +08:00
|
|
|
/* ringbuffer for log_raw function only */
|
|
|
|
struct rt_ringbuffer *async_rb;
|
2018-10-30 09:00:30 +08:00
|
|
|
rt_thread_t async_th;
|
|
|
|
struct rt_semaphore async_notice;
|
|
|
|
#endif
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
|
|
|
struct
|
|
|
|
{
|
|
|
|
/* all tag's level filter */
|
|
|
|
rt_slist_t tag_lvl_list;
|
|
|
|
/* global filter level, tag and keyword */
|
|
|
|
rt_uint32_t level;
|
|
|
|
char tag[ULOG_FILTER_TAG_MAX_LEN + 1];
|
|
|
|
char keyword[ULOG_FILTER_KW_MAX_LEN + 1];
|
|
|
|
} filter;
|
|
|
|
#endif /* ULOG_USING_FILTER */
|
|
|
|
};
|
|
|
|
|
|
|
|
/* level output info */
|
|
|
|
static const char * const level_output_info[] =
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
"A/",
|
|
|
|
RT_NULL,
|
|
|
|
RT_NULL,
|
|
|
|
"E/",
|
|
|
|
"W/",
|
|
|
|
RT_NULL,
|
|
|
|
"I/",
|
|
|
|
"D/",
|
2018-10-30 09:00:30 +08:00
|
|
|
};
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_COLOR
|
|
|
|
/* color output info */
|
|
|
|
static const char * const color_output_info[] =
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
ULOG_COLOR_ASSERT,
|
|
|
|
RT_NULL,
|
|
|
|
RT_NULL,
|
|
|
|
ULOG_COLOR_ERROR,
|
|
|
|
ULOG_COLOR_WARN,
|
|
|
|
RT_NULL,
|
|
|
|
ULOG_COLOR_INFO,
|
|
|
|
ULOG_COLOR_DEBUG,
|
2018-10-30 09:00:30 +08:00
|
|
|
};
|
|
|
|
#endif /* ULOG_USING_COLOR */
|
|
|
|
|
|
|
|
/* ulog local object */
|
|
|
|
static struct rt_ulog ulog = { 0 };
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_size_t ulog_strcpy(rt_size_t cur_len, char *dst, const char *src)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
const char *src_old = src;
|
|
|
|
|
|
|
|
RT_ASSERT(dst);
|
|
|
|
RT_ASSERT(src);
|
|
|
|
|
|
|
|
while (*src != 0)
|
|
|
|
{
|
|
|
|
/* make sure destination has enough space */
|
2019-01-03 15:31:04 +08:00
|
|
|
if (cur_len++ < ULOG_LINE_BUF_SIZE)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
*dst++ = *src++;
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
break;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
return src - src_old;
|
|
|
|
}
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_size_t ulog_ultoa(char *s, unsigned long int n)
|
2018-11-01 14:51:50 +08:00
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_size_t i = 0, j = 0, len = 0;
|
2018-11-01 14:51:50 +08:00
|
|
|
char swap;
|
|
|
|
|
|
|
|
do
|
|
|
|
{
|
|
|
|
s[len++] = n % 10 + '0';
|
|
|
|
} while (n /= 10);
|
|
|
|
s[len] = '\0';
|
|
|
|
/* reverse string */
|
|
|
|
for (i = 0, j = len - 1; i < j; ++i, --j)
|
|
|
|
{
|
|
|
|
swap = s[i];
|
|
|
|
s[i] = s[j];
|
|
|
|
s[j] = swap;
|
|
|
|
}
|
|
|
|
return len;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
static void output_unlock(void)
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
/* earlier stage */
|
|
|
|
if (ulog.output_lock_enabled == RT_FALSE)
|
|
|
|
{
|
2021-05-19 18:17:37 +08:00
|
|
|
return;
|
2022-03-21 14:06:17 +08:00
|
|
|
}
|
2021-05-19 18:17:37 +08:00
|
|
|
|
2022-02-09 15:18:26 +08:00
|
|
|
/* If the scheduler is started and in thread context */
|
2022-02-10 09:40:12 +08:00
|
|
|
if (rt_interrupt_get_nest() == 0 && rt_thread_self() != RT_NULL)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_mutex_release(&ulog.output_locker);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
#ifdef ULOG_USING_ISR_LOG
|
|
|
|
rt_hw_interrupt_enable(ulog.output_locker_isr_lvl);
|
|
|
|
#endif
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
static void output_lock(void)
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
/* earlier stage */
|
|
|
|
if (ulog.output_lock_enabled == RT_FALSE)
|
|
|
|
{
|
2021-05-19 18:17:37 +08:00
|
|
|
return;
|
2022-03-21 14:06:17 +08:00
|
|
|
}
|
2021-05-19 18:17:37 +08:00
|
|
|
|
2022-02-09 15:18:26 +08:00
|
|
|
/* If the scheduler is started and in thread context */
|
2022-02-10 09:40:12 +08:00
|
|
|
if (rt_interrupt_get_nest() == 0 && rt_thread_self() != RT_NULL)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_mutex_take(&ulog.output_locker, RT_WAITING_FOREVER);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
#ifdef ULOG_USING_ISR_LOG
|
|
|
|
ulog.output_locker_isr_lvl = rt_hw_interrupt_disable();
|
|
|
|
#endif
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
2021-05-19 18:17:37 +08:00
|
|
|
void ulog_output_lock_enabled(rt_bool_t enabled)
|
|
|
|
{
|
|
|
|
ulog.output_lock_enabled = enabled;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
static char *get_log_buf(void)
|
|
|
|
{
|
|
|
|
/* is in thread context */
|
|
|
|
if (rt_interrupt_get_nest() == 0)
|
|
|
|
{
|
|
|
|
return ulog.log_buf_th;
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
#ifdef ULOG_USING_ISR_LOG
|
|
|
|
return ulog.log_buf_isr;
|
|
|
|
#else
|
|
|
|
rt_kprintf("Error: Current mode not supported run in ISR. Please enable ULOG_USING_ISR_LOG.\n");
|
2022-03-21 14:06:17 +08:00
|
|
|
return RT_NULL;
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
2018-10-31 10:54:12 +08:00
|
|
|
RT_WEAK rt_size_t ulog_formater(char *log_buf, rt_uint32_t level, const char *tag, rt_bool_t newline,
|
|
|
|
const char *format, va_list args)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2018-11-01 14:51:50 +08:00
|
|
|
/* the caller has locker, so it can use static variable for reduce stack usage */
|
|
|
|
static rt_size_t log_len, newline_len;
|
|
|
|
static int fmt_result;
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
RT_ASSERT(log_buf);
|
|
|
|
RT_ASSERT(level <= LOG_LVL_DBG);
|
|
|
|
RT_ASSERT(tag);
|
|
|
|
RT_ASSERT(format);
|
|
|
|
|
2018-11-01 14:51:50 +08:00
|
|
|
log_len = 0;
|
|
|
|
newline_len = rt_strlen(ULOG_NEWLINE_SIGN);
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
#ifdef ULOG_USING_COLOR
|
|
|
|
/* add CSI start sign and color info */
|
|
|
|
if (color_output_info[level])
|
|
|
|
{
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, CSI_START);
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, color_output_info[level]);
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_COLOR */
|
|
|
|
|
2021-09-29 18:55:15 +08:00
|
|
|
log_buf[log_len] = '\0';
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
#ifdef ULOG_OUTPUT_TIME
|
|
|
|
/* add time info */
|
|
|
|
{
|
|
|
|
#ifdef ULOG_TIME_USING_TIMESTAMP
|
2021-04-15 14:15:39 +08:00
|
|
|
static struct timeval now;
|
2018-11-01 14:51:50 +08:00
|
|
|
static struct tm *tm, tm_tmp;
|
2021-04-15 14:15:39 +08:00
|
|
|
static rt_bool_t check_usec_support = RT_FALSE, usec_is_support = RT_FALSE;
|
2022-04-05 17:48:06 +08:00
|
|
|
time_t t = (time_t)0;
|
2018-10-30 09:00:30 +08:00
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
if (gettimeofday(&now, RT_NULL) >= 0)
|
2021-04-15 14:15:39 +08:00
|
|
|
{
|
2022-04-05 17:48:06 +08:00
|
|
|
t = now.tv_sec;
|
|
|
|
}
|
|
|
|
tm = localtime_r(&t, &tm_tmp);
|
|
|
|
/* show the time format MM-DD HH:MM:SS */
|
|
|
|
rt_snprintf(log_buf + log_len, ULOG_LINE_BUF_SIZE - log_len, "%02d-%02d %02d:%02d:%02d", tm->tm_mon + 1,
|
|
|
|
tm->tm_mday, tm->tm_hour, tm->tm_min, tm->tm_sec);
|
|
|
|
/* check the microseconds support when kernel is startup */
|
|
|
|
if (t > 0 && !check_usec_support && rt_thread_self() != RT_NULL)
|
|
|
|
{
|
|
|
|
long old_usec = now.tv_usec;
|
|
|
|
/* delay some time for wait microseconds changed */
|
|
|
|
rt_thread_mdelay(10);
|
|
|
|
gettimeofday(&now, RT_NULL);
|
|
|
|
check_usec_support = RT_TRUE;
|
|
|
|
/* the microseconds is not equal between two gettimeofday calls */
|
|
|
|
if (now.tv_usec != old_usec)
|
|
|
|
usec_is_support = RT_TRUE;
|
|
|
|
}
|
|
|
|
if (usec_is_support)
|
|
|
|
{
|
|
|
|
/* show the millisecond */
|
|
|
|
log_len += rt_strlen(log_buf + log_len);
|
|
|
|
rt_snprintf(log_buf + log_len, ULOG_LINE_BUF_SIZE - log_len, ".%03d", now.tv_usec / 1000);
|
2021-04-15 14:15:39 +08:00
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
#else
|
2018-11-01 14:51:50 +08:00
|
|
|
static rt_size_t tick_len = 0;
|
|
|
|
|
|
|
|
log_buf[log_len] = '[';
|
|
|
|
tick_len = ulog_ultoa(log_buf + log_len + 1, rt_tick_get());
|
|
|
|
log_buf[log_len + 1 + tick_len] = ']';
|
|
|
|
log_buf[log_len + 1 + tick_len + 1] = '\0';
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif /* ULOG_TIME_USING_TIMESTAMP */
|
|
|
|
|
|
|
|
log_len += rt_strlen(log_buf + log_len);
|
|
|
|
}
|
|
|
|
#endif /* ULOG_OUTPUT_TIME */
|
|
|
|
|
|
|
|
#ifdef ULOG_OUTPUT_LEVEL
|
|
|
|
|
|
|
|
#ifdef ULOG_OUTPUT_TIME
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, " ");
|
|
|
|
#endif
|
|
|
|
|
|
|
|
/* add level info */
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, level_output_info[level]);
|
|
|
|
#endif /* ULOG_OUTPUT_LEVEL */
|
|
|
|
|
|
|
|
#ifdef ULOG_OUTPUT_TAG
|
|
|
|
|
|
|
|
#if !defined(ULOG_OUTPUT_LEVEL) && defined(ULOG_OUTPUT_TIME)
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, " ");
|
|
|
|
#endif
|
|
|
|
|
|
|
|
/* add tag info */
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, tag);
|
|
|
|
#endif /* ULOG_OUTPUT_TAG */
|
|
|
|
|
|
|
|
#ifdef ULOG_OUTPUT_THREAD_NAME
|
|
|
|
/* add thread info */
|
|
|
|
{
|
|
|
|
|
|
|
|
#if defined(ULOG_OUTPUT_TIME) || defined(ULOG_OUTPUT_LEVEL) || defined(ULOG_OUTPUT_TAG)
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, " ");
|
|
|
|
#endif
|
|
|
|
|
|
|
|
/* is not in interrupt context */
|
|
|
|
if (rt_interrupt_get_nest() == 0)
|
|
|
|
{
|
2021-04-12 22:16:17 +08:00
|
|
|
rt_size_t name_len = 0;
|
|
|
|
const char *thread_name = "N/A";
|
2021-04-19 06:50:58 +08:00
|
|
|
if (rt_thread_self())
|
2021-04-15 14:15:39 +08:00
|
|
|
{
|
2021-04-12 22:16:17 +08:00
|
|
|
thread_name = rt_thread_self()->name;
|
2021-04-15 14:15:39 +08:00
|
|
|
}
|
2021-04-12 22:16:17 +08:00
|
|
|
name_len = rt_strnlen(thread_name, RT_NAME_MAX);
|
|
|
|
rt_strncpy(log_buf + log_len, thread_name, name_len);
|
2019-03-09 15:49:32 +08:00
|
|
|
log_len += name_len;
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, "ISR");
|
|
|
|
}
|
|
|
|
}
|
|
|
|
#endif /* ULOG_OUTPUT_THREAD_NAME */
|
|
|
|
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, ": ");
|
|
|
|
fmt_result = rt_vsnprintf(log_buf + log_len, ULOG_LINE_BUF_SIZE - log_len, format, args);
|
|
|
|
|
|
|
|
/* calculate log length */
|
|
|
|
if ((log_len + fmt_result <= ULOG_LINE_BUF_SIZE) && (fmt_result > -1))
|
|
|
|
{
|
|
|
|
log_len += fmt_result;
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
/* using max length */
|
|
|
|
log_len = ULOG_LINE_BUF_SIZE;
|
|
|
|
}
|
|
|
|
|
2022-04-05 17:48:06 +08:00
|
|
|
/* overflow check and reserve some space for CSI end sign, newline sign and string end sign */
|
2018-10-30 09:00:30 +08:00
|
|
|
#ifdef ULOG_USING_COLOR
|
2022-04-05 17:48:06 +08:00
|
|
|
if (log_len + (sizeof(CSI_END) - 1) + newline_len + sizeof((char)'\0') > ULOG_LINE_BUF_SIZE)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
/* using max length */
|
|
|
|
log_len = ULOG_LINE_BUF_SIZE;
|
|
|
|
/* reserve some space for CSI end sign */
|
|
|
|
log_len -= (sizeof(CSI_END) - 1);
|
|
|
|
#else
|
2022-04-05 17:48:06 +08:00
|
|
|
if (log_len + newline_len + sizeof((char)'\0') > ULOG_LINE_BUF_SIZE)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
/* using max length */
|
|
|
|
log_len = ULOG_LINE_BUF_SIZE;
|
|
|
|
#endif /* ULOG_USING_COLOR */
|
|
|
|
/* reserve some space for newline sign */
|
|
|
|
log_len -= newline_len;
|
2022-04-05 17:48:06 +08:00
|
|
|
/* reserve some space for string end sign */
|
|
|
|
log_len -= sizeof((char)'\0');
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
|
|
|
|
/* package newline sign */
|
2018-10-31 10:54:12 +08:00
|
|
|
if (newline)
|
|
|
|
{
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, ULOG_NEWLINE_SIGN);
|
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
#ifdef ULOG_USING_COLOR
|
|
|
|
/* add CSI end sign */
|
|
|
|
if (color_output_info[level])
|
|
|
|
{
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, CSI_END);
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_COLOR */
|
|
|
|
|
2022-04-05 17:48:06 +08:00
|
|
|
/* add string end sign */
|
|
|
|
log_buf[log_len] = '\0';
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
return log_len;
|
|
|
|
}
|
|
|
|
|
2022-04-05 17:48:06 +08:00
|
|
|
static void ulog_output_to_all_backend(rt_uint32_t level, const char *tag, rt_bool_t is_raw, const char *log, rt_size_t len)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
rt_slist_t *node;
|
|
|
|
ulog_backend_t backend;
|
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
return;
|
|
|
|
|
2022-02-09 15:18:26 +08:00
|
|
|
/* if there is no backend */
|
|
|
|
if (!rt_slist_first(&ulog.backend_list))
|
|
|
|
{
|
|
|
|
rt_kputs(log);
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/* output for all backends */
|
|
|
|
for (node = rt_slist_first(&ulog.backend_list); node; node = rt_slist_next(node))
|
|
|
|
{
|
|
|
|
backend = rt_slist_entry(node, struct ulog_backend, list);
|
2021-01-20 11:20:30 +08:00
|
|
|
if (backend->out_level < level)
|
|
|
|
{
|
|
|
|
continue;
|
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
#if !defined(ULOG_USING_COLOR) || defined(ULOG_USING_SYSLOG)
|
2022-04-05 17:48:06 +08:00
|
|
|
backend->output(backend, level, tag, is_raw, log, len);
|
2018-10-30 09:00:30 +08:00
|
|
|
#else
|
2022-04-05 17:48:06 +08:00
|
|
|
if (backend->filter && backend->filter(backend, level, tag, is_raw, log, len) == RT_FALSE)
|
2021-12-03 12:04:20 +08:00
|
|
|
{
|
|
|
|
/* backend's filter is not match, so skip output */
|
|
|
|
continue;
|
|
|
|
}
|
2020-01-07 11:22:26 +08:00
|
|
|
if (backend->support_color || is_raw)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2022-04-05 17:48:06 +08:00
|
|
|
backend->output(backend, level, tag, is_raw, log, len);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
/* recalculate the log start address and log size when backend not supported color */
|
2022-04-05 17:48:06 +08:00
|
|
|
rt_size_t color_info_len = 0, output_len = len;
|
2021-12-03 12:04:20 +08:00
|
|
|
const char *output_log = log;
|
2021-01-21 18:58:57 +08:00
|
|
|
|
|
|
|
if (color_output_info[level] != RT_NULL)
|
|
|
|
color_info_len = rt_strlen(color_output_info[level]);
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
if (color_info_len)
|
|
|
|
{
|
|
|
|
rt_size_t color_hdr_len = rt_strlen(CSI_START) + color_info_len;
|
|
|
|
|
2021-08-19 09:13:16 +08:00
|
|
|
output_log += color_hdr_len;
|
2022-04-05 17:48:06 +08:00
|
|
|
output_len -= (color_hdr_len + (sizeof(CSI_END) - 1));
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
2022-04-05 17:48:06 +08:00
|
|
|
backend->output(backend, level, tag, is_raw, output_log, output_len);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
#endif /* !defined(ULOG_USING_COLOR) || defined(ULOG_USING_SYSLOG) */
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
static void do_output(rt_uint32_t level, const char *tag, rt_bool_t is_raw, const char *log_buf, rt_size_t log_len)
|
|
|
|
{
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
2022-04-05 17:48:06 +08:00
|
|
|
rt_size_t log_buf_size = log_len + sizeof((char)'\0');
|
2018-10-30 09:00:30 +08:00
|
|
|
|
2021-02-01 11:22:05 +08:00
|
|
|
if (is_raw == RT_FALSE)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2021-02-01 11:22:05 +08:00
|
|
|
rt_rbb_blk_t log_blk;
|
|
|
|
ulog_frame_t log_frame;
|
|
|
|
|
|
|
|
/* allocate log frame */
|
2022-04-05 17:48:06 +08:00
|
|
|
log_blk = rt_rbb_blk_alloc(ulog.async_rbb, RT_ALIGN(sizeof(struct ulog_frame) + log_buf_size, RT_ALIGN_SIZE));
|
2021-02-01 11:22:05 +08:00
|
|
|
if (log_blk)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2021-02-01 11:22:05 +08:00
|
|
|
/* package the log frame */
|
|
|
|
log_frame = (ulog_frame_t) log_blk->buf;
|
|
|
|
log_frame->magic = ULOG_FRAME_MAGIC;
|
|
|
|
log_frame->is_raw = is_raw;
|
|
|
|
log_frame->level = level;
|
|
|
|
log_frame->log_len = log_len;
|
|
|
|
log_frame->tag = tag;
|
|
|
|
log_frame->log = (const char *)log_blk->buf + sizeof(struct ulog_frame);
|
|
|
|
/* copy log data */
|
2022-04-05 17:48:06 +08:00
|
|
|
rt_strncpy((char *)(log_blk->buf + sizeof(struct ulog_frame)), log_buf, log_buf_size);
|
2021-02-01 11:22:05 +08:00
|
|
|
/* put the block */
|
|
|
|
rt_rbb_blk_put(log_blk);
|
|
|
|
/* send a notice */
|
|
|
|
rt_sem_release(&ulog.async_notice);
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
static rt_bool_t already_output = RT_FALSE;
|
|
|
|
if (already_output == RT_FALSE)
|
|
|
|
{
|
|
|
|
rt_kprintf("Warning: There is no enough buffer for saving async log,"
|
|
|
|
" please increase the ULOG_ASYNC_OUTPUT_BUF_SIZE option.\n");
|
|
|
|
already_output = RT_TRUE;
|
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
}
|
2021-02-01 11:22:05 +08:00
|
|
|
else if (ulog.async_rb)
|
|
|
|
{
|
2022-04-05 17:48:06 +08:00
|
|
|
rt_ringbuffer_put(ulog.async_rb, (const rt_uint8_t *)log_buf, log_buf_size);
|
2021-02-01 11:22:05 +08:00
|
|
|
/* send a notice */
|
|
|
|
rt_sem_release(&ulog.async_notice);
|
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
#else
|
|
|
|
/* is in thread context */
|
|
|
|
if (rt_interrupt_get_nest() == 0)
|
|
|
|
{
|
|
|
|
/* output to all backends */
|
|
|
|
ulog_output_to_all_backend(level, tag, is_raw, log_buf, log_len);
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
#ifdef ULOG_BACKEND_USING_CONSOLE
|
|
|
|
/* We can't ensure that all backends support ISR context output.
|
|
|
|
* So only using rt_kprintf when context is ISR */
|
|
|
|
extern void ulog_console_backend_output(struct ulog_backend *backend, rt_uint32_t level, const char *tag,
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_bool_t is_raw, const char *log, rt_size_t len);
|
|
|
|
ulog_console_backend_output(RT_NULL, level, tag, is_raw, log_buf, log_len);
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif /* ULOG_BACKEND_USING_CONSOLE */
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_ASYNC_OUTPUT */
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* output the log by variable argument list
|
|
|
|
*
|
|
|
|
* @param level level
|
|
|
|
* @param tag tag
|
2018-10-31 10:54:12 +08:00
|
|
|
* @param newline has_newline
|
2018-10-30 09:00:30 +08:00
|
|
|
* @param format output format
|
|
|
|
* @param args variable argument list
|
|
|
|
*/
|
2018-10-31 10:54:12 +08:00
|
|
|
void ulog_voutput(rt_uint32_t level, const char *tag, rt_bool_t newline, const char *format, va_list args)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
static rt_bool_t ulog_voutput_recursion = RT_FALSE;
|
|
|
|
char *log_buf = RT_NULL;
|
2018-10-30 09:00:30 +08:00
|
|
|
rt_size_t log_len = 0;
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
RT_ASSERT(tag);
|
|
|
|
RT_ASSERT(format);
|
2018-10-30 09:00:30 +08:00
|
|
|
#ifndef ULOG_USING_SYSLOG
|
|
|
|
RT_ASSERT(level <= LOG_LVL_DBG);
|
|
|
|
#else
|
|
|
|
RT_ASSERT(LOG_PRI(level) <= LOG_DEBUG);
|
|
|
|
#endif /* ULOG_USING_SYSLOG */
|
|
|
|
|
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
{
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
|
|
|
/* level filter */
|
|
|
|
#ifndef ULOG_USING_SYSLOG
|
|
|
|
if (level > ulog.filter.level || level > ulog_tag_lvl_filter_get(tag))
|
|
|
|
{
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
#else
|
|
|
|
if (((LOG_MASK(LOG_PRI(level)) & ulog.filter.level) == 0)
|
|
|
|
|| ((LOG_MASK(LOG_PRI(level)) & ulog_tag_lvl_filter_get(tag)) == 0))
|
|
|
|
{
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_SYSLOG */
|
|
|
|
else if (!rt_strstr(tag, ulog.filter.tag))
|
|
|
|
{
|
2022-04-05 17:48:06 +08:00
|
|
|
/* tag filter */
|
2018-10-30 09:00:30 +08:00
|
|
|
return;
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_FILTER */
|
|
|
|
|
|
|
|
/* get log buffer */
|
|
|
|
log_buf = get_log_buf();
|
|
|
|
|
|
|
|
/* lock output */
|
|
|
|
output_lock();
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
/* If there is a recursion, we use a simple way */
|
|
|
|
if (ulog_voutput_recursion == RT_TRUE)
|
|
|
|
{
|
|
|
|
rt_kprintf(format, args);
|
|
|
|
if(newline == RT_TRUE)
|
|
|
|
{
|
|
|
|
rt_kprintf(ULOG_NEWLINE_SIGN);
|
|
|
|
}
|
|
|
|
output_unlock();
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
|
|
|
|
ulog_voutput_recursion = RT_TRUE;
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
#ifndef ULOG_USING_SYSLOG
|
2018-10-31 10:54:12 +08:00
|
|
|
log_len = ulog_formater(log_buf, level, tag, newline, format, args);
|
2018-10-30 09:00:30 +08:00
|
|
|
#else
|
2018-10-31 10:54:12 +08:00
|
|
|
extern rt_size_t syslog_formater(char *log_buf, rt_uint8_t level, const char *tag, rt_bool_t newline, const char *format, va_list args);
|
|
|
|
log_len = syslog_formater(log_buf, level, tag, newline, format, args);
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif /* ULOG_USING_SYSLOG */
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
|
|
|
/* keyword filter */
|
|
|
|
if (ulog.filter.keyword[0] != '\0')
|
|
|
|
{
|
|
|
|
/* add string end sign */
|
|
|
|
log_buf[log_len] = '\0';
|
|
|
|
/* find the keyword */
|
|
|
|
if (!rt_strstr(log_buf, ulog.filter.keyword))
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
ulog_voutput_recursion = RT_FALSE;
|
2018-10-30 09:00:30 +08:00
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_FILTER */
|
|
|
|
/* do log output */
|
|
|
|
do_output(level, tag, RT_FALSE, log_buf, log_len);
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
ulog_voutput_recursion = RT_FALSE;
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* output the log
|
|
|
|
*
|
|
|
|
* @param level level
|
|
|
|
* @param tag tag
|
2018-10-31 10:54:12 +08:00
|
|
|
* @param newline has newline
|
2018-10-30 09:00:30 +08:00
|
|
|
* @param format output format
|
|
|
|
* @param ... args
|
|
|
|
*/
|
2018-10-31 10:54:12 +08:00
|
|
|
void ulog_output(rt_uint32_t level, const char *tag, rt_bool_t newline, const char *format, ...)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
va_list args;
|
|
|
|
|
|
|
|
/* args point to the first variable parameter */
|
|
|
|
va_start(args, format);
|
|
|
|
|
2018-10-31 10:54:12 +08:00
|
|
|
ulog_voutput(level, tag, newline, format, args);
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
va_end(args);
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* output RAW string format log
|
|
|
|
*
|
|
|
|
* @param format output format
|
|
|
|
* @param ... args
|
|
|
|
*/
|
|
|
|
void ulog_raw(const char *format, ...)
|
|
|
|
{
|
|
|
|
rt_size_t log_len = 0;
|
2022-03-21 14:06:17 +08:00
|
|
|
char *log_buf = RT_NULL;
|
2018-10-30 09:00:30 +08:00
|
|
|
va_list args;
|
|
|
|
int fmt_result;
|
|
|
|
|
|
|
|
RT_ASSERT(ulog.init_ok);
|
|
|
|
|
2021-02-01 11:22:05 +08:00
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
2022-03-21 14:06:17 +08:00
|
|
|
if (ulog.async_rb == RT_NULL)
|
2021-02-01 11:22:05 +08:00
|
|
|
{
|
|
|
|
ulog.async_rb = rt_ringbuffer_create(ULOG_ASYNC_OUTPUT_BUF_SIZE);
|
|
|
|
}
|
|
|
|
#endif
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/* get log buffer */
|
|
|
|
log_buf = get_log_buf();
|
|
|
|
|
|
|
|
/* lock output */
|
|
|
|
output_lock();
|
2022-03-07 01:14:22 +08:00
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/* args point to the first variable parameter */
|
|
|
|
va_start(args, format);
|
|
|
|
fmt_result = rt_vsnprintf(log_buf, ULOG_LINE_BUF_SIZE, format, args);
|
|
|
|
va_end(args);
|
|
|
|
|
|
|
|
/* calculate log length */
|
|
|
|
if ((fmt_result > -1) && (fmt_result <= ULOG_LINE_BUF_SIZE))
|
|
|
|
{
|
|
|
|
log_len = fmt_result;
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
log_len = ULOG_LINE_BUF_SIZE;
|
|
|
|
}
|
|
|
|
|
|
|
|
/* do log output */
|
2022-04-05 17:48:06 +08:00
|
|
|
do_output(LOG_LVL_DBG, "", RT_TRUE, log_buf, log_len);
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* dump the hex format data to log
|
|
|
|
*
|
2018-11-08 11:23:03 +08:00
|
|
|
* @param tag name for hex object, it will show on log header
|
2018-10-30 09:00:30 +08:00
|
|
|
* @param width hex number for every line, such as: 16, 32
|
|
|
|
* @param buf hex buffer
|
|
|
|
* @param size buffer size
|
|
|
|
*/
|
2018-11-08 11:23:03 +08:00
|
|
|
void ulog_hexdump(const char *tag, rt_size_t width, rt_uint8_t *buf, rt_size_t size)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
#define __is_print(ch) ((unsigned int)((ch) - ' ') < 127u - ' ')
|
|
|
|
|
|
|
|
rt_size_t i, j;
|
2018-11-08 11:23:03 +08:00
|
|
|
rt_size_t log_len = 0, name_len = rt_strlen(tag);
|
2021-03-02 12:11:19 +08:00
|
|
|
#ifdef ULOG_OUTPUT_TIME
|
|
|
|
rt_size_t time_head_len = 0;
|
|
|
|
#endif
|
2022-03-21 14:06:17 +08:00
|
|
|
char *log_buf = RT_NULL, dump_string[8];
|
2018-10-30 09:00:30 +08:00
|
|
|
int fmt_result;
|
|
|
|
|
|
|
|
RT_ASSERT(ulog.init_ok);
|
|
|
|
|
2018-11-01 19:39:08 +08:00
|
|
|
#ifdef ULOG_USING_FILTER
|
|
|
|
/* level filter */
|
|
|
|
#ifndef ULOG_USING_SYSLOG
|
2018-11-08 11:23:03 +08:00
|
|
|
if (LOG_LVL_DBG > ulog.filter.level || LOG_LVL_DBG > ulog_tag_lvl_filter_get(tag))
|
2018-11-01 19:39:08 +08:00
|
|
|
{
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
#else
|
|
|
|
if ((LOG_MASK(LOG_DEBUG) & ulog.filter.level) == 0)
|
|
|
|
{
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_SYSLOG */
|
2018-11-08 11:23:03 +08:00
|
|
|
else if (!rt_strstr(tag, ulog.filter.tag))
|
|
|
|
{
|
|
|
|
/* tag filter */
|
|
|
|
return;
|
|
|
|
}
|
2018-11-01 19:39:08 +08:00
|
|
|
#endif /* ULOG_USING_FILTER */
|
|
|
|
|
2022-03-26 21:58:49 +08:00
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
if (ulog.async_rb == RT_NULL)
|
|
|
|
{
|
|
|
|
ulog.async_rb = rt_ringbuffer_create(ULOG_ASYNC_OUTPUT_BUF_SIZE);
|
|
|
|
}
|
|
|
|
#endif
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/* get log buffer */
|
|
|
|
log_buf = get_log_buf();
|
|
|
|
|
|
|
|
/* lock output */
|
|
|
|
output_lock();
|
|
|
|
|
|
|
|
for (i = 0, log_len = 0; i < size; i += width)
|
|
|
|
{
|
|
|
|
/* package header */
|
2018-11-01 19:39:08 +08:00
|
|
|
if (i == 0)
|
|
|
|
{
|
2021-03-02 12:11:19 +08:00
|
|
|
#ifdef ULOG_OUTPUT_TIME
|
|
|
|
/* add time info */
|
|
|
|
#ifdef ULOG_TIME_USING_TIMESTAMP
|
|
|
|
static time_t now;
|
|
|
|
static struct tm *tm, tm_tmp;
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
now = time(RT_NULL);
|
2021-03-02 12:11:19 +08:00
|
|
|
tm = gmtime_r(&now, &tm_tmp);
|
|
|
|
|
|
|
|
#ifdef RT_USING_SOFT_RTC
|
|
|
|
rt_snprintf(log_buf + log_len, ULOG_LINE_BUF_SIZE - log_len, "%02d-%02d %02d:%02d:%02d.%03d ", tm->tm_mon + 1,
|
|
|
|
tm->tm_mday, tm->tm_hour, tm->tm_min, tm->tm_sec, rt_tick_get() % 1000);
|
|
|
|
#else
|
|
|
|
rt_snprintf(log_buf + log_len, ULOG_LINE_BUF_SIZE - log_len, "%02d-%02d %02d:%02d:%02d ", tm->tm_mon + 1,
|
|
|
|
tm->tm_mday, tm->tm_hour, tm->tm_min, tm->tm_sec);
|
|
|
|
#endif /* RT_USING_SOFT_RTC */
|
|
|
|
|
|
|
|
#else
|
|
|
|
static rt_size_t tick_len = 0;
|
|
|
|
|
|
|
|
log_buf[log_len] = '[';
|
|
|
|
tick_len = ulog_ultoa(log_buf + log_len + 1, rt_tick_get());
|
|
|
|
log_buf[log_len + 1 + tick_len] = ']';
|
|
|
|
log_buf[log_len + 2 + tick_len] = ' ';
|
|
|
|
log_buf[log_len + 3 + tick_len] = '\0';
|
|
|
|
#endif /* ULOG_TIME_USING_TIMESTAMP */
|
|
|
|
time_head_len = rt_strlen(log_buf + log_len);
|
|
|
|
log_len += time_head_len;
|
|
|
|
#endif /* ULOG_OUTPUT_TIME */
|
2018-11-01 19:39:08 +08:00
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, "D/HEX ");
|
2018-11-08 11:23:03 +08:00
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, tag);
|
2018-11-01 19:39:08 +08:00
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, ": ");
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
log_len = 6 + name_len + 2;
|
2021-03-02 12:11:19 +08:00
|
|
|
#ifdef ULOG_OUTPUT_TIME
|
|
|
|
log_len += time_head_len;
|
|
|
|
#endif
|
2018-11-01 19:39:08 +08:00
|
|
|
rt_memset(log_buf, ' ', log_len);
|
|
|
|
}
|
2019-08-03 16:52:37 +08:00
|
|
|
fmt_result = rt_snprintf(log_buf + log_len, ULOG_LINE_BUF_SIZE, "%04X-%04X: ", i, i + width - 1);
|
2018-10-30 09:00:30 +08:00
|
|
|
/* calculate log length */
|
|
|
|
if ((fmt_result > -1) && (fmt_result <= ULOG_LINE_BUF_SIZE))
|
|
|
|
{
|
2018-11-01 19:39:08 +08:00
|
|
|
log_len += fmt_result;
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
log_len = ULOG_LINE_BUF_SIZE;
|
|
|
|
}
|
|
|
|
/* dump hex */
|
|
|
|
for (j = 0; j < width; j++)
|
|
|
|
{
|
|
|
|
if (i + j < size)
|
|
|
|
{
|
|
|
|
rt_snprintf(dump_string, sizeof(dump_string), "%02X ", buf[i + j]);
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_strncpy(dump_string, " ", sizeof(dump_string));
|
|
|
|
}
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, dump_string);
|
|
|
|
if ((j + 1) % 8 == 0)
|
|
|
|
{
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, " ");
|
|
|
|
}
|
|
|
|
}
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, " ");
|
|
|
|
/* dump char for hex */
|
|
|
|
for (j = 0; j < width; j++)
|
|
|
|
{
|
|
|
|
if (i + j < size)
|
|
|
|
{
|
|
|
|
rt_snprintf(dump_string, sizeof(dump_string), "%c", __is_print(buf[i + j]) ? buf[i + j] : '.');
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, dump_string);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
/* overflow check and reserve some space for newline sign */
|
|
|
|
if (log_len + rt_strlen(ULOG_NEWLINE_SIGN) > ULOG_LINE_BUF_SIZE)
|
|
|
|
{
|
|
|
|
log_len = ULOG_LINE_BUF_SIZE - rt_strlen(ULOG_NEWLINE_SIGN);
|
|
|
|
}
|
|
|
|
/* package newline sign */
|
|
|
|
log_len += ulog_strcpy(log_len, log_buf + log_len, ULOG_NEWLINE_SIGN);
|
2019-12-21 00:17:38 +08:00
|
|
|
/*add string end sign*/
|
|
|
|
log_buf[log_len] = '\0';
|
2018-10-30 09:00:30 +08:00
|
|
|
/* do log output */
|
2022-03-21 14:06:17 +08:00
|
|
|
do_output(LOG_LVL_DBG, RT_NULL, RT_TRUE, log_buf, log_len);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
}
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
2021-01-20 11:20:30 +08:00
|
|
|
/**
|
|
|
|
* Set the filter's level by different backend.
|
|
|
|
* The log on this backend which level is less than it will stop output.
|
|
|
|
*
|
|
|
|
* @param be_name backend name
|
|
|
|
* @param level The filter level. When the level is LOG_FILTER_LVL_SILENT, the log enter silent mode.
|
|
|
|
* When the level is LOG_FILTER_LVL_ALL, it will remove this tag's level filer.
|
|
|
|
* Then all level log will resume output.
|
|
|
|
*
|
|
|
|
* @return 0 : success
|
|
|
|
* -10: level is out of range
|
|
|
|
*/
|
|
|
|
int ulog_be_lvl_filter_set(const char *be_name, rt_uint32_t level)
|
|
|
|
{
|
|
|
|
rt_slist_t *node = RT_NULL;
|
|
|
|
ulog_backend_t backend;
|
|
|
|
int result = RT_EOK;
|
|
|
|
|
|
|
|
if (level > LOG_FILTER_LVL_ALL)
|
|
|
|
return -RT_EINVAL;
|
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
return result;
|
|
|
|
|
|
|
|
for (node = rt_slist_first(&ulog.backend_list); node; node = rt_slist_next(node))
|
|
|
|
{
|
|
|
|
backend = rt_slist_entry(node, struct ulog_backend, list);
|
|
|
|
if (rt_strncmp(backend->name, be_name, RT_NAME_MAX) == 0)
|
|
|
|
{
|
|
|
|
backend->out_level = level;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
return result;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/**
|
|
|
|
* Set the filter's level by different tag.
|
|
|
|
* The log on this tag which level is less than it will stop output.
|
|
|
|
*
|
|
|
|
* example:
|
|
|
|
* // the example tag log enter silent mode
|
|
|
|
* ulog_set_filter_lvl("example", LOG_FILTER_LVL_SILENT);
|
|
|
|
* // the example tag log which level is less than INFO level will stop output
|
|
|
|
* ulog_set_filter_lvl("example", LOG_LVL_INFO);
|
|
|
|
* // remove example tag's level filter, all level log will resume output
|
|
|
|
* ulog_set_filter_lvl("example", LOG_FILTER_LVL_ALL);
|
|
|
|
*
|
|
|
|
* @param tag log tag
|
|
|
|
* @param level The filter level. When the level is LOG_FILTER_LVL_SILENT, the log enter silent mode.
|
|
|
|
* When the level is LOG_FILTER_LVL_ALL, it will remove this tag's level filer.
|
|
|
|
* Then all level log will resume output.
|
|
|
|
*
|
2018-11-09 09:19:44 +08:00
|
|
|
* @return 0 : success
|
|
|
|
* -5 : no memory
|
|
|
|
* -10: level is out of range
|
2018-10-30 09:00:30 +08:00
|
|
|
*/
|
|
|
|
int ulog_tag_lvl_filter_set(const char *tag, rt_uint32_t level)
|
|
|
|
{
|
|
|
|
rt_slist_t *node;
|
2022-03-21 14:06:17 +08:00
|
|
|
ulog_tag_lvl_filter_t tag_lvl = RT_NULL;
|
2018-10-30 09:00:30 +08:00
|
|
|
int result = RT_EOK;
|
|
|
|
|
2018-11-10 09:49:21 +08:00
|
|
|
if (level > LOG_FILTER_LVL_ALL)
|
2018-11-09 09:19:44 +08:00
|
|
|
return -RT_EINVAL;
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
return result;
|
|
|
|
|
|
|
|
/* lock output */
|
|
|
|
output_lock();
|
|
|
|
/* find the tag in list */
|
2018-11-09 09:19:44 +08:00
|
|
|
for (node = rt_slist_first(ulog_tag_lvl_list_get()); node; node = rt_slist_next(node))
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2018-11-08 11:09:35 +08:00
|
|
|
tag_lvl = rt_slist_entry(node, struct ulog_tag_lvl_filter, list);
|
2018-10-30 09:00:30 +08:00
|
|
|
if (!rt_strncmp(tag_lvl->tag, tag, ULOG_FILTER_TAG_MAX_LEN))
|
|
|
|
{
|
|
|
|
break;
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
tag_lvl = RT_NULL;
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
}
|
|
|
|
/* find OK */
|
|
|
|
if (tag_lvl)
|
|
|
|
{
|
|
|
|
if (level == LOG_FILTER_LVL_ALL)
|
|
|
|
{
|
|
|
|
/* remove current tag's level filter when input level is the lowest level */
|
2018-11-09 09:19:44 +08:00
|
|
|
rt_slist_remove(ulog_tag_lvl_list_get(), &tag_lvl->list);
|
2018-11-08 10:59:25 +08:00
|
|
|
rt_free(tag_lvl);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
/* update level */
|
|
|
|
tag_lvl->level = level;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
/* only add the new tag's level filer when level is not LOG_FILTER_LVL_ALL */
|
|
|
|
if (level != LOG_FILTER_LVL_ALL)
|
|
|
|
{
|
|
|
|
/* new a tag's level filter */
|
2018-11-08 11:09:35 +08:00
|
|
|
tag_lvl = (ulog_tag_lvl_filter_t)rt_malloc(sizeof(struct ulog_tag_lvl_filter));
|
2018-10-30 09:00:30 +08:00
|
|
|
if (tag_lvl)
|
|
|
|
{
|
|
|
|
rt_memset(tag_lvl->tag, 0 , sizeof(tag_lvl->tag));
|
|
|
|
rt_strncpy(tag_lvl->tag, tag, ULOG_FILTER_TAG_MAX_LEN);
|
|
|
|
tag_lvl->level = level;
|
2018-11-09 09:19:44 +08:00
|
|
|
rt_slist_append(ulog_tag_lvl_list_get(), &tag_lvl->list);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
result = -RT_ENOMEM;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
}
|
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
|
|
|
|
return result;
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* get the level on tag's level filer
|
|
|
|
*
|
|
|
|
* @param tag log tag
|
|
|
|
*
|
|
|
|
* @return It will return the lowest level when tag was not found.
|
|
|
|
* Other level will return when tag was found.
|
|
|
|
*/
|
|
|
|
rt_uint32_t ulog_tag_lvl_filter_get(const char *tag)
|
|
|
|
{
|
|
|
|
rt_slist_t *node;
|
2022-03-21 14:06:17 +08:00
|
|
|
ulog_tag_lvl_filter_t tag_lvl = RT_NULL;
|
2018-10-30 09:00:30 +08:00
|
|
|
rt_uint32_t level = LOG_FILTER_LVL_ALL;
|
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
return level;
|
|
|
|
|
|
|
|
/* lock output */
|
|
|
|
output_lock();
|
|
|
|
/* find the tag in list */
|
2018-11-09 09:19:44 +08:00
|
|
|
for (node = rt_slist_first(ulog_tag_lvl_list_get()); node; node = rt_slist_next(node))
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2018-11-08 11:09:35 +08:00
|
|
|
tag_lvl = rt_slist_entry(node, struct ulog_tag_lvl_filter, list);
|
2018-10-30 09:00:30 +08:00
|
|
|
if (!rt_strncmp(tag_lvl->tag, tag, ULOG_FILTER_TAG_MAX_LEN))
|
|
|
|
{
|
|
|
|
level = tag_lvl->level;
|
|
|
|
break;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
|
|
|
|
return level;
|
|
|
|
}
|
|
|
|
|
2018-11-08 11:09:35 +08:00
|
|
|
/**
|
|
|
|
* get the tag's level list on filter
|
|
|
|
*
|
|
|
|
* @return tag's level list
|
|
|
|
*/
|
|
|
|
rt_slist_t *ulog_tag_lvl_list_get(void)
|
|
|
|
{
|
|
|
|
return &ulog.filter.tag_lvl_list;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/**
|
|
|
|
* set log global filter level
|
|
|
|
*
|
|
|
|
* @param level log level: LOG_LVL_ASSERT, LOG_LVL_ERROR, LOG_LVL_WARNING, LOG_LVL_INFO, LOG_LVL_DBG
|
|
|
|
* LOG_FILTER_LVL_SILENT: disable all log output, except assert level
|
|
|
|
* LOG_FILTER_LVL_ALL: enable all log output
|
|
|
|
*/
|
|
|
|
void ulog_global_filter_lvl_set(rt_uint32_t level)
|
|
|
|
{
|
|
|
|
RT_ASSERT(level <= LOG_FILTER_LVL_ALL);
|
|
|
|
|
|
|
|
ulog.filter.level = level;
|
|
|
|
}
|
|
|
|
|
2018-11-08 11:09:35 +08:00
|
|
|
/**
|
|
|
|
* get log global filter level
|
|
|
|
*
|
|
|
|
* @return log level: LOG_LVL_ASSERT, LOG_LVL_ERROR, LOG_LVL_WARNING, LOG_LVL_INFO, LOG_LVL_DBG
|
|
|
|
* LOG_FILTER_LVL_SILENT: disable all log output, except assert level
|
|
|
|
* LOG_FILTER_LVL_ALL: enable all log output
|
|
|
|
*/
|
|
|
|
rt_uint32_t ulog_global_filter_lvl_get(void)
|
|
|
|
{
|
|
|
|
return ulog.filter.level;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/**
|
|
|
|
* set log global filter tag
|
|
|
|
*
|
|
|
|
* @param tag tag
|
|
|
|
*/
|
|
|
|
void ulog_global_filter_tag_set(const char *tag)
|
|
|
|
{
|
|
|
|
RT_ASSERT(tag);
|
|
|
|
|
|
|
|
rt_strncpy(ulog.filter.tag, tag, ULOG_FILTER_TAG_MAX_LEN);
|
|
|
|
}
|
|
|
|
|
2018-11-08 11:09:35 +08:00
|
|
|
/**
|
|
|
|
* get log global filter tag
|
|
|
|
*
|
|
|
|
* @return tag
|
|
|
|
*/
|
|
|
|
const char *ulog_global_filter_tag_get(void)
|
|
|
|
{
|
|
|
|
return ulog.filter.tag;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/**
|
|
|
|
* set log global filter keyword
|
|
|
|
*
|
|
|
|
* @param keyword keyword
|
|
|
|
*/
|
|
|
|
void ulog_global_filter_kw_set(const char *keyword)
|
|
|
|
{
|
|
|
|
RT_ASSERT(keyword);
|
|
|
|
|
|
|
|
rt_strncpy(ulog.filter.keyword, keyword, ULOG_FILTER_KW_MAX_LEN);
|
|
|
|
}
|
|
|
|
|
2018-11-08 11:09:35 +08:00
|
|
|
/**
|
|
|
|
* get log global filter keyword
|
|
|
|
*
|
|
|
|
* @return keyword
|
|
|
|
*/
|
|
|
|
const char *ulog_global_filter_kw_get(void)
|
|
|
|
{
|
|
|
|
return ulog.filter.keyword;
|
|
|
|
}
|
|
|
|
|
2021-09-09 17:02:21 +08:00
|
|
|
#ifdef RT_USING_FINSH
|
2018-10-30 09:00:30 +08:00
|
|
|
#include <finsh.h>
|
|
|
|
|
2021-01-20 11:20:30 +08:00
|
|
|
static void _print_lvl_info(void)
|
|
|
|
{
|
|
|
|
#ifndef ULOG_USING_SYSLOG
|
|
|
|
rt_kprintf("Assert : 0\n");
|
|
|
|
rt_kprintf("Error : 3\n");
|
|
|
|
rt_kprintf("Warning : 4\n");
|
|
|
|
rt_kprintf("Info : 6\n");
|
|
|
|
rt_kprintf("Debug : 7\n");
|
|
|
|
#else
|
|
|
|
rt_kprintf("EMERG : 1 (1 << 0)\n");
|
|
|
|
rt_kprintf("ALERT : 2 (1 << 1)\n");
|
|
|
|
rt_kprintf("CRIT : 4 (1 << 2)\n");
|
|
|
|
rt_kprintf("ERR : 8 (1 << 3)\n");
|
|
|
|
rt_kprintf("WARNING : 16 (1 << 4)\n");
|
|
|
|
rt_kprintf("NOTICE : 32 (1 << 5)\n");
|
|
|
|
rt_kprintf("INFO : 64 (1 << 6)\n");
|
|
|
|
rt_kprintf("DEBUG : 128 (1 << 7)\n");
|
|
|
|
#endif /* ULOG_USING_SYSLOG */
|
|
|
|
}
|
|
|
|
|
|
|
|
static void ulog_be_lvl(uint8_t argc, char **argv)
|
|
|
|
{
|
|
|
|
if (argc > 2)
|
|
|
|
{
|
|
|
|
if ((atoi(argv[2]) <= LOG_FILTER_LVL_ALL) && (atoi(argv[2]) >= 0))
|
|
|
|
{
|
|
|
|
ulog_be_lvl_filter_set(argv[1], atoi(argv[2]));
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("Please input correct level (0-%d).\n", LOG_FILTER_LVL_ALL);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("Please input: ulog_be_lvl <be_name> <level>.\n");
|
|
|
|
_print_lvl_info();
|
|
|
|
}
|
|
|
|
}
|
|
|
|
MSH_CMD_EXPORT(ulog_be_lvl, Set ulog filter level by different backend.);
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
static void ulog_tag_lvl(uint8_t argc, char **argv)
|
|
|
|
{
|
|
|
|
if (argc > 2)
|
|
|
|
{
|
|
|
|
if ((atoi(argv[2]) <= LOG_FILTER_LVL_ALL) && (atoi(argv[2]) >= 0))
|
|
|
|
{
|
|
|
|
ulog_tag_lvl_filter_set(argv[1], atoi(argv[2]));
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("Please input correct level (0-%d).\n", LOG_FILTER_LVL_ALL);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("Please input: ulog_tag_lvl <tag> <level>.\n");
|
2021-01-20 11:20:30 +08:00
|
|
|
_print_lvl_info();
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
}
|
|
|
|
MSH_CMD_EXPORT(ulog_tag_lvl, Set ulog filter level by different tag.);
|
|
|
|
|
|
|
|
static void ulog_lvl(uint8_t argc, char **argv)
|
|
|
|
{
|
|
|
|
if (argc > 1)
|
|
|
|
{
|
|
|
|
if ((atoi(argv[1]) <= LOG_FILTER_LVL_ALL) && (atoi(argv[1]) >= 0))
|
|
|
|
{
|
|
|
|
ulog_global_filter_lvl_set(atoi(argv[1]));
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("Please input correct level (0-%d).\n", LOG_FILTER_LVL_ALL);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("Please input: ulog_lvl <level>.\n");
|
2021-01-20 11:20:30 +08:00
|
|
|
_print_lvl_info();
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
}
|
|
|
|
MSH_CMD_EXPORT(ulog_lvl, Set ulog global filter level.);
|
|
|
|
|
|
|
|
static void ulog_tag(uint8_t argc, char **argv)
|
|
|
|
{
|
|
|
|
if (argc > 1)
|
|
|
|
{
|
|
|
|
if (rt_strlen(argv[1]) <= ULOG_FILTER_TAG_MAX_LEN)
|
|
|
|
{
|
|
|
|
ulog_global_filter_tag_set(argv[1]);
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("The tag length is too long. Max is %d.\n", ULOG_FILTER_TAG_MAX_LEN);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
ulog_global_filter_tag_set("");
|
|
|
|
}
|
|
|
|
}
|
|
|
|
MSH_CMD_EXPORT(ulog_tag, Set ulog global filter tag);
|
|
|
|
|
|
|
|
static void ulog_kw(uint8_t argc, char **argv)
|
|
|
|
{
|
|
|
|
if (argc > 1)
|
|
|
|
{
|
|
|
|
if (rt_strlen(argv[1]) <= ULOG_FILTER_KW_MAX_LEN)
|
|
|
|
{
|
|
|
|
ulog_global_filter_kw_set(argv[1]);
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
rt_kprintf("The keyword length is too long. Max is %d.\n", ULOG_FILTER_KW_MAX_LEN);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
ulog_global_filter_kw_set("");
|
|
|
|
}
|
|
|
|
}
|
|
|
|
MSH_CMD_EXPORT(ulog_kw, Set ulog global filter keyword);
|
2018-11-08 11:22:02 +08:00
|
|
|
|
|
|
|
static void ulog_filter(uint8_t argc, char **argv)
|
|
|
|
{
|
|
|
|
#ifndef ULOG_USING_SYSLOG
|
|
|
|
const char *lvl_name[] = { "Assert ", "Error ", "Error ", "Error ", "Warning", "Info ", "Info ", "Debug " };
|
|
|
|
#endif
|
|
|
|
const char *tag = ulog_global_filter_tag_get(), *kw = ulog_global_filter_kw_get();
|
|
|
|
rt_slist_t *node;
|
2022-03-21 14:06:17 +08:00
|
|
|
ulog_tag_lvl_filter_t tag_lvl = RT_NULL;
|
2018-11-08 11:22:02 +08:00
|
|
|
|
|
|
|
rt_kprintf("--------------------------------------\n");
|
|
|
|
rt_kprintf("ulog global filter:\n");
|
|
|
|
|
|
|
|
#ifndef ULOG_USING_SYSLOG
|
|
|
|
rt_kprintf("level : %s\n", lvl_name[ulog_global_filter_lvl_get()]);
|
|
|
|
#else
|
|
|
|
rt_kprintf("level : %d\n", ulog_global_filter_lvl_get());
|
|
|
|
#endif
|
|
|
|
|
|
|
|
rt_kprintf("tag : %s\n", rt_strlen(tag) == 0 ? "NULL" : tag);
|
|
|
|
rt_kprintf("keyword : %s\n", rt_strlen(kw) == 0 ? "NULL" : kw);
|
|
|
|
|
|
|
|
rt_kprintf("--------------------------------------\n");
|
|
|
|
rt_kprintf("ulog tag's level filter:\n");
|
|
|
|
if (rt_slist_isempty(ulog_tag_lvl_list_get()))
|
|
|
|
{
|
|
|
|
rt_kprintf("settings not found\n");
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
/* lock output */
|
|
|
|
output_lock();
|
2018-11-09 09:19:44 +08:00
|
|
|
/* show the tag level list */
|
2018-11-08 11:22:02 +08:00
|
|
|
for (node = rt_slist_first(ulog_tag_lvl_list_get()); node; node = rt_slist_next(node))
|
|
|
|
{
|
|
|
|
tag_lvl = rt_slist_entry(node, struct ulog_tag_lvl_filter, list);
|
|
|
|
rt_kprintf("%-*.s: ", ULOG_FILTER_TAG_MAX_LEN, tag_lvl->tag);
|
|
|
|
|
|
|
|
#ifndef ULOG_USING_SYSLOG
|
|
|
|
rt_kprintf("%s\n", lvl_name[tag_lvl->level]);
|
|
|
|
#else
|
|
|
|
rt_kprintf("%d\n", tag_lvl->level);
|
|
|
|
#endif
|
|
|
|
|
|
|
|
}
|
|
|
|
/* unlock output */
|
|
|
|
output_unlock();
|
|
|
|
}
|
|
|
|
}
|
|
|
|
MSH_CMD_EXPORT(ulog_filter, Show ulog filter settings);
|
2021-10-08 10:03:01 +08:00
|
|
|
#endif /* RT_USING_FINSH */
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif /* ULOG_USING_FILTER */
|
|
|
|
|
|
|
|
rt_err_t ulog_backend_register(ulog_backend_t backend, const char *name, rt_bool_t support_color)
|
|
|
|
{
|
|
|
|
rt_base_t level;
|
|
|
|
|
|
|
|
RT_ASSERT(backend);
|
|
|
|
RT_ASSERT(name);
|
|
|
|
RT_ASSERT(ulog.init_ok);
|
|
|
|
RT_ASSERT(backend->output);
|
|
|
|
|
|
|
|
if (backend->init)
|
|
|
|
{
|
|
|
|
backend->init(backend);
|
|
|
|
}
|
|
|
|
|
|
|
|
backend->support_color = support_color;
|
2021-01-20 11:20:30 +08:00
|
|
|
backend->out_level = LOG_FILTER_LVL_ALL;
|
2021-02-01 11:22:05 +08:00
|
|
|
rt_strncpy(backend->name, name, RT_NAME_MAX);
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
level = rt_hw_interrupt_disable();
|
|
|
|
rt_slist_append(&ulog.backend_list, &backend->list);
|
|
|
|
rt_hw_interrupt_enable(level);
|
|
|
|
|
|
|
|
return RT_EOK;
|
|
|
|
}
|
|
|
|
|
|
|
|
rt_err_t ulog_backend_unregister(ulog_backend_t backend)
|
|
|
|
{
|
|
|
|
rt_base_t level;
|
|
|
|
|
|
|
|
RT_ASSERT(backend);
|
|
|
|
RT_ASSERT(ulog.init_ok);
|
|
|
|
|
2018-11-01 14:51:50 +08:00
|
|
|
if (backend->deinit)
|
|
|
|
{
|
|
|
|
backend->deinit(backend);
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
level = rt_hw_interrupt_disable();
|
|
|
|
rt_slist_remove(&ulog.backend_list, &backend->list);
|
|
|
|
rt_hw_interrupt_enable(level);
|
|
|
|
|
|
|
|
return RT_EOK;
|
|
|
|
}
|
|
|
|
|
2021-12-03 12:04:20 +08:00
|
|
|
rt_err_t ulog_backend_set_filter(ulog_backend_t backend, ulog_backend_filter_t filter)
|
|
|
|
{
|
|
|
|
rt_base_t level;
|
|
|
|
RT_ASSERT(backend);
|
|
|
|
|
|
|
|
level = rt_hw_interrupt_disable();
|
|
|
|
backend->filter = filter;
|
|
|
|
rt_hw_interrupt_enable(level);
|
|
|
|
|
|
|
|
return RT_EOK;
|
|
|
|
}
|
|
|
|
|
|
|
|
ulog_backend_t ulog_backend_find(const char *name)
|
|
|
|
{
|
|
|
|
rt_base_t level;
|
|
|
|
rt_slist_t *node;
|
|
|
|
ulog_backend_t backend;
|
|
|
|
|
|
|
|
RT_ASSERT(ulog.init_ok);
|
|
|
|
|
|
|
|
level = rt_hw_interrupt_disable();
|
|
|
|
for (node = rt_slist_first(&ulog.backend_list); node; node = rt_slist_next(node))
|
|
|
|
{
|
|
|
|
backend = rt_slist_entry(node, struct ulog_backend, list);
|
|
|
|
if (rt_strncmp(backend->name, name, RT_NAME_MAX) == 0)
|
|
|
|
{
|
|
|
|
rt_hw_interrupt_enable(level);
|
|
|
|
return backend;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
rt_hw_interrupt_enable(level);
|
|
|
|
return RT_NULL;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
/**
|
|
|
|
* asynchronous output logs to all backends
|
|
|
|
*
|
|
|
|
* @note you must call this function when ULOG_ASYNC_OUTPUT_BY_THREAD is disable
|
|
|
|
*/
|
|
|
|
void ulog_async_output(void)
|
|
|
|
{
|
|
|
|
rt_rbb_blk_t log_blk;
|
|
|
|
ulog_frame_t log_frame;
|
|
|
|
|
2021-01-20 11:20:30 +08:00
|
|
|
if (!ulog.async_enabled)
|
|
|
|
{
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
while ((log_blk = rt_rbb_blk_get(ulog.async_rbb)) != RT_NULL)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
log_frame = (ulog_frame_t) log_blk->buf;
|
|
|
|
if (log_frame->magic == ULOG_FRAME_MAGIC)
|
|
|
|
{
|
|
|
|
/* output to all backends */
|
|
|
|
ulog_output_to_all_backend(log_frame->level, log_frame->tag, log_frame->is_raw, log_frame->log,
|
|
|
|
log_frame->log_len);
|
|
|
|
}
|
|
|
|
rt_rbb_blk_free(ulog.async_rbb, log_blk);
|
|
|
|
}
|
2021-02-01 11:22:05 +08:00
|
|
|
/* output the log_raw format log */
|
|
|
|
if (ulog.async_rb)
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_size_t log_len = rt_ringbuffer_data_len(ulog.async_rb);
|
2022-04-05 17:48:06 +08:00
|
|
|
char *log = rt_malloc(log_len + 1);
|
2021-02-01 11:22:05 +08:00
|
|
|
if (log)
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_size_t len = rt_ringbuffer_get(ulog.async_rb, (rt_uint8_t *)log, log_len);
|
2022-04-05 17:48:06 +08:00
|
|
|
log[log_len] = '\0';
|
|
|
|
ulog_output_to_all_backend(LOG_LVL_DBG, "", RT_TRUE, log, len);
|
2021-02-01 11:22:05 +08:00
|
|
|
rt_free(log);
|
|
|
|
}
|
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
|
2021-01-20 11:20:30 +08:00
|
|
|
/**
|
|
|
|
* enable or disable asynchronous output mode
|
|
|
|
* the log will be output directly when mode is disabled
|
|
|
|
*
|
|
|
|
* @param enabled RT_TRUE: enabled, RT_FALSE: disabled
|
|
|
|
*/
|
|
|
|
void ulog_async_output_enabled(rt_bool_t enabled)
|
|
|
|
{
|
|
|
|
ulog.async_enabled = enabled;
|
|
|
|
}
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
/**
|
|
|
|
* waiting for get asynchronous output log
|
|
|
|
*
|
|
|
|
* @param time the waiting time
|
2022-04-05 17:48:06 +08:00
|
|
|
*
|
|
|
|
* @return the operation status, RT_EOK on successful
|
2018-10-30 09:00:30 +08:00
|
|
|
*/
|
2022-04-05 17:48:06 +08:00
|
|
|
rt_err_t ulog_async_waiting_log(rt_int32_t time)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
rt_sem_control(&ulog.async_notice, RT_IPC_CMD_RESET, RT_NULL);
|
2022-04-05 17:48:06 +08:00
|
|
|
return rt_sem_take(&ulog.async_notice, time);
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
|
|
|
|
static void async_output_thread_entry(void *param)
|
|
|
|
{
|
2019-05-16 09:53:56 +08:00
|
|
|
ulog_async_output();
|
|
|
|
|
2018-10-30 09:00:30 +08:00
|
|
|
while (1)
|
|
|
|
{
|
|
|
|
ulog_async_waiting_log(RT_WAITING_FOREVER);
|
2022-04-05 17:48:06 +08:00
|
|
|
while (1)
|
|
|
|
{
|
|
|
|
ulog_async_output();
|
|
|
|
/* If there is no log output for a certain period of time,
|
|
|
|
* refresh the log buffer
|
|
|
|
*/
|
|
|
|
if (ulog_async_waiting_log(RT_TICK_PER_SECOND * 2) == RT_EOK)
|
|
|
|
{
|
|
|
|
continue;
|
|
|
|
}
|
|
|
|
else
|
|
|
|
{
|
|
|
|
ulog_flush();
|
|
|
|
break;
|
|
|
|
}
|
|
|
|
}
|
2018-10-30 09:00:30 +08:00
|
|
|
}
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_ASYNC_OUTPUT */
|
|
|
|
|
|
|
|
/**
|
|
|
|
* flush all backends's log
|
|
|
|
*/
|
|
|
|
void ulog_flush(void)
|
|
|
|
{
|
|
|
|
rt_slist_t *node;
|
|
|
|
ulog_backend_t backend;
|
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
return;
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
ulog_async_output();
|
|
|
|
#endif
|
|
|
|
|
|
|
|
/* flush all backends */
|
|
|
|
for (node = rt_slist_first(&ulog.backend_list); node; node = rt_slist_next(node))
|
|
|
|
{
|
|
|
|
backend = rt_slist_entry(node, struct ulog_backend, list);
|
|
|
|
if (backend->flush)
|
|
|
|
{
|
|
|
|
backend->flush(backend);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
int ulog_init(void)
|
|
|
|
{
|
|
|
|
if (ulog.init_ok)
|
|
|
|
return 0;
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_mutex_init(&ulog.output_locker, "ulog", RT_IPC_FLAG_PRIO);
|
2021-05-19 18:17:37 +08:00
|
|
|
ulog.output_lock_enabled = RT_TRUE;
|
2018-10-30 09:00:30 +08:00
|
|
|
rt_slist_init(&ulog.backend_list);
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
2018-11-09 09:19:44 +08:00
|
|
|
rt_slist_init(ulog_tag_lvl_list_get());
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
RT_ASSERT(ULOG_ASYNC_OUTPUT_STORE_LINES >= 2);
|
2021-01-20 11:20:30 +08:00
|
|
|
ulog.async_enabled = RT_TRUE;
|
2018-10-30 09:00:30 +08:00
|
|
|
/* async output ring block buffer */
|
|
|
|
ulog.async_rbb = rt_rbb_create(RT_ALIGN(ULOG_ASYNC_OUTPUT_BUF_SIZE, RT_ALIGN_SIZE), ULOG_ASYNC_OUTPUT_STORE_LINES);
|
2022-03-21 14:06:17 +08:00
|
|
|
if (ulog.async_rbb == RT_NULL)
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
|
|
|
rt_kprintf("Error: ulog init failed! No memory for async rbb.\n");
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_mutex_detach(&ulog.output_locker);
|
2018-10-30 09:00:30 +08:00
|
|
|
return -RT_ENOMEM;
|
|
|
|
}
|
|
|
|
rt_sem_init(&ulog.async_notice, "ulog", 0, RT_IPC_FLAG_FIFO);
|
|
|
|
#endif /* ULOG_USING_ASYNC_OUTPUT */
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
|
|
|
ulog_global_filter_lvl_set(LOG_FILTER_LVL_ALL);
|
|
|
|
#endif
|
|
|
|
|
|
|
|
ulog.init_ok = RT_TRUE;
|
|
|
|
|
|
|
|
return 0;
|
|
|
|
}
|
2021-01-20 11:20:30 +08:00
|
|
|
INIT_BOARD_EXPORT(ulog_init);
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
int ulog_async_init(void)
|
|
|
|
{
|
2022-03-21 14:06:17 +08:00
|
|
|
if (ulog.async_th == RT_NULL)
|
2021-01-20 11:20:30 +08:00
|
|
|
{
|
|
|
|
/* async output thread */
|
|
|
|
ulog.async_th = rt_thread_create("ulog_async", async_output_thread_entry, &ulog, ULOG_ASYNC_OUTPUT_THREAD_STACK,
|
|
|
|
ULOG_ASYNC_OUTPUT_THREAD_PRIORITY, 20);
|
2022-03-21 14:06:17 +08:00
|
|
|
if (ulog.async_th == RT_NULL)
|
2021-01-20 11:20:30 +08:00
|
|
|
{
|
|
|
|
rt_kprintf("Error: ulog init failed! No memory for async output thread.\n");
|
|
|
|
return -RT_ENOMEM;
|
|
|
|
}
|
|
|
|
/* async output thread startup */
|
|
|
|
rt_thread_startup(ulog.async_th);
|
|
|
|
}
|
|
|
|
return 0;
|
|
|
|
}
|
|
|
|
INIT_PREV_EXPORT(ulog_async_init);
|
|
|
|
#endif /* ULOG_USING_ASYNC_OUTPUT */
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
void ulog_deinit(void)
|
|
|
|
{
|
|
|
|
rt_slist_t *node;
|
|
|
|
ulog_backend_t backend;
|
|
|
|
|
|
|
|
if (!ulog.init_ok)
|
|
|
|
return;
|
|
|
|
|
|
|
|
/* deinit all backends */
|
|
|
|
for (node = rt_slist_first(&ulog.backend_list); node; node = rt_slist_next(node))
|
|
|
|
{
|
|
|
|
backend = rt_slist_entry(node, struct ulog_backend, list);
|
|
|
|
if (backend->deinit)
|
|
|
|
{
|
|
|
|
backend->deinit(backend);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
#ifdef ULOG_USING_FILTER
|
|
|
|
/* deinit tag's level filter */
|
|
|
|
{
|
2018-11-08 11:09:35 +08:00
|
|
|
ulog_tag_lvl_filter_t tag_lvl;
|
2018-11-09 09:19:44 +08:00
|
|
|
for (node = rt_slist_first(ulog_tag_lvl_list_get()); node; node = rt_slist_next(node))
|
2018-10-30 09:00:30 +08:00
|
|
|
{
|
2018-11-08 11:09:35 +08:00
|
|
|
tag_lvl = rt_slist_entry(node, struct ulog_tag_lvl_filter, list);
|
2018-10-30 09:00:30 +08:00
|
|
|
rt_free(tag_lvl);
|
|
|
|
}
|
|
|
|
}
|
|
|
|
#endif /* ULOG_USING_FILTER */
|
|
|
|
|
2022-03-21 14:06:17 +08:00
|
|
|
rt_mutex_detach(&ulog.output_locker);
|
2018-10-30 09:00:30 +08:00
|
|
|
|
|
|
|
#ifdef ULOG_USING_ASYNC_OUTPUT
|
|
|
|
rt_rbb_destroy(ulog.async_rbb);
|
|
|
|
rt_thread_delete(ulog.async_th);
|
2021-02-01 11:22:05 +08:00
|
|
|
if (ulog.async_rb)
|
|
|
|
rt_ringbuffer_destroy(ulog.async_rb);
|
2018-10-30 09:00:30 +08:00
|
|
|
#endif
|
|
|
|
|
|
|
|
ulog.init_ok = RT_FALSE;
|
|
|
|
}
|
|
|
|
|
|
|
|
#endif /* RT_USING_ULOG */
|