52b84b
From d5245b46716cf53ce4d95966ea99499cf7aa209a Mon Sep 17 00:00:00 2001
52b84b
From: Lennart Poettering <lennart@poettering.net>
52b84b
Date: Tue, 13 Nov 2018 21:25:22 +0100
52b84b
Subject: [PATCH] core: make log messages about units entering a 'failed' state
52b84b
 recognizable
52b84b
52b84b
Let's make this recognizable, and carry result information in a
52b84b
structure fashion.
52b84b
52b84b
(cherry picked from commit 7c047d7443347c109daf67023a01c118b5f361eb)
52b84b
52b84b
Related: #1737283
52b84b
---
52b84b
 catalog/systemd.catalog.in |  7 +++++++
52b84b
 src/core/automount.c       |  2 +-
52b84b
 src/core/mount.c           |  2 +-
52b84b
 src/core/path.c            |  2 +-
52b84b
 src/core/scope.c           |  2 +-
52b84b
 src/core/service.c         |  2 +-
52b84b
 src/core/socket.c          |  2 +-
52b84b
 src/core/swap.c            |  2 +-
52b84b
 src/core/timer.c           |  2 +-
52b84b
 src/core/unit.c            | 12 ++++++++++++
52b84b
 src/core/unit.h            |  2 ++
52b84b
 src/systemd/sd-messages.h  |  4 ++++
52b84b
 12 files changed, 33 insertions(+), 8 deletions(-)
52b84b
52b84b
diff --git a/catalog/systemd.catalog.in b/catalog/systemd.catalog.in
52b84b
index 49a45890f6..54a0f46921 100644
52b84b
--- a/catalog/systemd.catalog.in
52b84b
+++ b/catalog/systemd.catalog.in
52b84b
@@ -344,6 +344,13 @@ Support: %SUPPORT_URL%
52b84b
 
52b84b
 The unit @UNIT@ completed and consumed the indicated resources.
52b84b
 
52b84b
+-- d9b373ed55a64feb8242e02dbe79a49c
52b84b
+Subject: Unit failed
52b84b
+Defined-By: systemd
52b84b
+Support: %SUPPORT_URL%
52b84b
+
52b84b
+The unit @UNIT@ has entered the 'failed' state with result '@UNIT_RESULT@'.
52b84b
+
52b84b
 -- 50876a9db00f4c40bde1a2ad381c3a1b
52b84b
 Subject: The system is configured in a way that might cause problems
52b84b
 Defined-By: systemd
52b84b
diff --git a/src/core/automount.c b/src/core/automount.c
52b84b
index 1b96a52c00..c78562c549 100644
52b84b
--- a/src/core/automount.c
52b84b
+++ b/src/core/automount.c
52b84b
@@ -315,7 +315,7 @@ static void automount_enter_dead(Automount *a, AutomountResult f) {
52b84b
                 a->result = f;
52b84b
 
52b84b
         if (a->result != AUTOMOUNT_SUCCESS)
52b84b
-                log_unit_warning(UNIT(a), "Failed with result '%s'.", automount_result_to_string(a->result));
52b84b
+                unit_log_failure(UNIT(a), automount_result_to_string(a->result));
52b84b
 
52b84b
         automount_set_state(a, a->result != AUTOMOUNT_SUCCESS ? AUTOMOUNT_FAILED : AUTOMOUNT_DEAD);
52b84b
 }
52b84b
diff --git a/src/core/mount.c b/src/core/mount.c
52b84b
index 5878814b1b..3cd0e479e9 100644
52b84b
--- a/src/core/mount.c
52b84b
+++ b/src/core/mount.c
52b84b
@@ -797,7 +797,7 @@ static void mount_enter_dead(Mount *m, MountResult f) {
52b84b
                 m->result = f;
52b84b
 
52b84b
         if (m->result != MOUNT_SUCCESS)
52b84b
-                log_unit_warning(UNIT(m), "Failed with result '%s'.", mount_result_to_string(m->result));
52b84b
+                unit_log_failure(UNIT(m), mount_result_to_string(m->result));
52b84b
 
52b84b
         mount_set_state(m, m->result != MOUNT_SUCCESS ? MOUNT_FAILED : MOUNT_DEAD);
52b84b
 
52b84b
diff --git a/src/core/path.c b/src/core/path.c
52b84b
index 5ef178a46b..f8b69e7804 100644
52b84b
--- a/src/core/path.c
52b84b
+++ b/src/core/path.c
52b84b
@@ -449,7 +449,7 @@ static void path_enter_dead(Path *p, PathResult f) {
52b84b
                 p->result = f;
52b84b
 
52b84b
         if (p->result != PATH_SUCCESS)
52b84b
-                log_unit_warning(UNIT(p), "Failed with result '%s'.", path_result_to_string(p->result));
52b84b
+                unit_log_failure(UNIT(p), path_result_to_string(p->result));
52b84b
 
52b84b
         path_set_state(p, p->result != PATH_SUCCESS ? PATH_FAILED : PATH_DEAD);
52b84b
 }
52b84b
diff --git a/src/core/scope.c b/src/core/scope.c
52b84b
index 751556fecf..79ecfd992f 100644
52b84b
--- a/src/core/scope.c
52b84b
+++ b/src/core/scope.c
52b84b
@@ -240,7 +240,7 @@ static void scope_enter_dead(Scope *s, ScopeResult f) {
52b84b
                 s->result = f;
52b84b
 
52b84b
         if (s->result != SCOPE_SUCCESS)
52b84b
-                log_unit_warning(UNIT(s), "Failed with result '%s'.", scope_result_to_string(s->result));
52b84b
+                unit_log_failure(UNIT(s), scope_result_to_string(s->result));
52b84b
 
52b84b
         scope_set_state(s, s->result != SCOPE_SUCCESS ? SCOPE_FAILED : SCOPE_DEAD);
52b84b
 }
52b84b
diff --git a/src/core/service.c b/src/core/service.c
52b84b
index 5035dcacac..efceb0614c 100644
52b84b
--- a/src/core/service.c
52b84b
+++ b/src/core/service.c
52b84b
@@ -1680,7 +1680,7 @@ static void service_enter_dead(Service *s, ServiceResult f, bool allow_restart)
52b84b
                 s->result = f;
52b84b
 
52b84b
         if (s->result != SERVICE_SUCCESS)
52b84b
-                log_unit_warning(UNIT(s), "Failed with result '%s'.", service_result_to_string(s->result));
52b84b
+                unit_log_failure(UNIT(s), service_result_to_string(s->result));
52b84b
 
52b84b
         if (allow_restart && service_shall_restart(s))
52b84b
                 s->will_auto_restart = true;
52b84b
diff --git a/src/core/socket.c b/src/core/socket.c
52b84b
index b034549634..160f11765c 100644
52b84b
--- a/src/core/socket.c
52b84b
+++ b/src/core/socket.c
52b84b
@@ -1991,7 +1991,7 @@ static void socket_enter_dead(Socket *s, SocketResult f) {
52b84b
                 s->result = f;
52b84b
 
52b84b
         if (s->result != SOCKET_SUCCESS)
52b84b
-                log_unit_warning(UNIT(s), "Failed with result '%s'.", socket_result_to_string(s->result));
52b84b
+                unit_log_failure(UNIT(s), socket_result_to_string(s->result));
52b84b
 
52b84b
         socket_set_state(s, s->result != SOCKET_SUCCESS ? SOCKET_FAILED : SOCKET_DEAD);
52b84b
 
52b84b
diff --git a/src/core/swap.c b/src/core/swap.c
52b84b
index 66a62d8a37..b5926d8644 100644
52b84b
--- a/src/core/swap.c
52b84b
+++ b/src/core/swap.c
52b84b
@@ -657,7 +657,7 @@ static void swap_enter_dead(Swap *s, SwapResult f) {
52b84b
                 s->result = f;
52b84b
 
52b84b
         if (s->result != SWAP_SUCCESS)
52b84b
-                log_unit_warning(UNIT(s), "Failed with result '%s'.", swap_result_to_string(s->result));
52b84b
+                unit_log_failure(UNIT(s), swap_result_to_string(s->result));
52b84b
 
52b84b
         swap_set_state(s, s->result != SWAP_SUCCESS ? SWAP_FAILED : SWAP_DEAD);
52b84b
 
52b84b
diff --git a/src/core/timer.c b/src/core/timer.c
52b84b
index db202971d3..6ac310cbe0 100644
52b84b
--- a/src/core/timer.c
52b84b
+++ b/src/core/timer.c
52b84b
@@ -288,7 +288,7 @@ static void timer_enter_dead(Timer *t, TimerResult f) {
52b84b
                 t->result = f;
52b84b
 
52b84b
         if (t->result != TIMER_SUCCESS)
52b84b
-                log_unit_warning(UNIT(t), "Failed with result '%s'.", timer_result_to_string(t->result));
52b84b
+                unit_log_failure(UNIT(t), timer_result_to_string(t->result));
52b84b
 
52b84b
         timer_set_state(t, t->result != TIMER_SUCCESS ? TIMER_FAILED : TIMER_DEAD);
52b84b
 }
52b84b
diff --git a/src/core/unit.c b/src/core/unit.c
52b84b
index a4865c1da5..f55bddc00f 100644
52b84b
--- a/src/core/unit.c
52b84b
+++ b/src/core/unit.c
52b84b
@@ -5462,6 +5462,18 @@ int unit_pid_attachable(Unit *u, pid_t pid, sd_bus_error *error) {
52b84b
         return 0;
52b84b
 }
52b84b
 
52b84b
+void unit_log_failure(Unit *u, const char *result) {
52b84b
+        assert(u);
52b84b
+        assert(result);
52b84b
+
52b84b
+        log_struct(LOG_WARNING,
52b84b
+                   "MESSAGE_ID=" SD_MESSAGE_UNIT_FAILURE_RESULT_STR,
52b84b
+                   LOG_UNIT_ID(u),
52b84b
+                   LOG_UNIT_INVOCATION_ID(u),
52b84b
+                   LOG_UNIT_MESSAGE(u, "Failed with result '%s'.", result),
52b84b
+                   "UNIT_RESULT=%s", result);
52b84b
+}
52b84b
+
52b84b
 static const char* const collect_mode_table[_COLLECT_MODE_MAX] = {
52b84b
         [COLLECT_INACTIVE] = "inactive",
52b84b
         [COLLECT_INACTIVE_OR_FAILED] = "inactive-or-failed",
52b84b
diff --git a/src/core/unit.h b/src/core/unit.h
52b84b
index 4d9539790a..9d226fb3e0 100644
52b84b
--- a/src/core/unit.h
52b84b
+++ b/src/core/unit.h
52b84b
@@ -804,6 +804,8 @@ const char *unit_label_path(Unit *u);
52b84b
 
52b84b
 int unit_pid_attachable(Unit *unit, pid_t pid, sd_bus_error *error);
52b84b
 
52b84b
+void unit_log_failure(Unit *u, const char *result);
52b84b
+
52b84b
 /* Macros which append UNIT= or USER_UNIT= to the message */
52b84b
 
52b84b
 #define log_unit_full(unit, level, error, ...)                          \
52b84b
diff --git a/src/systemd/sd-messages.h b/src/systemd/sd-messages.h
52b84b
index 2adfe16062..846b28fc2b 100644
52b84b
--- a/src/systemd/sd-messages.h
52b84b
+++ b/src/systemd/sd-messages.h
52b84b
@@ -106,6 +106,10 @@ _SD_BEGIN_DECLARATIONS;
52b84b
 #define SD_MESSAGE_UNIT_RESOURCES         SD_ID128_MAKE(ae,8f,7b,86,6b,03,47,b9,af,31,fe,1c,80,b1,27,c0)
52b84b
 #define SD_MESSAGE_UNIT_RESOURCES_STR     SD_ID128_MAKE_STR(ae,8f,7b,86,6b,03,47,b9,af,31,fe,1c,80,b1,27,c0)
52b84b
 
52b84b
+#define SD_MESSAGE_UNIT_FAILURE_RESULT    SD_ID128_MAKE(d9,b3,73,ed,55,a6,4f,eb,82,42,e0,2d,be,79,a4,9c)
52b84b
+#define SD_MESSAGE_UNIT_FAILURE_RESULT_STR \
52b84b
+                                          SD_ID128_MAKE_STR(d9,b3,73,ed,55,a6,4f,eb,82,42,e0,2d,be,79,a4,9c)
52b84b
+
52b84b
 #define SD_MESSAGE_SPAWN_FAILED           SD_ID128_MAKE(64,12,57,65,1c,1b,4e,c9,a8,62,4d,7a,40,a9,e1,e7)
52b84b
 #define SD_MESSAGE_SPAWN_FAILED_STR       SD_ID128_MAKE_STR(64,12,57,65,1c,1b,4e,c9,a8,62,4d,7a,40,a9,e1,e7)
52b84b