2008-11-06 16:36:07 +00:00
|
|
|
/*
|
|
|
|
* logging.c: internal logging and debugging
|
|
|
|
*
|
2011-02-16 23:49:15 +00:00
|
|
|
* Copyright (C) 2008, 2010-2011 Red Hat, Inc.
|
2008-11-06 16:36:07 +00:00
|
|
|
*
|
|
|
|
* This library is free software; you can redistribute it and/or
|
|
|
|
* modify it under the terms of the GNU Lesser General Public
|
|
|
|
* License as published by the Free Software Foundation; either
|
|
|
|
* version 2.1 of the License, or (at your option) any later version.
|
|
|
|
*
|
|
|
|
* This library is distributed in the hope that it will be useful,
|
|
|
|
* but WITHOUT ANY WARRANTY; without even the implied warranty of
|
|
|
|
* MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
|
|
|
|
* Lesser General Public License for more details.
|
|
|
|
*
|
|
|
|
* You should have received a copy of the GNU Lesser General Public
|
|
|
|
* License along with this library; if not, write to the Free Software
|
|
|
|
* Foundation, Inc., 59 Temple Place, Suite 330, Boston, MA 02111-1307 USA
|
|
|
|
*
|
|
|
|
*/
|
|
|
|
|
|
|
|
#include <config.h>
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
#include <stdio.h>
|
|
|
|
#include <stdarg.h>
|
|
|
|
#include <stdlib.h>
|
|
|
|
#include <time.h>
|
|
|
|
#include <sys/time.h>
|
|
|
|
#include <sys/types.h>
|
|
|
|
#include <sys/stat.h>
|
|
|
|
#include <fcntl.h>
|
2009-01-06 18:32:03 +00:00
|
|
|
#include <unistd.h>
|
2008-12-22 10:36:54 +00:00
|
|
|
#if HAVE_SYSLOG_H
|
2010-03-09 18:22:22 +00:00
|
|
|
# include <syslog.h>
|
2008-12-22 10:36:54 +00:00
|
|
|
#endif
|
|
|
|
|
2010-01-18 10:51:01 +00:00
|
|
|
#include "ignore-value.h"
|
2008-11-06 16:36:07 +00:00
|
|
|
#include "logging.h"
|
2008-12-22 10:36:54 +00:00
|
|
|
#include "memory.h"
|
|
|
|
#include "util.h"
|
2009-10-08 15:05:01 +00:00
|
|
|
#include "buf.h"
|
2009-01-15 19:56:05 +00:00
|
|
|
#include "threads.h"
|
2010-11-09 20:48:48 +00:00
|
|
|
#include "files.h"
|
2008-11-06 16:36:07 +00:00
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
/*
|
|
|
|
* Macro used to format the message as a string in virLogMessage
|
|
|
|
* and borrowed from libxml2 (also used in virRaiseError)
|
|
|
|
*/
|
|
|
|
#define VIR_GET_VAR_STR(msg, str) { \
|
|
|
|
int size, prev_size = -1; \
|
|
|
|
int chars; \
|
|
|
|
char *larger; \
|
|
|
|
va_list ap; \
|
|
|
|
\
|
|
|
|
str = (char *) malloc(150); \
|
|
|
|
if (str != NULL) { \
|
|
|
|
\
|
|
|
|
size = 150; \
|
|
|
|
\
|
|
|
|
while (1) { \
|
|
|
|
va_start(ap, msg); \
|
|
|
|
chars = vsnprintf(str, size, msg, ap); \
|
|
|
|
va_end(ap); \
|
|
|
|
if ((chars > -1) && (chars < size)) { \
|
|
|
|
if (prev_size == chars) { \
|
|
|
|
break; \
|
|
|
|
} else { \
|
|
|
|
prev_size = chars; \
|
|
|
|
} \
|
|
|
|
} \
|
|
|
|
if (chars > -1) \
|
|
|
|
size += chars + 1; \
|
|
|
|
else \
|
|
|
|
size += 100; \
|
|
|
|
if ((larger = (char *) realloc(str, size)) == NULL) { \
|
|
|
|
break; \
|
|
|
|
} \
|
|
|
|
str = larger; \
|
|
|
|
}} \
|
|
|
|
}
|
|
|
|
|
|
|
|
/*
|
|
|
|
* A logging buffer to keep some history over logs
|
|
|
|
*/
|
|
|
|
#define LOG_BUFFER_SIZE 64000
|
|
|
|
|
|
|
|
static char virLogBuffer[LOG_BUFFER_SIZE + 1];
|
|
|
|
static int virLogLen = 0;
|
|
|
|
static int virLogStart = 0;
|
|
|
|
static int virLogEnd = 0;
|
|
|
|
|
|
|
|
/*
|
|
|
|
* Filters are used to refine the rules on what to keep or drop
|
|
|
|
* based on a matching pattern (currently a substring)
|
|
|
|
*/
|
|
|
|
struct _virLogFilter {
|
|
|
|
const char *match;
|
|
|
|
int priority;
|
|
|
|
};
|
|
|
|
typedef struct _virLogFilter virLogFilter;
|
|
|
|
typedef virLogFilter *virLogFilterPtr;
|
|
|
|
|
|
|
|
static virLogFilterPtr virLogFilters = NULL;
|
|
|
|
static int virLogNbFilters = 0;
|
|
|
|
|
|
|
|
/*
|
|
|
|
* Outputs are used to emit the messages retained
|
|
|
|
* after filtering, multiple output can be used simultaneously
|
|
|
|
*/
|
|
|
|
struct _virLogOutput {
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
bool logVersion;
|
2008-12-22 10:36:54 +00:00
|
|
|
void *data;
|
|
|
|
virLogOutputFunc f;
|
|
|
|
virLogCloseFunc c;
|
|
|
|
int priority;
|
2009-10-08 15:05:01 +00:00
|
|
|
virLogDestination dest;
|
|
|
|
const char *name;
|
2008-12-22 10:36:54 +00:00
|
|
|
};
|
|
|
|
typedef struct _virLogOutput virLogOutput;
|
|
|
|
typedef virLogOutput *virLogOutputPtr;
|
|
|
|
|
|
|
|
static virLogOutputPtr virLogOutputs = NULL;
|
|
|
|
static int virLogNbOutputs = 0;
|
|
|
|
|
|
|
|
/*
|
|
|
|
* Default priorities
|
|
|
|
*/
|
2009-07-01 11:21:15 +00:00
|
|
|
static virLogPriority virLogDefaultPriority = VIR_LOG_DEFAULT;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
static int virLogResetFilters(void);
|
|
|
|
static int virLogResetOutputs(void);
|
|
|
|
|
|
|
|
/*
|
|
|
|
* Logs accesses must be serialized though a mutex
|
|
|
|
*/
|
2009-01-15 19:56:05 +00:00
|
|
|
virMutex virLogMutex;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
2010-02-03 16:12:57 +00:00
|
|
|
void virLogLock(void)
|
2008-12-22 10:36:54 +00:00
|
|
|
{
|
2009-01-15 19:56:05 +00:00
|
|
|
virMutexLock(&virLogMutex);
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
2010-02-03 16:12:57 +00:00
|
|
|
void virLogUnlock(void)
|
2008-12-22 10:36:54 +00:00
|
|
|
{
|
2009-01-15 19:56:05 +00:00
|
|
|
virMutexUnlock(&virLogMutex);
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
2009-10-08 15:05:01 +00:00
|
|
|
static const char *virLogOutputString(virLogDestination ldest) {
|
|
|
|
switch (ldest) {
|
2011-01-21 16:30:17 +00:00
|
|
|
case VIR_LOG_TO_STDERR:
|
|
|
|
return "stderr";
|
|
|
|
case VIR_LOG_TO_SYSLOG:
|
|
|
|
return "syslog";
|
|
|
|
case VIR_LOG_TO_FILE:
|
|
|
|
return "file";
|
2009-10-08 15:05:01 +00:00
|
|
|
}
|
2011-01-21 16:30:17 +00:00
|
|
|
return "unknown";
|
2009-10-08 15:05:01 +00:00
|
|
|
}
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
static const char *virLogPriorityString(virLogPriority lvl) {
|
|
|
|
switch (lvl) {
|
2011-01-21 16:30:17 +00:00
|
|
|
case VIR_LOG_DEBUG:
|
|
|
|
return "debug";
|
|
|
|
case VIR_LOG_INFO:
|
|
|
|
return "info";
|
|
|
|
case VIR_LOG_WARN:
|
|
|
|
return "warning";
|
|
|
|
case VIR_LOG_ERROR:
|
|
|
|
return "error";
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
2011-01-21 16:30:17 +00:00
|
|
|
return "unknown";
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
static int virLogInitialized = 0;
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogStartup:
|
|
|
|
*
|
|
|
|
* Initialize the logging module
|
|
|
|
*
|
|
|
|
* Returns 0 if successful, and -1 in case or error
|
|
|
|
*/
|
|
|
|
int virLogStartup(void) {
|
|
|
|
if (virLogInitialized)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2009-01-15 19:56:05 +00:00
|
|
|
|
|
|
|
if (virMutexInit(&virLogMutex) < 0)
|
|
|
|
return -1;
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogInitialized = 1;
|
|
|
|
virLogLock();
|
|
|
|
virLogLen = 0;
|
|
|
|
virLogStart = 0;
|
|
|
|
virLogEnd = 0;
|
2009-07-01 11:21:15 +00:00
|
|
|
virLogDefaultPriority = VIR_LOG_DEFAULT;
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogUnlock();
|
2011-01-21 16:30:17 +00:00
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogReset:
|
|
|
|
*
|
|
|
|
* Reset the logging module to its default initial state
|
|
|
|
*
|
|
|
|
* Returns 0 if successful, and -1 in case or error
|
|
|
|
*/
|
|
|
|
int virLogReset(void) {
|
|
|
|
if (!virLogInitialized)
|
2011-01-21 16:30:17 +00:00
|
|
|
return virLogStartup();
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
virLogLock();
|
|
|
|
virLogResetFilters();
|
|
|
|
virLogResetOutputs();
|
|
|
|
virLogLen = 0;
|
|
|
|
virLogStart = 0;
|
|
|
|
virLogEnd = 0;
|
2009-07-01 11:21:15 +00:00
|
|
|
virLogDefaultPriority = VIR_LOG_DEFAULT;
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogUnlock();
|
2011-01-21 16:30:17 +00:00
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
/**
|
|
|
|
* virLogShutdown:
|
|
|
|
*
|
|
|
|
* Shutdown the logging module
|
|
|
|
*/
|
|
|
|
void virLogShutdown(void) {
|
|
|
|
if (!virLogInitialized)
|
|
|
|
return;
|
|
|
|
virLogLock();
|
|
|
|
virLogResetFilters();
|
|
|
|
virLogResetOutputs();
|
|
|
|
virLogLen = 0;
|
|
|
|
virLogStart = 0;
|
|
|
|
virLogEnd = 0;
|
|
|
|
virLogUnlock();
|
2009-01-15 19:56:05 +00:00
|
|
|
virMutexDestroy(&virLogMutex);
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogInitialized = 0;
|
|
|
|
}
|
|
|
|
|
|
|
|
/*
|
|
|
|
* Store a string in the ring buffer
|
|
|
|
*/
|
|
|
|
static void virLogStr(const char *str, int len) {
|
|
|
|
int tmp;
|
|
|
|
|
|
|
|
if (str == NULL)
|
|
|
|
return;
|
|
|
|
if (len <= 0)
|
|
|
|
len = strlen(str);
|
|
|
|
if (len > LOG_BUFFER_SIZE)
|
|
|
|
return;
|
|
|
|
virLogLock();
|
|
|
|
|
|
|
|
/*
|
|
|
|
* copy the data and reset the end, we cycle over the end of the buffer
|
|
|
|
*/
|
|
|
|
if (virLogEnd + len >= LOG_BUFFER_SIZE) {
|
|
|
|
tmp = LOG_BUFFER_SIZE - virLogEnd;
|
|
|
|
memcpy(&virLogBuffer[virLogEnd], str, tmp);
|
|
|
|
virLogBuffer[LOG_BUFFER_SIZE] = 0;
|
2009-09-03 16:36:59 +00:00
|
|
|
memcpy(&virLogBuffer[0], &str[tmp], len - tmp);
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogEnd = len - tmp;
|
|
|
|
} else {
|
|
|
|
memcpy(&virLogBuffer[virLogEnd], str, len);
|
|
|
|
virLogEnd += len;
|
|
|
|
}
|
|
|
|
/*
|
|
|
|
* Update the log length, and if full move the start index
|
|
|
|
*/
|
|
|
|
virLogLen += len;
|
|
|
|
if (virLogLen > LOG_BUFFER_SIZE) {
|
|
|
|
tmp = virLogLen - LOG_BUFFER_SIZE;
|
|
|
|
virLogLen = LOG_BUFFER_SIZE;
|
|
|
|
virLogStart += tmp;
|
2011-03-03 07:45:52 +00:00
|
|
|
if (virLogStart >= LOG_BUFFER_SIZE)
|
|
|
|
virLogStart -= LOG_BUFFER_SIZE;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
virLogUnlock();
|
|
|
|
}
|
|
|
|
|
|
|
|
#if 0
|
|
|
|
/*
|
|
|
|
* Output the ring buffer
|
|
|
|
*/
|
|
|
|
static int virLogDump(void *data, virLogOutputFunc f) {
|
|
|
|
int ret = 0, tmp;
|
|
|
|
|
|
|
|
if ((virLogLen == 0) || (f == NULL))
|
2011-01-21 16:30:17 +00:00
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogLock();
|
|
|
|
if (virLogStart + virLogLen < LOG_BUFFER_SIZE) {
|
|
|
|
push_end:
|
|
|
|
virLogBuffer[virLogStart + virLogLen] = 0;
|
|
|
|
tmp = f(data, &virLogBuffer[virLogStart], virLogLen);
|
|
|
|
if (tmp < 0) {
|
|
|
|
ret = -1;
|
|
|
|
goto error;
|
|
|
|
}
|
|
|
|
ret += tmp;
|
|
|
|
virLogStart += tmp;
|
|
|
|
virLogLen -= tmp;
|
|
|
|
} else {
|
|
|
|
tmp = LOG_BUFFER_SIZE - virLogStart;
|
|
|
|
ret = f(data, &virLogBuffer[virLogStart], tmp);
|
|
|
|
if (ret < 0) {
|
|
|
|
ret = -1;
|
|
|
|
goto error;
|
|
|
|
}
|
|
|
|
if (ret < tmp) {
|
|
|
|
virLogStart += ret;
|
|
|
|
virLogLen -= ret;
|
|
|
|
} else {
|
|
|
|
virLogStart = 0;
|
|
|
|
virLogLen -= tmp;
|
|
|
|
/* dump the second part */
|
|
|
|
if (virLogLen > 0)
|
|
|
|
goto push_end;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
error:
|
|
|
|
virLogUnlock();
|
2011-01-21 16:30:17 +00:00
|
|
|
return ret;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
2008-11-06 16:36:07 +00:00
|
|
|
#endif
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
/**
|
|
|
|
* virLogSetDefaultPriority:
|
|
|
|
* @priority: the default priority level
|
|
|
|
*
|
|
|
|
* Set the default priority level, i.e. any logged data of a priority
|
|
|
|
* equal or superior to this level will be logged, unless a specific rule
|
|
|
|
* was defined for the log category of the message.
|
|
|
|
*
|
|
|
|
* Returns 0 if successful, -1 in case of error.
|
|
|
|
*/
|
|
|
|
int virLogSetDefaultPriority(int priority) {
|
2009-08-06 13:38:11 +00:00
|
|
|
if ((priority < VIR_LOG_DEBUG) || (priority > VIR_LOG_ERROR)) {
|
2010-05-19 10:00:18 +00:00
|
|
|
VIR_WARN0("Ignoring invalid log level setting.");
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2009-08-06 13:38:11 +00:00
|
|
|
}
|
2008-12-22 10:36:54 +00:00
|
|
|
if (!virLogInitialized)
|
|
|
|
virLogStartup();
|
|
|
|
virLogDefaultPriority = priority;
|
2011-01-21 16:30:17 +00:00
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogResetFilters:
|
|
|
|
*
|
|
|
|
* Removes the set of logging filters defined.
|
|
|
|
*
|
|
|
|
* Returns the number of filters removed
|
|
|
|
*/
|
|
|
|
static int virLogResetFilters(void) {
|
|
|
|
int i;
|
|
|
|
|
|
|
|
for (i = 0; i < virLogNbFilters;i++)
|
|
|
|
VIR_FREE(virLogFilters[i].match);
|
|
|
|
VIR_FREE(virLogFilters);
|
|
|
|
virLogNbFilters = 0;
|
2011-01-21 16:30:17 +00:00
|
|
|
return i;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogDefineFilter:
|
|
|
|
* @match: the pattern to match
|
|
|
|
* @priority: the priority to give to messages matching the pattern
|
|
|
|
* @flags: extra flag, currently unused
|
|
|
|
*
|
|
|
|
* Defines a pattern used for log filtering, it allow to select or
|
|
|
|
* reject messages independently of the default priority.
|
|
|
|
* The filter defines a rules that will apply only to messages matching
|
|
|
|
* the pattern (currently if @match is a substring of the message category)
|
|
|
|
*
|
|
|
|
* Returns -1 in case of failure or the filter number if successful
|
|
|
|
*/
|
|
|
|
int virLogDefineFilter(const char *match, int priority,
|
|
|
|
int flags ATTRIBUTE_UNUSED) {
|
|
|
|
int i;
|
|
|
|
char *mdup = NULL;
|
|
|
|
|
|
|
|
if ((match == NULL) || (priority < VIR_LOG_DEBUG) ||
|
|
|
|
(priority > VIR_LOG_ERROR))
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
virLogLock();
|
|
|
|
for (i = 0;i < virLogNbFilters;i++) {
|
|
|
|
if (STREQ(virLogFilters[i].match, match)) {
|
|
|
|
virLogFilters[i].priority = priority;
|
|
|
|
goto cleanup;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
mdup = strdup(match);
|
2009-11-10 11:56:11 +00:00
|
|
|
if (mdup == NULL) {
|
2008-12-22 10:36:54 +00:00
|
|
|
i = -1;
|
|
|
|
goto cleanup;
|
|
|
|
}
|
|
|
|
i = virLogNbFilters;
|
|
|
|
if (VIR_REALLOC_N(virLogFilters, virLogNbFilters + 1)) {
|
|
|
|
i = -1;
|
|
|
|
VIR_FREE(mdup);
|
|
|
|
goto cleanup;
|
|
|
|
}
|
|
|
|
virLogFilters[i].match = mdup;
|
|
|
|
virLogFilters[i].priority = priority;
|
|
|
|
virLogNbFilters++;
|
|
|
|
cleanup:
|
|
|
|
virLogUnlock();
|
2011-01-21 16:30:17 +00:00
|
|
|
return i;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogFiltersCheck:
|
|
|
|
* @input: the input string
|
|
|
|
*
|
|
|
|
* Check the input of the message against the existing filters. Currently
|
|
|
|
* the match is just a substring check of the category used as the input
|
|
|
|
* string, a more subtle approach could be used instead
|
|
|
|
*
|
|
|
|
* Returns 0 if not matched or the new priority if found.
|
|
|
|
*/
|
|
|
|
static int virLogFiltersCheck(const char *input) {
|
|
|
|
int ret = 0;
|
|
|
|
int i;
|
|
|
|
|
|
|
|
virLogLock();
|
|
|
|
for (i = 0;i < virLogNbFilters;i++) {
|
|
|
|
if (strstr(input, virLogFilters[i].match)) {
|
|
|
|
ret = virLogFilters[i].priority;
|
|
|
|
break;
|
|
|
|
}
|
|
|
|
}
|
|
|
|
virLogUnlock();
|
2011-01-21 16:30:17 +00:00
|
|
|
return ret;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogResetOutputs:
|
|
|
|
*
|
|
|
|
* Removes the set of logging output defined.
|
|
|
|
*
|
|
|
|
* Returns the number of output removed
|
|
|
|
*/
|
|
|
|
static int virLogResetOutputs(void) {
|
|
|
|
int i;
|
|
|
|
|
|
|
|
for (i = 0;i < virLogNbOutputs;i++) {
|
|
|
|
if (virLogOutputs[i].c != NULL)
|
|
|
|
virLogOutputs[i].c(virLogOutputs[i].data);
|
2009-10-08 15:05:01 +00:00
|
|
|
VIR_FREE(virLogOutputs[i].name);
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
VIR_FREE(virLogOutputs);
|
|
|
|
i = virLogNbOutputs;
|
|
|
|
virLogNbOutputs = 0;
|
2011-01-21 16:30:17 +00:00
|
|
|
return i;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogDefineOutput:
|
|
|
|
* @f: the function to call to output a message
|
2009-10-08 15:05:01 +00:00
|
|
|
* @c: the function to call to close the output (or NULL)
|
2008-12-22 10:36:54 +00:00
|
|
|
* @data: extra data passed as first arg to the function
|
|
|
|
* @priority: minimal priority for this filter, use 0 for none
|
2009-10-08 15:05:01 +00:00
|
|
|
* @dest: where to send output of this priority
|
|
|
|
* @name: optional name data associated with an output
|
2008-12-22 10:36:54 +00:00
|
|
|
* @flags: extra flag, currently unused
|
|
|
|
*
|
|
|
|
* Defines an output function for log messages. Each message once
|
|
|
|
* gone though filtering is emitted through each registered output.
|
|
|
|
*
|
|
|
|
* Returns -1 in case of failure or the output number if successful
|
|
|
|
*/
|
|
|
|
int virLogDefineOutput(virLogOutputFunc f, virLogCloseFunc c, void *data,
|
2009-10-08 15:05:01 +00:00
|
|
|
int priority, int dest, const char *name,
|
|
|
|
int flags ATTRIBUTE_UNUSED) {
|
2008-12-22 10:36:54 +00:00
|
|
|
int ret = -1;
|
2009-10-08 15:05:01 +00:00
|
|
|
char *ndup = NULL;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
if (f == NULL)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
2009-10-08 15:05:01 +00:00
|
|
|
if (dest == VIR_LOG_TO_SYSLOG || dest == VIR_LOG_TO_FILE) {
|
|
|
|
if (name == NULL)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2009-10-08 15:05:01 +00:00
|
|
|
ndup = strdup(name);
|
|
|
|
if (ndup == NULL)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2009-10-08 15:05:01 +00:00
|
|
|
}
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogLock();
|
|
|
|
if (VIR_REALLOC_N(virLogOutputs, virLogNbOutputs + 1)) {
|
2009-11-10 11:56:11 +00:00
|
|
|
VIR_FREE(ndup);
|
2008-12-22 10:36:54 +00:00
|
|
|
goto cleanup;
|
|
|
|
}
|
|
|
|
ret = virLogNbOutputs++;
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
virLogOutputs[ret].logVersion = true;
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogOutputs[ret].f = f;
|
|
|
|
virLogOutputs[ret].c = c;
|
|
|
|
virLogOutputs[ret].data = data;
|
|
|
|
virLogOutputs[ret].priority = priority;
|
2009-10-08 15:05:01 +00:00
|
|
|
virLogOutputs[ret].dest = dest;
|
|
|
|
virLogOutputs[ret].name = ndup;
|
2008-12-22 10:36:54 +00:00
|
|
|
cleanup:
|
|
|
|
virLogUnlock();
|
2011-01-21 16:30:17 +00:00
|
|
|
return ret;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
static int
|
|
|
|
virLogFormatString(char **msg,
|
|
|
|
const char *funcname,
|
|
|
|
long long linenr,
|
|
|
|
struct tm *time_info,
|
|
|
|
struct timeval *cur_time,
|
|
|
|
int priority,
|
|
|
|
const char *str)
|
|
|
|
{
|
|
|
|
int ret;
|
|
|
|
if ((funcname != NULL)) {
|
|
|
|
ret = virAsprintf(msg, "%02d:%02d:%02d.%03d: %d: %s : %s:%lld : %s\n",
|
|
|
|
time_info->tm_hour, time_info->tm_min,
|
|
|
|
time_info->tm_sec, (int) cur_time->tv_usec / 1000,
|
|
|
|
virThreadSelfID(),
|
|
|
|
virLogPriorityString(priority), funcname, linenr, str);
|
|
|
|
} else {
|
|
|
|
ret = virAsprintf(msg, "%02d:%02d:%02d.%03d: %d: %s : %s\n",
|
|
|
|
time_info->tm_hour, time_info->tm_min,
|
|
|
|
time_info->tm_sec, (int) cur_time->tv_usec / 1000,
|
|
|
|
virThreadSelfID(),
|
|
|
|
virLogPriorityString(priority), str);
|
|
|
|
}
|
|
|
|
return ret;
|
|
|
|
}
|
|
|
|
|
|
|
|
static int
|
|
|
|
virLogVersionString(char **msg,
|
|
|
|
struct tm *time_info,
|
|
|
|
struct timeval *cur_time)
|
|
|
|
{
|
|
|
|
#ifdef PACKAGER_VERSION
|
|
|
|
# ifdef PACKAGER
|
|
|
|
# define LOG_VERSION_STRING \
|
|
|
|
"libvirt version: " VERSION ", package: " PACKAGER_VERSION " (" PACKAGER ")"
|
|
|
|
# else
|
|
|
|
# define LOG_VERSION_STRING \
|
|
|
|
"libvirt version: " VERSION ", package: " PACKAGER_VERSION
|
|
|
|
# endif
|
|
|
|
#else
|
|
|
|
# define LOG_VERSION_STRING \
|
|
|
|
"libvirt version: " VERSION
|
|
|
|
#endif
|
|
|
|
|
|
|
|
return virLogFormatString(msg, NULL, 0,
|
|
|
|
time_info, cur_time,
|
|
|
|
VIR_LOG_INFO, LOG_VERSION_STRING);
|
|
|
|
}
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
/**
|
|
|
|
* virLogMessage:
|
|
|
|
* @category: where is that message coming from
|
|
|
|
* @priority: the priority level
|
2008-12-22 10:44:10 +00:00
|
|
|
* @funcname: the function emitting the (debug) message
|
|
|
|
* @linenr: line where the message was emitted
|
2008-12-22 10:36:54 +00:00
|
|
|
* @flags: extra flags, 1 if coming from the error handler
|
|
|
|
* @fmt: the string format
|
|
|
|
* @...: the arguments
|
|
|
|
*
|
|
|
|
* Call the libvirt logger with some informations. Based on the configuration
|
|
|
|
* the message may be stored, sent to output or just discarded
|
|
|
|
*/
|
2008-12-22 10:44:10 +00:00
|
|
|
void virLogMessage(const char *category, int priority, const char *funcname,
|
|
|
|
long long linenr, int flags, const char *fmt, ...) {
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
static bool logVersionStderr = true;
|
2008-12-22 10:36:54 +00:00
|
|
|
char *str = NULL;
|
2011-03-02 12:26:02 +00:00
|
|
|
char *msg = NULL;
|
2008-12-22 10:36:54 +00:00
|
|
|
struct timeval cur_time;
|
|
|
|
struct tm time_info;
|
2008-12-22 10:44:10 +00:00
|
|
|
int len, fprio, i, ret;
|
2011-02-16 23:49:15 +00:00
|
|
|
int saved_errno = errno;
|
2011-03-02 12:26:02 +00:00
|
|
|
int emit = 1;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
if (!virLogInitialized)
|
|
|
|
virLogStartup();
|
|
|
|
|
|
|
|
if (fmt == NULL)
|
2011-02-16 23:49:15 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
/*
|
|
|
|
* check against list of specific logging patterns
|
|
|
|
*/
|
|
|
|
fprio = virLogFiltersCheck(category);
|
|
|
|
if (fprio == 0) {
|
|
|
|
if (priority < virLogDefaultPriority)
|
2011-03-02 12:26:02 +00:00
|
|
|
emit = 0;
|
2011-02-16 23:49:15 +00:00
|
|
|
} else if (priority < fprio) {
|
2011-03-02 12:26:02 +00:00
|
|
|
emit = 0;
|
2011-02-16 23:49:15 +00:00
|
|
|
}
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
/*
|
|
|
|
* serialize the error message, add level and timestamp
|
|
|
|
*/
|
|
|
|
VIR_GET_VAR_STR(fmt, str);
|
|
|
|
if (str == NULL)
|
2011-02-16 23:49:15 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
gettimeofday(&cur_time, NULL);
|
|
|
|
localtime_r(&cur_time.tv_sec, &time_info);
|
|
|
|
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
ret = virLogFormatString(&msg, funcname, linenr,
|
|
|
|
&time_info, &cur_time,
|
|
|
|
priority, str);
|
2008-12-22 10:44:10 +00:00
|
|
|
VIR_FREE(str);
|
2011-02-16 23:49:15 +00:00
|
|
|
if (ret < 0)
|
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
/*
|
2011-03-02 12:26:02 +00:00
|
|
|
* Log based on defaults, first store in the history buffer,
|
|
|
|
* then if emit push the message on the outputs defined, if none
|
2008-12-22 10:36:54 +00:00
|
|
|
* use stderr.
|
|
|
|
* NOTE: the locking is a single point of contention for multiple
|
|
|
|
* threads, but avoid intermixing. Maybe set up locks per output
|
|
|
|
* to improve paralellism.
|
|
|
|
*/
|
|
|
|
len = strlen(msg);
|
|
|
|
virLogStr(msg, len);
|
2011-03-02 12:26:02 +00:00
|
|
|
if (emit == 0)
|
|
|
|
goto cleanup;
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogLock();
|
|
|
|
for (i = 0; i < virLogNbOutputs;i++) {
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
if (priority >= virLogOutputs[i].priority) {
|
|
|
|
if (virLogOutputs[i].logVersion) {
|
|
|
|
char *ver = NULL;
|
|
|
|
if (virLogVersionString(&ver, &time_info, &cur_time) >= 0)
|
|
|
|
virLogOutputs[i].f(category, VIR_LOG_INFO, __func__, __LINE__,
|
|
|
|
ver, strlen(ver),
|
|
|
|
virLogOutputs[i].data);
|
|
|
|
VIR_FREE(ver);
|
|
|
|
virLogOutputs[i].logVersion = false;
|
|
|
|
}
|
2008-12-22 10:44:10 +00:00
|
|
|
virLogOutputs[i].f(category, priority, funcname, linenr,
|
|
|
|
msg, len, virLogOutputs[i].data);
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
}
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
if ((virLogNbOutputs == 0) && (flags != 1)) {
|
|
|
|
if (logVersionStderr) {
|
|
|
|
char *ver = NULL;
|
|
|
|
if (virLogVersionString(&ver, &time_info, &cur_time) >= 0)
|
|
|
|
ignore_value (safewrite(STDERR_FILENO,
|
|
|
|
ver, strlen(ver)));
|
|
|
|
VIR_FREE(ver);
|
|
|
|
logVersionStderr = false;
|
|
|
|
}
|
2010-01-18 10:51:01 +00:00
|
|
|
ignore_value (safewrite(STDERR_FILENO, msg, len));
|
Imprint all logs with version + package build information
The logging functions are enhanced so that immediately prior to
the first log message being printed to any output channel, the
libvirt package version will be printed.
eg
$ LIBVIRT_DEBUG=1 virsh
18:13:28.013: 17536: info : libvirt version: 0.8.7
18:13:28.013: 17536: debug : virInitialize:361 : register drivers
...
The 'configure' script gains two new arguments which can be
used as
--with-packager="Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10"
--with-packager-version="1.fc14"
to allow distros to append a custom string with package specific
data.
The RPM specfile is modified so that it appends the RPM version,
the build host, the build date and the packager name.
eg
$ LIBVIRT_DEBUG=1 virsh
18:14:52.086: 17551: info : libvirt version: 0.8.7, package: 1.fc13 (Fedora Project, x86-01.phx2.fedoraproject.org, 01-27-2011-18:00:10)
18:14:52.086: 17551: debug : virInitialize:361 : register drivers
Thus when distro packagers receive bug reports they can clearly
see what version was in use, even if the bug reporter mistakenly
or intentionally lies about version/builds
* src/util/logging.c: Output version data prior to first log message
* libvirt.spec.in: Include RPM release, date, hostname & packager
* configure.ac: Add --with-packager & --with-packager-version args
2011-01-27 18:11:16 +00:00
|
|
|
}
|
2008-12-22 10:36:54 +00:00
|
|
|
virLogUnlock();
|
|
|
|
|
2011-02-16 23:49:15 +00:00
|
|
|
cleanup:
|
2011-03-02 12:26:02 +00:00
|
|
|
VIR_FREE(msg);
|
2011-02-16 23:49:15 +00:00
|
|
|
errno = saved_errno;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
2008-12-22 10:44:10 +00:00
|
|
|
static int virLogOutputToFd(const char *category ATTRIBUTE_UNUSED,
|
2008-12-22 10:36:54 +00:00
|
|
|
int priority ATTRIBUTE_UNUSED,
|
2008-12-22 10:44:10 +00:00
|
|
|
const char *funcname ATTRIBUTE_UNUSED,
|
|
|
|
long long linenr ATTRIBUTE_UNUSED,
|
|
|
|
const char *str, int len, void *data) {
|
2008-12-22 10:36:54 +00:00
|
|
|
int fd = (long) data;
|
|
|
|
int ret;
|
|
|
|
|
|
|
|
if (fd < 0)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
ret = safewrite(fd, str, len);
|
2011-01-21 16:30:17 +00:00
|
|
|
return ret;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
static void virLogCloseFd(void *data) {
|
|
|
|
int fd = (long) data;
|
|
|
|
|
2010-11-09 20:48:48 +00:00
|
|
|
VIR_FORCE_CLOSE(fd);
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
static int virLogAddOutputToStderr(int priority) {
|
2009-10-08 15:05:01 +00:00
|
|
|
if (virLogDefineOutput(virLogOutputToFd, NULL, (void *)2L, priority,
|
|
|
|
VIR_LOG_TO_STDERR, NULL, 0) < 0)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
static int virLogAddOutputToFile(int priority, const char *file) {
|
|
|
|
int fd;
|
|
|
|
|
2009-10-08 15:05:01 +00:00
|
|
|
fd = open(file, O_CREAT | O_APPEND | O_WRONLY, S_IRUSR | S_IWUSR);
|
2008-12-22 10:36:54 +00:00
|
|
|
if (fd < 0)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
if (virLogDefineOutput(virLogOutputToFd, virLogCloseFd, (void *)(long)fd,
|
2009-10-08 15:05:01 +00:00
|
|
|
priority, VIR_LOG_TO_FILE, file, 0) < 0) {
|
2010-11-09 20:48:48 +00:00
|
|
|
VIR_FORCE_CLOSE(fd);
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
2011-01-21 16:30:17 +00:00
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
#if HAVE_SYSLOG_H
|
2008-12-22 10:44:10 +00:00
|
|
|
static int virLogOutputToSyslog(const char *category ATTRIBUTE_UNUSED,
|
|
|
|
int priority,
|
|
|
|
const char *funcname ATTRIBUTE_UNUSED,
|
|
|
|
long long linenr ATTRIBUTE_UNUSED,
|
|
|
|
const char *str, int len ATTRIBUTE_UNUSED,
|
|
|
|
void *data ATTRIBUTE_UNUSED) {
|
2008-12-22 10:36:54 +00:00
|
|
|
int prio;
|
|
|
|
|
|
|
|
switch (priority) {
|
|
|
|
case VIR_LOG_DEBUG:
|
|
|
|
prio = LOG_DEBUG;
|
|
|
|
break;
|
|
|
|
case VIR_LOG_INFO:
|
|
|
|
prio = LOG_INFO;
|
|
|
|
break;
|
|
|
|
case VIR_LOG_WARN:
|
|
|
|
prio = LOG_WARNING;
|
|
|
|
break;
|
|
|
|
case VIR_LOG_ERROR:
|
|
|
|
prio = LOG_ERR;
|
|
|
|
break;
|
|
|
|
default:
|
|
|
|
prio = LOG_ERR;
|
|
|
|
}
|
|
|
|
syslog(prio, "%s", str);
|
2011-01-21 16:30:17 +00:00
|
|
|
return len;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
2009-01-20 21:34:44 +00:00
|
|
|
static char *current_ident = NULL;
|
|
|
|
|
2008-12-22 10:36:54 +00:00
|
|
|
static void virLogCloseSyslog(void *data ATTRIBUTE_UNUSED) {
|
|
|
|
closelog();
|
2009-01-20 21:34:44 +00:00
|
|
|
VIR_FREE(current_ident);
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
static int virLogAddOutputToSyslog(int priority, const char *ident) {
|
2009-01-20 21:34:44 +00:00
|
|
|
/*
|
|
|
|
* ident needs to be kept around on Solaris
|
|
|
|
*/
|
|
|
|
VIR_FREE(current_ident);
|
|
|
|
current_ident = strdup(ident);
|
|
|
|
if (current_ident == NULL)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2009-01-20 21:34:44 +00:00
|
|
|
|
|
|
|
openlog(current_ident, 0, 0);
|
2008-12-22 10:36:54 +00:00
|
|
|
if (virLogDefineOutput(virLogOutputToSyslog, virLogCloseSyslog, NULL,
|
2009-10-08 15:05:01 +00:00
|
|
|
priority, VIR_LOG_TO_SYSLOG, ident, 0) < 0) {
|
2008-12-22 10:36:54 +00:00
|
|
|
closelog();
|
2009-01-20 21:34:44 +00:00
|
|
|
VIR_FREE(current_ident);
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
2011-01-21 16:30:17 +00:00
|
|
|
return 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
#endif /* HAVE_SYSLOG_H */
|
|
|
|
|
|
|
|
#define IS_SPACE(cur) \
|
|
|
|
((*cur == ' ') || (*cur == '\t') || (*cur == '\n') || \
|
|
|
|
(*cur == '\r') || (*cur == '\\'))
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogParseOutputs:
|
|
|
|
* @outputs: string defining a (set of) output(s)
|
|
|
|
*
|
|
|
|
* The format for an output can be:
|
|
|
|
* x:stderr
|
|
|
|
* output goes to stderr
|
|
|
|
* x:syslog:name
|
|
|
|
* use syslog for the output and use the given name as the ident
|
|
|
|
* x:file:file_path
|
|
|
|
* output to a file, with the given filepath
|
|
|
|
* In all case the x prefix is the minimal level, acting as a filter
|
|
|
|
* 0: everything
|
|
|
|
* 1: DEBUG
|
|
|
|
* 2: INFO
|
|
|
|
* 3: WARNING
|
|
|
|
* 4: ERROR
|
|
|
|
*
|
|
|
|
* Multiple output can be defined in a single @output, they just need to be
|
|
|
|
* separated by spaces.
|
|
|
|
*
|
|
|
|
* Returns the number of output parsed and installed or -1 in case of error
|
|
|
|
*/
|
|
|
|
int virLogParseOutputs(const char *outputs) {
|
|
|
|
const char *cur = outputs, *str;
|
|
|
|
char *name;
|
2009-10-08 15:05:01 +00:00
|
|
|
char *abspath;
|
2008-12-22 10:36:54 +00:00
|
|
|
int prio;
|
2009-08-06 13:38:11 +00:00
|
|
|
int ret = -1;
|
|
|
|
int count = 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
if (cur == NULL)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
virSkipSpaces(&cur);
|
|
|
|
while (*cur != 0) {
|
|
|
|
prio= virParseNumber(&cur);
|
2009-07-01 11:21:15 +00:00
|
|
|
if ((prio < VIR_LOG_DEBUG) || (prio > VIR_LOG_ERROR))
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
if (*cur != ':')
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
cur++;
|
|
|
|
if (STREQLEN(cur, "stderr", 6)) {
|
|
|
|
cur += 6;
|
|
|
|
if (virLogAddOutputToStderr(prio) == 0)
|
2009-08-06 13:38:11 +00:00
|
|
|
count++;
|
2008-12-22 10:36:54 +00:00
|
|
|
} else if (STREQLEN(cur, "syslog", 6)) {
|
|
|
|
cur += 6;
|
|
|
|
if (*cur != ':')
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
cur++;
|
|
|
|
str = cur;
|
|
|
|
while ((*cur != 0) && (!IS_SPACE(cur)))
|
|
|
|
cur++;
|
|
|
|
if (str == cur)
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
#if HAVE_SYSLOG_H
|
|
|
|
name = strndup(str, cur - str);
|
|
|
|
if (name == NULL)
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
if (virLogAddOutputToSyslog(prio, name) == 0)
|
2009-08-06 13:38:11 +00:00
|
|
|
count++;
|
2008-12-22 10:36:54 +00:00
|
|
|
VIR_FREE(name);
|
|
|
|
#endif /* HAVE_SYSLOG_H */
|
|
|
|
} else if (STREQLEN(cur, "file", 4)) {
|
|
|
|
cur += 4;
|
|
|
|
if (*cur != ':')
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
cur++;
|
|
|
|
str = cur;
|
|
|
|
while ((*cur != 0) && (!IS_SPACE(cur)))
|
|
|
|
cur++;
|
|
|
|
if (str == cur)
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
name = strndup(str, cur - str);
|
|
|
|
if (name == NULL)
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2009-10-08 15:05:01 +00:00
|
|
|
if (virFileAbsPath(name, &abspath) < 0) {
|
|
|
|
VIR_FREE(name);
|
|
|
|
return -1; /* skip warning here because setting was fine */
|
|
|
|
}
|
|
|
|
if (virLogAddOutputToFile(prio, abspath) == 0)
|
2009-08-06 13:38:11 +00:00
|
|
|
count++;
|
2008-12-22 10:36:54 +00:00
|
|
|
VIR_FREE(name);
|
2009-10-08 15:05:01 +00:00
|
|
|
VIR_FREE(abspath);
|
2008-12-22 10:36:54 +00:00
|
|
|
} else {
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
virSkipSpaces(&cur);
|
|
|
|
}
|
2009-08-06 13:38:11 +00:00
|
|
|
ret = count;
|
|
|
|
cleanup:
|
|
|
|
if (ret == -1)
|
2010-05-19 10:00:18 +00:00
|
|
|
VIR_WARN0("Ignoring invalid log output setting.");
|
2011-01-21 16:30:17 +00:00
|
|
|
return ret;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogParseFilters:
|
|
|
|
* @filters: string defining a (set of) filter(s)
|
|
|
|
*
|
|
|
|
* The format for a filter is:
|
|
|
|
* x:name
|
|
|
|
* where name is a match string
|
|
|
|
* the x prefix is the minimal level where the messages should be logged
|
|
|
|
* 1: DEBUG
|
|
|
|
* 2: INFO
|
|
|
|
* 3: WARNING
|
|
|
|
* 4: ERROR
|
|
|
|
*
|
|
|
|
* Multiple filter can be defined in a single @filters, they just need to be
|
|
|
|
* separated by spaces.
|
|
|
|
*
|
|
|
|
* Returns the number of filter parsed and installed or -1 in case of error
|
|
|
|
*/
|
|
|
|
int virLogParseFilters(const char *filters) {
|
|
|
|
const char *cur = filters, *str;
|
|
|
|
char *name;
|
|
|
|
int prio;
|
2009-08-06 13:38:11 +00:00
|
|
|
int ret = -1;
|
|
|
|
int count = 0;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
if (cur == NULL)
|
2011-01-21 16:30:17 +00:00
|
|
|
return -1;
|
2008-12-22 10:36:54 +00:00
|
|
|
|
|
|
|
virSkipSpaces(&cur);
|
|
|
|
while (*cur != 0) {
|
|
|
|
prio= virParseNumber(&cur);
|
2009-07-01 11:21:15 +00:00
|
|
|
if ((prio < VIR_LOG_DEBUG) || (prio > VIR_LOG_ERROR))
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
if (*cur != ':')
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
cur++;
|
|
|
|
str = cur;
|
|
|
|
while ((*cur != 0) && (!IS_SPACE(cur)))
|
|
|
|
cur++;
|
|
|
|
if (str == cur)
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
name = strndup(str, cur - str);
|
|
|
|
if (name == NULL)
|
2009-08-06 13:38:11 +00:00
|
|
|
goto cleanup;
|
2008-12-22 10:36:54 +00:00
|
|
|
if (virLogDefineFilter(name, prio, 0) >= 0)
|
2009-08-06 13:38:11 +00:00
|
|
|
count++;
|
2008-12-22 10:36:54 +00:00
|
|
|
VIR_FREE(name);
|
|
|
|
virSkipSpaces(&cur);
|
|
|
|
}
|
2009-08-06 13:38:11 +00:00
|
|
|
ret = count;
|
|
|
|
cleanup:
|
|
|
|
if (ret == -1)
|
2010-05-19 10:00:18 +00:00
|
|
|
VIR_WARN0("Ignoring invalid log filter setting.");
|
2011-01-21 16:30:17 +00:00
|
|
|
return ret;
|
2008-12-22 10:36:54 +00:00
|
|
|
}
|
2009-08-06 13:45:50 +00:00
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogGetDefaultPriority:
|
|
|
|
*
|
|
|
|
* Returns the current logging priority level.
|
|
|
|
*/
|
|
|
|
int virLogGetDefaultPriority(void) {
|
2011-01-21 16:30:17 +00:00
|
|
|
return virLogDefaultPriority;
|
2009-08-06 13:45:50 +00:00
|
|
|
}
|
|
|
|
|
2009-10-08 15:05:01 +00:00
|
|
|
/**
|
|
|
|
* virLogGetFilters:
|
|
|
|
*
|
|
|
|
* Returns a string listing the current filters, in the format originally
|
|
|
|
* specified in the config file or environment. Caller must free the
|
|
|
|
* result.
|
|
|
|
*/
|
|
|
|
char *virLogGetFilters(void) {
|
|
|
|
int i;
|
|
|
|
virBuffer filterbuf = VIR_BUFFER_INITIALIZER;
|
|
|
|
|
|
|
|
virLogLock();
|
|
|
|
for (i = 0; i < virLogNbFilters; i++) {
|
|
|
|
virBufferVSprintf(&filterbuf, "%d:%s ", virLogFilters[i].priority,
|
|
|
|
virLogFilters[i].match);
|
|
|
|
}
|
|
|
|
virLogUnlock();
|
|
|
|
|
2009-12-09 23:00:50 +00:00
|
|
|
if (virBufferError(&filterbuf)) {
|
|
|
|
virBufferFreeAndReset(&filterbuf);
|
2009-10-08 15:05:01 +00:00
|
|
|
return NULL;
|
2009-12-09 23:00:50 +00:00
|
|
|
}
|
2009-10-08 15:05:01 +00:00
|
|
|
|
|
|
|
return virBufferContentAndReset(&filterbuf);
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogGetOutputs:
|
|
|
|
*
|
|
|
|
* Returns a string listing the current outputs, in the format originally
|
|
|
|
* specified in the config file or environment. Caller must free the
|
|
|
|
* result.
|
|
|
|
*/
|
|
|
|
char *virLogGetOutputs(void) {
|
|
|
|
int i;
|
|
|
|
virBuffer outputbuf = VIR_BUFFER_INITIALIZER;
|
|
|
|
|
|
|
|
virLogLock();
|
|
|
|
for (i = 0; i < virLogNbOutputs; i++) {
|
|
|
|
int dest = virLogOutputs[i].dest;
|
|
|
|
if (i)
|
|
|
|
virBufferVSprintf(&outputbuf, " ");
|
|
|
|
switch (dest) {
|
|
|
|
case VIR_LOG_TO_SYSLOG:
|
|
|
|
case VIR_LOG_TO_FILE:
|
|
|
|
virBufferVSprintf(&outputbuf, "%d:%s:%s",
|
|
|
|
virLogOutputs[i].priority,
|
|
|
|
virLogOutputString(dest),
|
|
|
|
virLogOutputs[i].name);
|
|
|
|
break;
|
|
|
|
default:
|
|
|
|
virBufferVSprintf(&outputbuf, "%d:%s",
|
|
|
|
virLogOutputs[i].priority,
|
|
|
|
virLogOutputString(dest));
|
|
|
|
}
|
|
|
|
}
|
|
|
|
virLogUnlock();
|
|
|
|
|
2009-12-09 23:00:50 +00:00
|
|
|
if (virBufferError(&outputbuf)) {
|
|
|
|
virBufferFreeAndReset(&outputbuf);
|
2009-10-08 15:05:01 +00:00
|
|
|
return NULL;
|
2009-12-09 23:00:50 +00:00
|
|
|
}
|
2009-10-08 15:05:01 +00:00
|
|
|
|
|
|
|
return virBufferContentAndReset(&outputbuf);
|
|
|
|
}
|
|
|
|
|
2009-08-06 13:45:50 +00:00
|
|
|
/**
|
|
|
|
* virLogGetNbFilters:
|
|
|
|
*
|
|
|
|
* Returns the current number of defined log filters.
|
|
|
|
*/
|
|
|
|
int virLogGetNbFilters(void) {
|
2011-01-21 16:30:17 +00:00
|
|
|
return virLogNbFilters;
|
2009-08-06 13:45:50 +00:00
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogGetNbOutputs:
|
|
|
|
*
|
|
|
|
* Returns the current number of defined log outputs.
|
|
|
|
*/
|
|
|
|
int virLogGetNbOutputs(void) {
|
2011-01-21 16:30:17 +00:00
|
|
|
return virLogNbOutputs;
|
2009-08-06 13:45:50 +00:00
|
|
|
}
|
2009-08-06 13:55:07 +00:00
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogParseDefaultPriority:
|
|
|
|
* @priority: string defining the desired logging level
|
|
|
|
*
|
|
|
|
* Parses and sets the default log priority level. It can take a string or
|
|
|
|
* number corresponding to the following levels:
|
|
|
|
* 1: DEBUG
|
|
|
|
* 2: INFO
|
|
|
|
* 3: WARNING
|
|
|
|
* 4: ERROR
|
|
|
|
*
|
|
|
|
* Returns the parsed log level or -1 on error.
|
|
|
|
*/
|
|
|
|
int virLogParseDefaultPriority(const char *priority) {
|
|
|
|
int ret = -1;
|
|
|
|
|
|
|
|
if (STREQ(priority, "1") || STREQ(priority, "debug"))
|
|
|
|
ret = virLogSetDefaultPriority(VIR_LOG_DEBUG);
|
|
|
|
else if (STREQ(priority, "2") || STREQ(priority, "info"))
|
|
|
|
ret = virLogSetDefaultPriority(VIR_LOG_INFO);
|
|
|
|
else if (STREQ(priority, "3") || STREQ(priority, "warning"))
|
|
|
|
ret = virLogSetDefaultPriority(VIR_LOG_WARN);
|
|
|
|
else if (STREQ(priority, "4") || STREQ(priority, "error"))
|
|
|
|
ret = virLogSetDefaultPriority(VIR_LOG_ERROR);
|
|
|
|
else
|
2010-05-19 10:00:18 +00:00
|
|
|
VIR_WARN0("Ignoring invalid log level setting");
|
2009-08-06 13:55:07 +00:00
|
|
|
|
|
|
|
return ret;
|
|
|
|
}
|
|
|
|
|
|
|
|
/**
|
|
|
|
* virLogSetFromEnv:
|
|
|
|
*
|
|
|
|
* Sets virLogDefaultPriority, virLogFilters and virLogOutputs based on
|
|
|
|
* environment variables.
|
|
|
|
*/
|
|
|
|
void virLogSetFromEnv(void) {
|
|
|
|
char *debugEnv;
|
|
|
|
|
|
|
|
debugEnv = getenv("LIBVIRT_DEBUG");
|
|
|
|
if (debugEnv && *debugEnv)
|
|
|
|
virLogParseDefaultPriority(debugEnv);
|
|
|
|
debugEnv = getenv("LIBVIRT_LOG_FILTERS");
|
|
|
|
if (debugEnv && *debugEnv)
|
2010-12-01 16:42:17 +00:00
|
|
|
virLogParseFilters(debugEnv);
|
2009-08-06 13:55:07 +00:00
|
|
|
debugEnv = getenv("LIBVIRT_LOG_OUTPUTS");
|
|
|
|
if (debugEnv && *debugEnv)
|
2010-12-01 16:42:17 +00:00
|
|
|
virLogParseOutputs(debugEnv);
|
2009-08-06 13:55:07 +00:00
|
|
|
}
|