Blame SOURCES/bz1791792-4-main-Add-schedmiss-timestamp-into-message.patch

354091
From 35662dd0ec53f456445c30c0ef92892f47b25aa2 Mon Sep 17 00:00:00 2001
354091
From: Jan Friesse <jfriesse@redhat.com>
354091
Date: Mon, 24 Feb 2020 14:58:45 +0100
354091
Subject: [PATCH] main: Add schedmiss timestamp into message
354091
354091
This is useful for matching schedmiss event in stats map with logged
354091
event.
354091
354091
Signed-off-by: Jan Friesse <jfriesse@redhat.com>
354091
Reviewed-by: Christine Caulfield <ccaulfie@redhat.com>
354091
---
354091
 exec/main.c | 9 ++++++---
354091
 1 file changed, 6 insertions(+), 3 deletions(-)
354091
354091
diff --git a/exec/main.c b/exec/main.c
354091
index 821d97e..8c3df79 100644
354091
--- a/exec/main.c
354091
+++ b/exec/main.c
354091
@@ -817,6 +817,7 @@ static void timer_function_scheduler_timeout (void *data)
354091
 	struct scheduler_pause_timeout_data *timeout_data = (struct scheduler_pause_timeout_data *)data;
354091
 	unsigned long long tv_current;
354091
 	unsigned long long tv_diff;
354091
+	uint64_t schedmiss_event_tstamp;
354091
 
354091
 	tv_current = qb_util_nano_current_get ();
354091
 
354091
@@ -832,12 +833,14 @@ static void timer_function_scheduler_timeout (void *data)
354091
 	timeout_data->tv_prev = tv_current;
354091
 
354091
 	if (tv_diff > timeout_data->max_tv_diff) {
354091
-		log_printf (LOGSYS_LEVEL_WARNING, "Corosync main process was not scheduled for %0.4f ms "
354091
+		schedmiss_event_tstamp = qb_util_nano_from_epoch_get() / QB_TIME_NS_IN_MSEC;
354091
+
354091
+		log_printf (LOGSYS_LEVEL_WARNING, "Corosync main process was not scheduled (@%" PRIu64 ") for %0.4f ms "
354091
 		    "(threshold is %0.4f ms). Consider token timeout increase.",
354091
+		    schedmiss_event_tstamp,
354091
 		    (float)tv_diff / QB_TIME_NS_IN_MSEC, (float)timeout_data->max_tv_diff / QB_TIME_NS_IN_MSEC);
354091
 
354091
-		stats_add_schedmiss_event(qb_util_nano_from_epoch_get() / QB_TIME_NS_IN_MSEC,
354091
-		    (float)tv_diff / QB_TIME_NS_IN_MSEC);
354091
+		stats_add_schedmiss_event(schedmiss_event_tstamp, (float)tv_diff / QB_TIME_NS_IN_MSEC);
354091
 	}
354091
 
354091
 	/*
354091
-- 
354091
1.8.3.1
354091