/*
This file is part of GNUnet.
- (C) 2011 Christian Grothoff (and other contributing authors)
+ Copyright (C) 2011 GNUnet e.V.
GNUnet is free software; you can redistribute it and/or modify
it under the terms of the GNU General Public License as published
You should have received a copy of the GNU General Public License
along with GNUnet; see the file COPYING. If not, write to the
- Free Software Foundation, Inc., 59 Temple Place - Suite 330,
- Boston, MA 02111-1307, USA.
+ Free Software Foundation, Inc., 51 Franklin Street, Fifth Floor,
+ Boston, MA 02110-1301, USA.
*/
/**
* @author LRN
*/
#include "platform.h"
-#include "gnunet_common.h"
-#include "gnunet_scheduler_lib.h"
-#include "gnunet_network_lib.h"
-#include "gnunet_disk_lib.h"
-#include "gnunet_os_lib.h"
+#include "gnunet_util_lib.h"
#define VERBOSE GNUNET_NO
+/**
+ * How much time the child is allowed to waste on skipped log calls, at most.
+ * Raspberry Pi takes 113 microseconds tops, this is 3x that value.
+ */
+#define MAX_SKIP_DELAY GNUNET_TIME_relative_multiply (GNUNET_TIME_UNIT_MICROSECONDS, 400).rel_value_us
+
+/**
+ * How much time non-skipped log call should take, at least.
+ * Keep in sync with the value in the dummy!
+ */
+#define OUTPUT_DELAY GNUNET_TIME_relative_multiply (GNUNET_TIME_UNIT_MICROSECONDS, 1000).rel_value_us
+
static int ok;
static int phase = 0;
/* Pipe to read from started processes stdout (on read end) */
static struct GNUNET_DISK_PipeHandle *pipe_stdout;
-static GNUNET_SCHEDULER_TaskIdentifier die_task;
+static struct GNUNET_SCHEDULER_Task * die_task;
-static GNUNET_SCHEDULER_TaskIdentifier read_task;
+static struct GNUNET_SCHEDULER_Task * read_task;
static void
runone (void);
static void
-end_task (void *cls, const struct GNUNET_SCHEDULER_TaskContext *tc)
+end_task (void *cls)
{
GNUNET_log (GNUNET_ERROR_TYPE_DEBUG, "Ending phase %d, ok is %d\n", phase,
ok);
if (NULL != proc)
{
- if (0 != GNUNET_OS_process_kill (proc, SIGTERM))
+ if (0 != GNUNET_OS_process_kill (proc, GNUNET_TERM_SIG))
{
GNUNET_log_strerror (GNUNET_ERROR_TYPE_WARNING, "kill");
}
GNUNET_OS_process_destroy (proc);
proc = NULL;
}
- if (GNUNET_SCHEDULER_NO_TASK != read_task)
+ if (NULL != read_task)
{
GNUNET_SCHEDULER_cancel (read_task);
- read_task = GNUNET_SCHEDULER_NO_TASK;
+ read_task = NULL;
}
GNUNET_DISK_pipe_close (pipe_stdout);
if (ok == 1)
static char *
read_output_line (int phase_from1, int phase_to1, int phase_from2,
int phase_to2, char c, const char *expect_level,
- long delay_morethan, long delay_lessthan, int phase,
- const char *p,
+ long delay_morethan, long delay_lessthan, int phase,
+ char *p,
int *len, long *delay, char level[8])
{
char *r = p;
char t[7];
int i, j, stop = 0;
+ int level_matches;
+ int delay_is_sane;
+ int delay_is_a_dummy;
+ int delay_outside_of_range;
j = 0;
int stage = 0;
break;
}
}
- if (!stop || strcmp (expect_level, level) != 0 || *delay < 0 || *delay > 1000
- || (!((*delay < delay_lessthan) || !(*delay > delay_morethan)) && c != '1'
- && c != '2'))
+ level_matches = (strcmp (expect_level, level) == 0);
+ delay_is_sane = (*delay >= 0) && (*delay <= 1000000);
+ delay_is_a_dummy = (c == 'L');
+ /* Delay must be either less than 'lessthan' (log call is skipped)
+ * or more than 'morethan' (log call is not skipped)
+ */
+ delay_outside_of_range = ((*delay < delay_lessthan) || (*delay >= delay_morethan));
+ if (delay_is_a_dummy)
+ delay_outside_of_range = 1;
+
+ if (! stop)
+ GNUNET_log (GNUNET_ERROR_TYPE_ERROR,
+ "Wrong log format?\n");
+ if (! level_matches)
+ GNUNET_log (GNUNET_ERROR_TYPE_ERROR,
+ "Wrong log level\n");
+ if (! delay_is_sane)
+ GNUNET_log (GNUNET_ERROR_TYPE_ERROR,
+ "Delay %ld is insane\n",
+ *delay);
+ if (! delay_outside_of_range)
+ GNUNET_log (GNUNET_ERROR_TYPE_ERROR,
+ "Delay %ld is not outside of range (%ld ; %ld)\n",
+ *delay,
+ delay_lessthan,
+ delay_morethan);
+ if (!stop || !level_matches || !delay_is_sane || !delay_outside_of_range)
return NULL;
*len = *len - i;
return &r[i];
}
-static char buf[20 * 16];
+/**
+ * Up to 8 non-skipped GNUNET_log() calls
+ * + extra line with delay for each one
+ */
+#define LOG_MAX_NUM_LINES (8 * 2)
+/**
+ * Actual message is 17 chars at most
+ */
+#define LOG_MAX_LINE_LENGTH (17)
+
+#define LOG_BUFFER_SIZE LOG_MAX_NUM_LINES * LOG_MAX_LINE_LENGTH
+
+static char buf[LOG_BUFFER_SIZE];
static char *buf_ptr;
static void
-read_call (void *cls, const struct GNUNET_SCHEDULER_TaskContext *tc)
+read_call (void *cls)
{
const struct GNUNET_DISK_FileHandle *stdout_read_handle = cls;
char level[8];
long delays[8];
int rd;
- read_task = GNUNET_SCHEDULER_NO_TASK;
+ read_task = NULL;
rd = GNUNET_DISK_file_read (stdout_read_handle, buf_ptr,
sizeof (buf) - bytes);
if (rd > 0)
FPRINTF (stderr, "got %d bytes, reading more\n", rd);
#endif
read_task = GNUNET_SCHEDULER_add_read_file (GNUNET_TIME_UNIT_FOREVER_REL,
- stdout_read_handle, &read_call,
+ stdout_read_handle,
+ &read_call,
(void*) stdout_read_handle);
return;
}
*/
char *p = buf;
- if (bytes == 20 * 16 ||
+ if (bytes == LOG_BUFFER_SIZE ||
!(p =
- read_output_line (0, 3, 4, 9, 'L', "ERROR", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (0, 3, 4, 9, 'L', "ERROR", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '1', "ERROR", 200, 400, phase, p, &bytes,
- &delays[0], level)) ||
+ read_output_line (0, 3, 4, 9, '1', "ERROR", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
+ &bytes, &delays[0], level)) ||
!(p =
- read_output_line (1, 3, 5, 9, 'L', "WARNING", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (1, 3, 5, 9, 'L', "WARNING", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '1', "WARNING", 200, 400, phase, p,
+ read_output_line (0, 3, 4, 9, '1', "WARNING", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
&bytes, &delays[1], level)) ||
!(p =
- read_output_line (2, 3, 6, 7, 'L', "INFO", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (2, 3, 6, 7, 'L', "INFO", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '1', "INFO", 200, 400, phase, p, &bytes,
- &delays[2], level)) ||
+ read_output_line (0, 3, 4, 9, '1', "INFO", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
+ &bytes, &delays[2], level)) ||
!(p =
- read_output_line (3, 3, 7, 7, 'L', "DEBUG", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (3, 3, 7, 7, 'L', "DEBUG", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '1', "DEBUG", 200, 400, phase, p, &bytes,
- &delays[3], level)) ||
+ read_output_line (0, 3, 4, 9, '1', "DEBUG", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
+ &bytes, &delays[3], level)) ||
!(p =
- read_output_line (0, 3, 4, 9, 'L', "ERROR", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (0, 3, 4, 9, 'L', "ERROR", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '2', "ERROR", 200, 400, phase, p, &bytes,
- &delays[4], level)) ||
+ read_output_line (0, 3, 4, 9, '2', "ERROR", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
+ &bytes, &delays[4], level)) ||
!(p =
- read_output_line (0, 3, 5, 9, 'L', "WARNING", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (0, 3, 5, 9, 'L', "WARNING", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '2', "WARNING", 200, 400, phase, p,
+ read_output_line (0, 3, 4, 9, '2', "WARNING", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
&bytes, &delays[5], level)) ||
!(p =
- read_output_line (-1, -1, 6, 7, 'L', "INFO", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (-1, -1, 6, 7, 'L', "INFO", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '2', "INFO", 200, 400, phase, p, &bytes,
- &delays[6], level)) ||
+ read_output_line (0, 3, 4, 9, '2', "INFO", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
+ &bytes, &delays[6], level)) ||
!(p =
- read_output_line (-1, -1, 7, 7, 'L', "DEBUG", -1, 1, phase, p, &bytes,
- &delay, level)) ||
+ read_output_line (-1, -1, 7, 7, 'L', "DEBUG", -1,
+ 1, phase, p,
+ &bytes, &delay, level)) ||
!(p =
- read_output_line (0, 3, 4, 9, '2', "DEBUG", 200, 400, phase, p, &bytes,
- &delays[7], level)))
+ read_output_line (0, 3, 4, 9, '2', "DEBUG", OUTPUT_DELAY,
+ MAX_SKIP_DELAY, phase, p,
+ &bytes, &delays[7], level)))
{
- if (bytes == 20 * 16)
+ if (bytes == LOG_BUFFER_SIZE)
FPRINTF (stderr, "%s", "Ran out of buffer space!\n");
GNUNET_break (0);
ok = 2;
break;
}
- proc = GNUNET_OS_start_process (GNUNET_NO, GNUNET_OS_INHERIT_STD_OUT_AND_ERR, NULL, pipe_stdout,
+ proc = GNUNET_OS_start_process (GNUNET_NO, GNUNET_OS_INHERIT_STD_OUT_AND_ERR,
+ NULL, pipe_stdout, NULL,
#if MINGW
"test_common_logging_dummy",
#else
die_task =
GNUNET_SCHEDULER_add_delayed (GNUNET_TIME_relative_multiply
- (GNUNET_TIME_UNIT_SECONDS, 10), &end_task,
+ (GNUNET_TIME_UNIT_SECONDS, 10),
+ &end_task,
NULL);
bytes = 0;
memset (&buf, 0, sizeof (buf));
read_task = GNUNET_SCHEDULER_add_read_file (GNUNET_TIME_UNIT_FOREVER_REL,
- stdout_read_handle, &read_call,
+ stdout_read_handle,
+ &read_call,
(void*) stdout_read_handle);
}
static void
-task (void *cls, const struct GNUNET_SCHEDULER_TaskContext *tc)
+task (void *cls)
{
phase = 0;
runone ();