/* layout_simple - a dumb log layout */
-/* Copyright (c) 2003, 2004 Martin Quinson. All rights reserved. */
+/* Copyright (c) 2007-2011. The SimGrid Team.
+ * All rights reserved. */
/* This program is free software; you can redistribute it and/or modify it
* under the terms of the license (GNU LGPL) which comes with this package. */
#include "portable.h" /* execinfo when available */
+#include "xbt/ex_interface.h"
#include "xbt/sysdep.h"
#include "xbt/strbuff.h"
#include "xbt/log_private.h"
-#include "gras/virtu.h" /* gras_os_myname (KILLME) */
#include "xbt/synchro.h" /* xbt_thread_self_name */
+#include "simgrid/simix.h" /* SIMIX_host_self_get_name */
+#include "surf/surf.h"
#include <stdio.h>
extern const char *xbt_log_priority_names[8];
static double format_begin_of_time = -1;
-#define append1(fmt,fmt2,elm) \
- do { \
- if (precision == -1) { \
- xbt_strbuff_append(buff, tmp=bprintf(fmt,elm)); \
- free(tmp); \
- } else { \
- xbt_strbuff_append(buff, tmp=bprintf(fmt2,precision,elm)); \
- free(tmp); \
- precision = -1; \
- } \
- } while (0)
-#define append2(fmt,elm,elm2) \
- do { \
- xbt_strbuff_append(buff, tmp=bprintf(fmt,elm,elm2)); \
- free(tmp); \
- precision = -1; \
- } while (0)
-
-#define ERRMSG "Unknown %%%c sequence in layout format (%s).\nKnown sequences:\n" \
- " what: %%m: user message %%c: log category %%p: log priority\n" \
- " where:\n" \
+#define ERRMSG \
+ "Unknown %%%c sequence in layout format (%s).\n" \
+ "Known sequences:\n" \
+ " what: %%m: user message %%c: log category %%p: log priority\n" \
+ " where:\n" \
" source: %%F: file %%L: line %%M: function %%l: location (%%F:%%L)\n" \
- " runtime: %%h: hostname %%t: thread %%P: process %%i: PID\n" \
- " backtrace: %%b: full %%B: short\n" \
- " when: %%d: date %%r: app. age\n" \
+ " runtime: %%h: hostname %%t: thread %%P: process %%i: PID\n" \
+ " backtrace: %%b: full %%B: short\n" \
+ " when: %%d: date %%r: app. age\n" \
" other: %%%%: %% %%n: new line %%e: plain space\n"
-
-static void xbt_log_layout_format_dynamic(xbt_log_layout_t l,
- xbt_log_event_t ev,
- const char *fmt,
- xbt_log_appender_t app)
+#define check_overflow(len) \
+ if ((rem_size -= (len)) > 0) { \
+ p += (len); \
+ } else \
+ return 0
+
+#define set_sz_from_precision() \
+ if (1) { \
+ sz = rem_size; \
+ if (precision != -1) { \
+ if (precision < sz) \
+ sz = precision + 1; /* +1 for the final '\0' */ \
+ precision = -1; \
+ } \
+ } else (void)0
+
+#define show_it(data, letter) \
+ if (1) { \
+ int len, wd; \
+ if (length == -1) { \
+ wd = 0; \
+ } else { \
+ wd = length; \
+ length = -1; \
+ } \
+ if (precision == -1) { \
+ len = snprintf(p, rem_size, "%*" letter, wd, data); \
+ } else { \
+ len = snprintf(p, rem_size, "%*.*" letter, wd, precision, data); \
+ precision = -1; \
+ } \
+ check_overflow(len); \
+ } else (void)0
+
+#define show_string(data) \
+ if (1) { \
+ const char *show_string_data = (data); \
+ show_it(show_string_data ? show_string_data : "(null)", "s"); \
+ } else (void)0
+#define show_int(data) show_it(data, "d")
+#define show_double(data) show_it(data, "f")
+
+static int xbt_log_layout_format_doit(xbt_log_layout_t l,
+ xbt_log_event_t ev,
+ const char *msg_fmt)
{
- xbt_strbuff_t buff = xbt_strbuff_new();
+ char *p = ev->buffer;
+ int rem_size = ev->buffer_size;
int precision = -1;
- char *q = l->data;
- char *tmp;
- char *tmp2;
- int vres; /* shut gcc up, but ignored */
+ int length = -1;
+ char *q;
- while (*q != '\0') {
+ for (q = l->data ; *q != '\0' ; q++) {
if (*q == '%') {
q++;
handle_modifier:
switch (*q) {
case '\0':
- fprintf(stderr, "Layout format (%s) ending with %%\n",
- (char *) l->data);
- abort();
+ fprintf(stderr, "Layout format (%s) ending with %%\n", (char *)l->data);
+ xbt_abort();
case '%':
- xbt_strbuff_append(buff, "%");
+ *p = '%';
+ check_overflow(1);
break;
- case 'n': /* platform-dependant line separator (LOG4J compliant) */
- xbt_strbuff_append(buff, "\n");
+ case 'n': /* platform-dependant line separator; LOG4J compliant */
+ *p = '\n';
+ check_overflow(1);
break;
- case 'e': /* plain space (SimGrid extension) */
- xbt_strbuff_append(buff, " ");
+ case 'e': /* plain space; SimGrid extension */
+ *p = ' ';
+ check_overflow(1);
break;
-
- case '.': /* precision specifyier */
- q++;
- q += sscanf(q, "%d", &precision);
+ case '.': /* precision specifier */
+ precision = strtol(q + 1, &q, 10);
goto handle_modifier;
-
- case 'c': /* category name; LOG4J compliant
- should accept a precision postfix to show the hierarchy */
- append1("%s", "%.*s", ev->cat->name);
- break;
- case 'p': /* priority name; LOG4J compliant */
- append1("%s", "%.*s", xbt_log_priority_names[ev->priority]);
- break;
-
- case 'h': /* host name; SimGrid extension */
- append1("%s", "%.*s", gras_os_myname());
- break;
- case 't': /* thread name; LOG4J compliant */
- append1("%s", "%.*s", xbt_thread_self_name());
- break;
- case 'P': /* process name; SimGrid extension */
- append1("%s", "%.*s", xbt_procname());
- break;
- case 'i': /* process PID name; SimGrid extension */
- append1("%d", "%.*d", (*xbt_getpid) ());
- break;
-
- case 'F': /* file name; LOG4J compliant */
- append1("%s", "%.*s", ev->fileName);
- break;
- case 'l': /* location; LOG4J compliant */
- append2("%s:%d", ev->fileName, ev->lineNum);
- precision = -1; /* Ignored */
- break;
- case 'L': /* line number; LOG4J compliant */
- append1("%d", "%.*d", ev->lineNum);
- break;
- case 'M': /* method (ie, function) name; LOG4J compliant */
- append1("%s", "%.*s", ev->functionName);
- break;
- case 'b': /* backtrace; called %throwable in LOG4J */
- case 'B': /* short backtrace; called %throwable{short} in LOG4J */
-#if defined(HAVE_EXECINFO_H) && defined(HAVE_POPEN) && defined(ADDR2LINE)
- {
- xbt_ex_t e;
- int i;
-
- e.used = backtrace((void **) e.bt, XBT_BACKTRACE_SIZE);
- e.bt_strings = NULL;
- e.msg = NULL;
- e.remote = 0;
- xbt_backtrace_current(&e);
- if (*q == 'B') {
- append1("%s", "%.*s", e.bt_strings[2] + 8);
- } else {
- for (i = 2; i < e.used; i++)
- append1("%s\n", "%.*s\n", e.bt_strings[i] + 8);
- }
-
- xbt_ex_free(e);
- }
-#else
- append1("%s", "%.*s", "(no backtrace on this arch)");
-#endif
- break;
-
- case 'd': /* date; LOG4J compliant */
- append1("%f", "%.*f", gras_os_time());
- break;
- case 'r': /* application age; LOG4J compliant */
- append1("%f", "%.*f", gras_os_time() - format_begin_of_time);
- break;
-
- case 'm': /* user-provided message; LOG4J compliant */
- vres = vasprintf(&tmp2, fmt, ev->ap_copy);
- append1("%s", "%.*s", tmp2);
- free(tmp2);
- break;
-
- default:
- fprintf(stderr, ERRMSG, *q, (char *) l->data);
- abort();
- }
- q++;
- } else {
- char tmp2[2];
- tmp2[0] = *(q++);
- tmp2[1] = '\0';
- xbt_strbuff_append(buff, tmp2);
- }
- }
- app->do_append(app, buff->data);
- xbt_strbuff_free(buff);
-}
-
-#undef check_overflow
-#define check_overflow \
- if (p-ev->buffer > XBT_LOG_BUFF_SIZE) { /* buffer overflow */ \
- xbt_log_layout_format_dynamic(l,ev,msg_fmt,app); \
- return;\
- }
-static void xbt_log_layout_format_doit(xbt_log_layout_t l,
- xbt_log_event_t ev,
- const char *msg_fmt,
- xbt_log_appender_t app)
-{
- char *p, *q;
- int precision = -1;
-
-
- p = ev->buffer;
- q = l->data;
-
- while (*q != '\0') {
- if (*q == '%') {
- q++;
- handle_modifier:
- switch (*q) {
- case '\0':
- fprintf(stderr, "Layout format (%s) ending with %%\n",
- (char *) l->data);
- abort();
- case '%':
- *p++ = '%';
- break;
- case 'n': /* platform-dependant line separator (LOG4J compliant) */
- p += snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "\n");
- check_overflow;
- break;
- case 'e': /* plain space (SimGrid extension) */
- p += snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), " ");
- check_overflow;
- break;
-
- case '.': /* precision specifyier */
- q++;
- q += sscanf(q, "%d", &precision);
+ case '0':
+ case '1':
+ case '2':
+ case '3':
+ case '4':
+ case '5':
+ case '6':
+ case '7':
+ case '8':
+ case '9': /* length modifier */
+ length = strtol(q, &q, 10);
goto handle_modifier;
-
- case 'c': /* category name; LOG4J compliant
- should accept a precision postfix to show the hierarchy */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- ev->cat->name);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), ev->cat->name);
- check_overflow;
- precision = -1;
- }
+ case 'c': /* category name; LOG4J compliant
+ should accept a precision postfix to show the
+ hierarchy */
+ show_string(ev->cat->name);
break;
- case 'p': /* priority name; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- xbt_log_priority_names[ev->priority]);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision),
- xbt_log_priority_names[ev->priority]);
- check_overflow;
- precision = -1;
- }
+ case 'p': /* priority name; LOG4J compliant */
+ show_string(xbt_log_priority_names[ev->priority]);
break;
-
- case 'h': /* host name; SimGrid extension */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- gras_os_myname());
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), gras_os_myname());
- check_overflow;
- precision = -1;
- }
+ case 'h': /* host name; SimGrid extension */
+ show_string(SIMIX_host_self_get_name());
break;
- case 't': /* thread name; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- xbt_thread_self_name());
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), xbt_thread_self_name());
- check_overflow;
- precision = -1;
- }
+ case 't': /* thread name; LOG4J compliant */
+ show_string(xbt_thread_self_name());
break;
- case 'P': /* process name; SimGrid extension */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- xbt_procname());
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), xbt_procname());
- check_overflow;
- precision = -1;
- }
+ case 'P': /* process name; SimGrid extension */
+ show_string(xbt_procname());
break;
- case 'i': /* process PID name; SimGrid extension */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%d",
- (*xbt_getpid) ());
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*d",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), (*xbt_getpid) ());
- check_overflow;
- precision = -1;
- }
+ case 'i': /* process PID name; SimGrid extension */
+ show_int(xbt_getpid());
break;
-
- case 'F': /* file name; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- ev->fileName);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), ev->fileName);
- check_overflow;
- precision = -1;
- }
+ case 'F': /* file name; LOG4J compliant */
+ show_string(ev->fileName);
break;
- case 'l': /* location; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s:%d",
- ev->fileName, ev->lineNum);
- check_overflow;
- } else {
- p +=
- snprintf(p,
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), "%s:%d", ev->fileName,
- ev->lineNum);
- check_overflow;
- precision = -1;
- }
+ case 'l': { /* location; LOG4J compliant */
+ int len, sz;
+ set_sz_from_precision();
+ len = snprintf(p, sz, "%s:%d", ev->fileName, ev->lineNum);
+ check_overflow(MIN(sz, len));
break;
- case 'L': /* line number; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%d",
- ev->lineNum);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*d",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), ev->lineNum);
- check_overflow;
- precision = -1;
- }
+ }
+ case 'L': /* line number; LOG4J compliant */
+ show_int(ev->lineNum);
break;
case 'M': /* method (ie, function) name; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- ev->functionName);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), ev->functionName);
- check_overflow;
- precision = -1;
- }
+ show_string(ev->functionName);
break;
- case 'b': /* backtrace; called %throwable in LOG4J */
- case 'B': /* short backtrace; called %throwable{short} in LOG4J */
+ case 'b': /* backtrace; called %throwable in LOG4J */
+ case 'B': /* short backtrace; called %throwable{short} in LOG4J */
#if defined(HAVE_EXECINFO_H) && defined(HAVE_POPEN) && defined(ADDR2LINE)
{
xbt_ex_t e;
- int i;
e.used = backtrace((void **) e.bt, XBT_BACKTRACE_SIZE);
e.bt_strings = NULL;
e.msg = NULL;
e.remote = 0;
- xbt_backtrace_current(&e);
+ xbt_ex_setup_backtrace(&e);
if (*q == 'B') {
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s",
- e.bt_strings[2] + 8);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), e.bt_strings[2] + 8);
- check_overflow;
- precision = -1;
- }
+ show_string(e.bt_strings[1] + 8);
} else {
- for (i = 2; i < e.used; i++)
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%s\n",
- e.bt_strings[i] + 8);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*s\n",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), e.bt_strings[i] + 8);
- check_overflow;
- precision = -1;
- }
+ xbt_strbuff_t buff = xbt_strbuff_new();
+ int i;
+ xbt_strbuff_append(buff, e.bt_strings[1] + 8);
+ for (i = 2; i < e.used; i++) {
+ xbt_strbuff_append(buff, "\n");
+ xbt_strbuff_append(buff, e.bt_strings[i] + 8);
+ }
+ show_string(buff->data);
+ xbt_strbuff_free(buff);
}
-
xbt_ex_free(e);
}
#else
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- "(no backtrace on this arch)");
- check_overflow;
+ show_string("(no backtrace on this arch)");
#endif
break;
-
- case 'd': /* date; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%f",
- gras_os_time());
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*f",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), gras_os_time());
- check_overflow;
- precision = -1;
- }
+ case 'd': /* date; LOG4J compliant */
+ show_double(surf_get_clock());
break;
- case 'r': /* application age; LOG4J compliant */
- if (precision == -1) {
- p +=
- snprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), "%f",
- gras_os_time() - format_begin_of_time);
- check_overflow;
- } else {
- p +=
- sprintf(p, "%.*f",
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), gras_os_time() - format_begin_of_time);
- check_overflow;
- precision = -1;
- }
+ case 'r': /* application age; LOG4J compliant */
+ show_double(surf_get_clock() - format_begin_of_time);
break;
-
- case 'm': /* user-provided message; LOG4J compliant */
- if (precision == -1) {
- p +=
- vsnprintf(p, XBT_LOG_BUFF_SIZE - (p - ev->buffer), msg_fmt,
- ev->ap);
- check_overflow;
- } else {
- p +=
- vsnprintf(p,
- (int) MIN(XBT_LOG_BUFF_SIZE - (p - ev->buffer),
- precision), msg_fmt, ev->ap);
- check_overflow;
- precision = -1;
- }
+ case 'm': { /* user-provided message; LOG4J compliant */
+ int len, sz;
+ set_sz_from_precision();
+ len = vsnprintf(p, sz, msg_fmt, ev->ap);
+ check_overflow(MIN(sz, len));
break;
-
+ }
default:
- fprintf(stderr, ERRMSG, *q, (char *) l->data);
- abort();
+ fprintf(stderr, ERRMSG, *q, (char *)l->data);
+ xbt_abort();
}
- q++;
} else {
- *(p++) = *(q++);
- check_overflow;
+ *p = *q;
+ check_overflow(1);
}
}
*p = '\0';
- app->do_append(app, ev->buffer);
+
+ return 1;
}
static void xbt_log_layout_format_free(xbt_log_layout_t lay)
res->data = xbt_strdup((char *) arg);
if (format_begin_of_time < 0)
- format_begin_of_time = gras_os_time();
-
+ format_begin_of_time = surf_get_clock();
+
return res;
}
