numam-spdk/lib/log/log.c
Daniel Verkamp d27b24c94b log: split internal TRACELOG macro into new header
The SPDK_TRACELOG macro depends on a CONFIG setting (DEBUG), so it
should not be part of the public API.

Create a new include/spdk_internal directory for headers that should
only be used within SPDK, not exported for public use.

Change-Id: I39b90ce57da3270e735ba32210c4b3a3468c460b
Signed-off-by: Daniel Verkamp <daniel.verkamp@intel.com>
2016-11-16 13:33:51 -07:00

405 lines
10 KiB
C

/*-
* BSD LICENSE
*
* Copyright (c) Intel Corporation.
* All rights reserved.
*
* Redistribution and use in source and binary forms, with or without
* modification, are permitted provided that the following conditions
* are met:
*
* * Redistributions of source code must retain the above copyright
* notice, this list of conditions and the following disclaimer.
* * Redistributions in binary form must reproduce the above copyright
* notice, this list of conditions and the following disclaimer in
* the documentation and/or other materials provided with the
* distribution.
* * Neither the name of Intel Corporation nor the names of its
* contributors may be used to endorse or promote products derived
* from this software without specific prior written permission.
*
* THIS SOFTWARE IS PROVIDED BY THE COPYRIGHT HOLDERS AND CONTRIBUTORS
* "AS IS" AND ANY EXPRESS OR IMPLIED WARRANTIES, INCLUDING, BUT NOT
* LIMITED TO, THE IMPLIED WARRANTIES OF MERCHANTABILITY AND FITNESS FOR
* A PARTICULAR PURPOSE ARE DISCLAIMED. IN NO EVENT SHALL THE COPYRIGHT
* OWNER OR CONTRIBUTORS BE LIABLE FOR ANY DIRECT, INDIRECT, INCIDENTAL,
* SPECIAL, EXEMPLARY, OR CONSEQUENTIAL DAMAGES (INCLUDING, BUT NOT
* LIMITED TO, PROCUREMENT OF SUBSTITUTE GOODS OR SERVICES; LOSS OF USE,
* DATA, OR PROFITS; OR BUSINESS INTERRUPTION) HOWEVER CAUSED AND ON ANY
* THEORY OF LIABILITY, WHETHER IN CONTRACT, STRICT LIABILITY, OR TORT
* (INCLUDING NEGLIGENCE OR OTHERWISE) ARISING IN ANY WAY OUT OF THE USE
* OF THIS SOFTWARE, EVEN IF ADVISED OF THE POSSIBILITY OF SUCH DAMAGE.
*/
#include "spdk_internal/log.h"
#include <stdarg.h>
#include <stdio.h>
#include <stdlib.h>
#include <string.h>
#include <strings.h>
#include <syslog.h>
#include <ctype.h>
#include <errno.h>
struct spdk_trace_flag {
const char *name;
bool *enabled;
};
static size_t g_num_trace_flags = 0;
static struct spdk_trace_flag *g_trace_flags = NULL;
unsigned int spdk_g_notice_stderr_flag = 1;
unsigned int spdk_g_log_facility = LOG_DAEMON;
unsigned int spdk_g_log_priority = LOG_NOTICE;
SPDK_LOG_REGISTER_TRACE_FLAG("debug", SPDK_TRACE_DEBUG)
#define MAX_TMPBUF 1024
int
spdk_set_log_facility(const char *facility)
{
if (strcasecmp(facility, "daemon") == 0) {
spdk_g_log_facility = LOG_DAEMON;
} else if (strcasecmp(facility, "auth") == 0) {
spdk_g_log_facility = LOG_AUTH;
} else if (strcasecmp(facility, "authpriv") == 0) {
spdk_g_log_facility = LOG_AUTHPRIV;
} else if (strcasecmp(facility, "local1") == 0) {
spdk_g_log_facility = LOG_LOCAL1;
} else if (strcasecmp(facility, "local2") == 0) {
spdk_g_log_facility = LOG_LOCAL2;
} else if (strcasecmp(facility, "local3") == 0) {
spdk_g_log_facility = LOG_LOCAL3;
} else if (strcasecmp(facility, "local4") == 0) {
spdk_g_log_facility = LOG_LOCAL4;
} else if (strcasecmp(facility, "local5") == 0) {
spdk_g_log_facility = LOG_LOCAL5;
} else if (strcasecmp(facility, "local6") == 0) {
spdk_g_log_facility = LOG_LOCAL6;
} else if (strcasecmp(facility, "local7") == 0) {
spdk_g_log_facility = LOG_LOCAL7;
} else {
spdk_g_log_facility = LOG_DAEMON;
return -1;
}
return 0;
}
int
spdk_set_log_priority(const char *priority)
{
if (strcasecmp(priority, "emerg") == 0) {
spdk_g_log_priority = LOG_EMERG;
} else if (strcasecmp(priority, "alert") == 0) {
spdk_g_log_priority = LOG_ALERT;
} else if (strcasecmp(priority, "crit") == 0) {
spdk_g_log_priority = LOG_CRIT;
} else if (strcasecmp(priority, "err") == 0) {
spdk_g_log_priority = LOG_ERR;
} else if (strcasecmp(priority, "warning") == 0) {
spdk_g_log_priority = LOG_WARNING;
} else if (strcasecmp(priority, "notice") == 0) {
spdk_g_log_priority = LOG_NOTICE;
} else if (strcasecmp(priority, "info") == 0) {
spdk_g_log_priority = LOG_INFO;
} else if (strcasecmp(priority, "debug") == 0) {
spdk_g_log_priority = LOG_DEBUG;
} else {
spdk_g_log_priority = LOG_NOTICE;
return -1;
}
return 0;
}
void
spdk_noticelog(const char *file, const int line, const char *func,
const char *format, ...)
{
char buf[MAX_TMPBUF];
va_list ap;
va_start(ap, format);
vsnprintf(buf, sizeof buf, format, ap);
if (file != NULL) {
if (func != NULL) {
if (spdk_g_notice_stderr_flag) {
fprintf(stderr, "%s:%4d:%s: %s", file, line, func, buf);
}
syslog(LOG_NOTICE, "%s:%4d:%s: %s", file, line, func, buf);
} else {
if (spdk_g_notice_stderr_flag) {
fprintf(stderr, "%s:%4d: %s", file, line, buf);
}
syslog(LOG_NOTICE, "%s:%4d: %s", file, line, buf);
}
} else {
if (spdk_g_notice_stderr_flag) {
fprintf(stderr, "%s", buf);
}
syslog(LOG_NOTICE, "%s", buf);
}
va_end(ap);
}
void
spdk_warnlog(const char *file, const int line, const char *func,
const char *format, ...)
{
char buf[MAX_TMPBUF];
va_list ap;
va_start(ap, format);
vsnprintf(buf, sizeof buf, format, ap);
if (file != NULL) {
if (func != NULL) {
fprintf(stderr, "%s:%4d:%s: %s", file, line, func, buf);
syslog(LOG_WARNING, "%s:%4d:%s: %s",
file, line, func, buf);
} else {
fprintf(stderr, "%s:%4d: %s", file, line, buf);
syslog(LOG_WARNING, "%s:%4d: %s", file, line, buf);
}
} else {
fprintf(stderr, "%s", buf);
syslog(LOG_WARNING, "%s", buf);
}
va_end(ap);
}
void
spdk_tracelog(const char *file, const int line, const char *func,
const char *format, ...)
{
char buf[MAX_TMPBUF];
va_list ap;
va_start(ap, format);
vsnprintf(buf, sizeof buf, format, ap);
if (func != NULL) {
fprintf(stderr, "%s:%4d:%s: %s", file, line, func, buf);
//syslog(LOG_INFO, "%s:%4d:%s: %s", file, line, func, buf);
} else {
fprintf(stderr, "%s:%4d: %s", file, line, buf);
//syslog(LOG_INFO, "%s:%4d: %s", file, line, buf);
}
va_end(ap);
}
void
spdk_errlog(const char *file, const int line, const char *func,
const char *format, ...)
{
char buf[MAX_TMPBUF];
va_list ap;
va_start(ap, format);
vsnprintf(buf, sizeof buf, format, ap);
if (func != NULL) {
fprintf(stderr, "%s:%4d:%s: ***ERROR*** %s", file, line, func, buf);
syslog(LOG_ERR, "%s:%4d:%s: ***ERROR*** %s", file, line, func, buf);
} else {
fprintf(stderr, "%s:%4d: ***ERROR*** %s", file, line, buf);
syslog(LOG_ERR, "%s:%4d: ***ERROR*** %s", file, line, buf);
}
va_end(ap);
}
static void
fdump(FILE *fp, const char *label, const uint8_t *buf, size_t len)
{
char tmpbuf[MAX_TMPBUF];
char buf16[16 + 1];
size_t total;
unsigned int idx;
fprintf(fp, "%s\n", label);
memset(buf16, 0, sizeof buf16);
total = 0;
for (idx = 0; idx < len; idx++) {
if (idx != 0 && idx % 16 == 0) {
snprintf(tmpbuf + total, sizeof tmpbuf - total,
" %s", buf16);
fprintf(fp, "%s\n", tmpbuf);
total = 0;
}
if (idx % 16 == 0) {
total += snprintf(tmpbuf + total, sizeof tmpbuf - total,
"%08x ", idx);
}
if (idx % 8 == 0) {
total += snprintf(tmpbuf + total, sizeof tmpbuf - total,
"%s", " ");
}
total += snprintf(tmpbuf + total, sizeof tmpbuf - total,
"%2.2x ", buf[idx] & 0xff);
buf16[idx % 16] = isprint(buf[idx]) ? buf[idx] : '.';
}
for (; idx % 16 != 0; idx++) {
total += snprintf(tmpbuf + total, sizeof tmpbuf - total, " ");
buf16[idx % 16] = ' ';
}
snprintf(tmpbuf + total, sizeof tmpbuf - total, " %s", buf16);
fprintf(fp, "%s\n", tmpbuf);
fflush(fp);
}
void
spdk_trace_dump(const char *label, const uint8_t *buf, size_t len)
{
fdump(stderr, label, buf, len);
}
static int compare_trace_flags(const void *key, const void *p)
{
const struct spdk_trace_flag *flag = p;
return strcasecmp(key, flag->name);
}
static struct spdk_trace_flag *
get_trace_flag(const char *name)
{
return bsearch(name, g_trace_flags, g_num_trace_flags, sizeof(struct spdk_trace_flag),
compare_trace_flags);
}
void
spdk_log_register_trace_flag(const char *name, bool *enabled)
{
struct spdk_trace_flag *flag, *new_flags;
if (name == NULL || enabled == NULL) {
fprintf(stderr, "missing spdk_trace_flag parameters\n");
abort();
}
if (get_trace_flag(name)) {
fprintf(stderr, "duplicate spdk_trace_flag '%s'\n", name);
abort();
}
new_flags = realloc(g_trace_flags, (g_num_trace_flags + 1) * sizeof(struct spdk_trace_flag));
if (new_flags == NULL) {
fprintf(stderr, "spdk_trace_flag allocation error\n");
abort();
}
g_trace_flags = new_flags;
/* Find slot so that new flag is inserted in sorted order */
for (flag = g_trace_flags; flag != g_trace_flags + g_num_trace_flags; flag++) {
if (strcasecmp(name, flag->name) < 0) {
size_t to_move = g_num_trace_flags - (flag - g_trace_flags);
memmove(flag + 1, flag, to_move * sizeof(struct spdk_trace_flag));
break;
}
}
flag->name = name;
flag->enabled = enabled;
g_num_trace_flags++;
}
bool
spdk_log_get_trace_flag(const char *name)
{
struct spdk_trace_flag *flag = get_trace_flag(name);
if (flag && *flag->enabled) {
return true;
}
return false;
}
static int
set_trace_flag(const char *name, bool value)
{
struct spdk_trace_flag *flag;
size_t i;
if (strcasecmp(name, "all") == 0) {
for (i = 0; i < g_num_trace_flags; i++) {
*g_trace_flags[i].enabled = value;
}
return 0;
}
flag = get_trace_flag(name);
if (flag == NULL) {
return -1;
}
*flag->enabled = value;
return 0;
}
int
spdk_log_set_trace_flag(const char *name)
{
return set_trace_flag(name, true);
}
int
spdk_log_clear_trace_flag(const char *name)
{
return set_trace_flag(name, false);
}
size_t spdk_log_get_num_trace_flags(void)
{
return g_num_trace_flags;
}
const char *spdk_log_get_trace_flag_name(size_t idx)
{
if (idx >= g_num_trace_flags) {
return NULL;
}
return g_trace_flags[idx].name;
}
void
spdk_open_log(void)
{
if (spdk_g_log_facility != 0) {
openlog("spdk", LOG_PID, spdk_g_log_facility);
} else {
openlog("spdk", LOG_PID, LOG_DAEMON);
}
}
void
spdk_close_log(void)
{
closelog();
}
void
spdk_tracelog_usage(FILE *f, const char *trace_arg)
{
#ifdef DEBUG
size_t i;
fprintf(f, " %s flag enable trace flag (all", trace_arg);
for (i = 0; i < g_num_trace_flags; i++) {
fprintf(f, ", %s", g_trace_flags[i].name);
}
fprintf(f, ")\n");
#else
fprintf(f, " %s flag enable trace flag (not supported - must rebuild with CONFIG_DEBUG=y)\n",
trace_arg);
#endif
}