2 This file is part of systemd.
4 Copyright 2011 Lennart Poettering
6 systemd is free software; you can redistribute it and/or modify it
7 under the terms of the GNU Lesser General Public License as published by
8 the Free Software Foundation; either version 2.1 of the License, or
9 (at your option) any later version.
11 systemd is distributed in the hope that it will be useful, but
12 WITHOUT ANY WARRANTY; without even the implied warranty of
13 MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE. See the GNU
14 Lesser General Public License for more details.
16 You should have received a copy of the GNU Lesser General Public License
17 along with systemd; If not, see <http://www.gnu.org/licenses/>.
24 #include <selinux/selinux.h>
27 #include "sd-daemon.h"
30 #include "alloc-util.h"
31 #include "dirent-util.h"
36 #include "journald-console.h"
37 #include "journald-context.h"
38 #include "journald-kmsg.h"
39 #include "journald-server.h"
40 #include "journald-stream.h"
41 #include "journald-syslog.h"
42 #include "journald-wall.h"
44 #include "parse-util.h"
45 #include "process-util.h"
46 #include "selinux-util.h"
47 #include "socket-util.h"
48 #include "stdio-util.h"
49 #include "string-util.h"
50 #include "syslog-util.h"
51 #include "unit-name.h"
53 #define STDOUT_STREAMS_MAX 4096
55 typedef enum StdoutStreamState
{
56 STDOUT_STREAM_IDENTIFIER
,
57 STDOUT_STREAM_UNIT_ID
,
58 STDOUT_STREAM_PRIORITY
,
59 STDOUT_STREAM_LEVEL_PREFIX
,
60 STDOUT_STREAM_FORWARD_TO_SYSLOG
,
61 STDOUT_STREAM_FORWARD_TO_KMSG
,
62 STDOUT_STREAM_FORWARD_TO_CONSOLE
,
66 /* The different types of log record terminators: a real \n was read, a NUL character was read, the maximum line length
67 * was reached, or the end of the stream was reached */
69 typedef enum LineBreak
{
78 StdoutStreamState state
;
88 bool forward_to_syslog
:1;
89 bool forward_to_kmsg
:1;
90 bool forward_to_console
:1;
93 bool in_notify_queue
:1;
99 sd_event_source
*event_source
;
103 ClientContext
*context
;
105 LIST_FIELDS(StdoutStream
, stdout_stream
);
106 LIST_FIELDS(StdoutStream
, stdout_stream_notify_queue
);
108 char id_field
[sizeof("_STREAM_ID=")-1 + SD_ID128_STRING_MAX
];
111 void stdout_stream_free(StdoutStream
*s
) {
118 client_context_release(s
->server
, s
->context
);
120 assert(s
->server
->n_stdout_streams
> 0);
121 s
->server
->n_stdout_streams
--;
122 LIST_REMOVE(stdout_stream
, s
->server
->stdout_streams
, s
);
124 if (s
->in_notify_queue
)
125 LIST_REMOVE(stdout_stream_notify_queue
, s
->server
->stdout_streams_notify_queue
, s
);
128 if (s
->event_source
) {
129 sd_event_source_set_enabled(s
->event_source
, SD_EVENT_OFF
);
130 s
->event_source
= sd_event_source_unref(s
->event_source
);
143 DEFINE_TRIVIAL_CLEANUP_FUNC(StdoutStream
*, stdout_stream_free
);
145 static void stdout_stream_destroy(StdoutStream
*s
) {
150 (void) unlink(s
->state_file
);
152 stdout_stream_free(s
);
155 static int stdout_stream_save(StdoutStream
*s
) {
156 _cleanup_free_
char *temp_path
= NULL
;
157 _cleanup_fclose_
FILE *f
= NULL
;
162 if (s
->state
!= STDOUT_STREAM_RUNNING
)
165 if (!s
->state_file
) {
168 r
= fstat(s
->fd
, &st
);
170 return log_warning_errno(errno
, "Failed to stat connected stream: %m");
172 /* We use device and inode numbers as identifier for the stream */
173 if (asprintf(&s
->state_file
, "/run/systemd/journal/streams/%lu:%lu", (unsigned long) st
.st_dev
, (unsigned long) st
.st_ino
) < 0)
177 mkdir_p("/run/systemd/journal/streams", 0755);
179 r
= fopen_temporary(s
->state_file
, &f
, &temp_path
);
184 "# This is private data. Do not parse\n"
187 "FORWARD_TO_SYSLOG=%i\n"
188 "FORWARD_TO_KMSG=%i\n"
189 "FORWARD_TO_CONSOLE=%i\n"
193 s
->forward_to_syslog
,
195 s
->forward_to_console
,
196 s
->id_field
+ strlen("_STREAM_ID="));
198 if (!isempty(s
->identifier
)) {
199 _cleanup_free_
char *escaped
;
201 escaped
= cescape(s
->identifier
);
207 fprintf(f
, "IDENTIFIER=%s\n", escaped
);
210 if (!isempty(s
->unit_id
)) {
211 _cleanup_free_
char *escaped
;
213 escaped
= cescape(s
->unit_id
);
219 fprintf(f
, "UNIT=%s\n", escaped
);
222 r
= fflush_and_check(f
);
226 if (rename(temp_path
, s
->state_file
) < 0) {
231 if (!s
->fdstore
&& !s
->in_notify_queue
) {
232 LIST_PREPEND(stdout_stream_notify_queue
, s
->server
->stdout_streams_notify_queue
, s
);
233 s
->in_notify_queue
= true;
235 if (s
->server
->notify_event_source
) {
236 r
= sd_event_source_set_enabled(s
->server
->notify_event_source
, SD_EVENT_ON
);
238 log_warning_errno(r
, "Failed to enable notify event source: %m");
245 (void) unlink(s
->state_file
);
248 (void) unlink(temp_path
);
250 return log_error_errno(r
, "Failed to save stream data %s: %m", s
->state_file
);
253 static int stdout_stream_log(StdoutStream
*s
, const char *p
, LineBreak line_break
) {
256 char syslog_priority
[] = "PRIORITY=\0";
257 char syslog_facility
[sizeof("SYSLOG_FACILITY=")-1 + DECIMAL_STR_MAX(int) + 1];
258 _cleanup_free_
char *message
= NULL
, *syslog_identifier
= NULL
;
266 (void) client_context_maybe_refresh(s
->server
, s
->context
, NULL
, NULL
, 0, NULL
, USEC_INFINITY
);
267 else if (pid_is_valid(s
->ucred
.pid
)) {
268 r
= client_context_acquire(s
->server
, s
->ucred
.pid
, &s
->ucred
, s
->label
, strlen_ptr(s
->label
), s
->unit_id
, &s
->context
);
270 log_warning_errno(r
, "Failed to acquire client context, ignoring: %m");
273 priority
= s
->priority
;
276 syslog_parse_priority(&p
, &priority
, false);
278 if (!client_context_test_priority(s
->context
, priority
))
284 if (s
->forward_to_syslog
|| s
->server
->forward_to_syslog
)
285 server_forward_syslog(s
->server
, syslog_fixup_facility(priority
), s
->identifier
, p
, &s
->ucred
, NULL
);
287 if (s
->forward_to_kmsg
|| s
->server
->forward_to_kmsg
)
288 server_forward_kmsg(s
->server
, priority
, s
->identifier
, p
, &s
->ucred
);
290 if (s
->forward_to_console
|| s
->server
->forward_to_console
)
291 server_forward_console(s
->server
, priority
, s
->identifier
, p
, &s
->ucred
);
293 if (s
->server
->forward_to_wall
)
294 server_forward_wall(s
->server
, priority
, s
->identifier
, p
, &s
->ucred
);
296 m
= N_IOVEC_META_FIELDS
+ 7 + client_context_extra_fields_n_iovec(s
->context
);
297 iovec
= newa(struct iovec
, m
);
299 iovec
[n
++] = IOVEC_MAKE_STRING("_TRANSPORT=stdout");
300 iovec
[n
++] = IOVEC_MAKE_STRING(s
->id_field
);
302 syslog_priority
[strlen("PRIORITY=")] = '0' + LOG_PRI(priority
);
303 iovec
[n
++] = IOVEC_MAKE_STRING(syslog_priority
);
305 if (priority
& LOG_FACMASK
) {
306 xsprintf(syslog_facility
, "SYSLOG_FACILITY=%i", LOG_FAC(priority
));
307 iovec
[n
++] = IOVEC_MAKE_STRING(syslog_facility
);
311 syslog_identifier
= strappend("SYSLOG_IDENTIFIER=", s
->identifier
);
312 if (syslog_identifier
)
313 iovec
[n
++] = IOVEC_MAKE_STRING(syslog_identifier
);
316 if (line_break
!= LINE_BREAK_NEWLINE
) {
319 /* If this log message was generated due to an uncommon line break then mention this in the log
322 c
= line_break
== LINE_BREAK_NUL
? "_LINE_BREAK=nul" :
323 line_break
== LINE_BREAK_LINE_MAX
? "_LINE_BREAK=line-max" :
325 iovec
[n
++] = IOVEC_MAKE_STRING(c
);
328 message
= strappend("MESSAGE=", p
);
330 iovec
[n
++] = IOVEC_MAKE_STRING(message
);
332 server_dispatch_message(s
->server
, iovec
, n
, m
, s
->context
, NULL
, priority
, 0);
336 static int stdout_stream_line(StdoutStream
*s
, char *p
, LineBreak line_break
) {
346 /* line breaks by NUL, line max length or EOF are not permissible during the negotiation part of the protocol */
347 if (line_break
!= LINE_BREAK_NEWLINE
&& s
->state
!= STDOUT_STREAM_RUNNING
) {
348 log_warning("Control protocol line not properly terminated.");
354 case STDOUT_STREAM_IDENTIFIER
:
356 s
->identifier
= strdup(p
);
361 s
->state
= STDOUT_STREAM_UNIT_ID
;
364 case STDOUT_STREAM_UNIT_ID
:
365 if (s
->ucred
.uid
== 0 &&
366 unit_name_is_valid(p
, UNIT_NAME_PLAIN
|UNIT_NAME_INSTANCE
)) {
368 s
->unit_id
= strdup(p
);
373 s
->state
= STDOUT_STREAM_PRIORITY
;
376 case STDOUT_STREAM_PRIORITY
:
377 r
= safe_atoi(p
, &s
->priority
);
378 if (r
< 0 || s
->priority
< 0 || s
->priority
> 999) {
379 log_warning("Failed to parse log priority line.");
383 s
->state
= STDOUT_STREAM_LEVEL_PREFIX
;
386 case STDOUT_STREAM_LEVEL_PREFIX
:
387 r
= parse_boolean(p
);
389 log_warning("Failed to parse level prefix line.");
393 s
->level_prefix
= !!r
;
394 s
->state
= STDOUT_STREAM_FORWARD_TO_SYSLOG
;
397 case STDOUT_STREAM_FORWARD_TO_SYSLOG
:
398 r
= parse_boolean(p
);
400 log_warning("Failed to parse forward to syslog line.");
404 s
->forward_to_syslog
= !!r
;
405 s
->state
= STDOUT_STREAM_FORWARD_TO_KMSG
;
408 case STDOUT_STREAM_FORWARD_TO_KMSG
:
409 r
= parse_boolean(p
);
411 log_warning("Failed to parse copy to kmsg line.");
415 s
->forward_to_kmsg
= !!r
;
416 s
->state
= STDOUT_STREAM_FORWARD_TO_CONSOLE
;
419 case STDOUT_STREAM_FORWARD_TO_CONSOLE
:
420 r
= parse_boolean(p
);
422 log_warning("Failed to parse copy to console line.");
426 s
->forward_to_console
= !!r
;
427 s
->state
= STDOUT_STREAM_RUNNING
;
429 /* Try to save the stream, so that journald can be restarted and we can recover */
430 (void) stdout_stream_save(s
);
433 case STDOUT_STREAM_RUNNING
:
434 return stdout_stream_log(s
, orig
, line_break
);
437 assert_not_reached("Unknown stream state");
440 static int stdout_stream_scan(StdoutStream
*s
, bool force_flush
) {
448 remaining
= s
->length
;
450 /* XXX: This function does nothing if (s->length == 0) */
453 LineBreak line_break
;
457 end1
= memchr(p
, '\n', remaining
);
458 end2
= memchr(p
, 0, end1
? (size_t) (end1
- p
) : remaining
);
461 /* We found a NUL terminator */
463 line_break
= LINE_BREAK_NUL
;
465 /* We found a \n terminator */
468 line_break
= LINE_BREAK_NEWLINE
;
469 } else if (remaining
>= s
->server
->line_max
) {
470 /* Force a line break after the maximum line length */
471 *(p
+ s
->server
->line_max
) = 0;
473 line_break
= LINE_BREAK_LINE_MAX
;
477 r
= stdout_stream_line(s
, p
, line_break
);
485 if (force_flush
&& remaining
> 0) {
487 r
= stdout_stream_line(s
, p
, LINE_BREAK_EOF
);
496 memmove(s
->buffer
, p
, remaining
);
497 s
->length
= remaining
;
503 static int stdout_stream_process(sd_event_source
*es
, int fd
, uint32_t revents
, void *userdata
) {
504 StdoutStream
*s
= userdata
;
511 if ((revents
|EPOLLIN
|EPOLLHUP
) != (EPOLLIN
|EPOLLHUP
)) {
512 log_error("Got invalid event from epoll for stdout stream: %"PRIx32
, revents
);
516 /* If the buffer is full already (discounting the extra NUL we need), add room for another 1K */
517 if (s
->length
+ 1 >= s
->allocated
) {
518 if (!GREEDY_REALLOC(s
->buffer
, s
->allocated
, s
->length
+ 1 + 1024)) {
524 /* Try to make use of the allocated buffer in full, but never read more than the configured line size. Also,
525 * always leave room for a terminating NUL we might need to add. */
526 limit
= MIN(s
->allocated
- 1, s
->server
->line_max
);
528 l
= read(s
->fd
, s
->buffer
+ s
->length
, limit
- s
->length
);
533 log_warning_errno(errno
, "Failed to read from stream: %m");
538 stdout_stream_scan(s
, true);
543 r
= stdout_stream_scan(s
, false);
550 stdout_stream_destroy(s
);
554 static int stdout_stream_install(Server
*s
, int fd
, StdoutStream
**ret
) {
555 _cleanup_(stdout_stream_freep
) StdoutStream
*stream
= NULL
;
562 r
= sd_id128_randomize(&id
);
564 return log_error_errno(r
, "Failed to generate stream ID: %m");
566 stream
= new0(StdoutStream
, 1);
571 stream
->priority
= LOG_INFO
;
573 xsprintf(stream
->id_field
, "_STREAM_ID=" SD_ID128_FORMAT_STR
, SD_ID128_FORMAT_VAL(id
));
575 r
= getpeercred(fd
, &stream
->ucred
);
577 return log_error_errno(r
, "Failed to determine peer credentials: %m");
579 if (mac_selinux_use()) {
580 r
= getpeersec(fd
, &stream
->label
);
581 if (r
< 0 && r
!= -EOPNOTSUPP
)
582 (void) log_warning_errno(r
, "Failed to determine peer security context: %m");
585 (void) shutdown(fd
, SHUT_WR
);
587 r
= sd_event_add_io(s
->event
, &stream
->event_source
, fd
, EPOLLIN
, stdout_stream_process
, stream
);
589 return log_error_errno(r
, "Failed to add stream to event loop: %m");
591 r
= sd_event_source_set_priority(stream
->event_source
, SD_EVENT_PRIORITY_NORMAL
+5);
593 return log_error_errno(r
, "Failed to adjust stdout event source priority: %m");
598 LIST_PREPEND(stdout_stream
, s
->stdout_streams
, stream
);
599 s
->n_stdout_streams
++;
609 static int stdout_stream_new(sd_event_source
*es
, int listen_fd
, uint32_t revents
, void *userdata
) {
610 _cleanup_close_
int fd
= -1;
611 Server
*s
= userdata
;
616 if (revents
!= EPOLLIN
) {
617 log_error("Got invalid event from epoll for stdout server fd: %"PRIx32
, revents
);
621 fd
= accept4(s
->stdout_fd
, NULL
, NULL
, SOCK_NONBLOCK
|SOCK_CLOEXEC
);
626 return log_error_errno(errno
, "Failed to accept stdout connection: %m");
629 if (s
->n_stdout_streams
>= STDOUT_STREAMS_MAX
) {
630 log_warning("Too many stdout streams, refusing connection.");
634 r
= stdout_stream_install(s
, fd
, NULL
);
642 static int stdout_stream_load(StdoutStream
*stream
, const char *fname
) {
645 *level_prefix
= NULL
,
646 *forward_to_syslog
= NULL
,
647 *forward_to_kmsg
= NULL
,
648 *forward_to_console
= NULL
,
655 if (!stream
->state_file
) {
656 stream
->state_file
= strappend("/run/systemd/journal/streams/", fname
);
657 if (!stream
->state_file
)
661 r
= parse_env_file(stream
->state_file
, NEWLINE
,
662 "PRIORITY", &priority
,
663 "LEVEL_PREFIX", &level_prefix
,
664 "FORWARD_TO_SYSLOG", &forward_to_syslog
,
665 "FORWARD_TO_KMSG", &forward_to_kmsg
,
666 "FORWARD_TO_CONSOLE", &forward_to_console
,
667 "IDENTIFIER", &stream
->identifier
,
668 "UNIT", &stream
->unit_id
,
669 "STREAM_ID", &stream_id
,
672 return log_error_errno(r
, "Failed to read: %s", stream
->state_file
);
677 p
= log_level_from_string(priority
);
679 stream
->priority
= p
;
683 r
= parse_boolean(level_prefix
);
685 stream
->level_prefix
= r
;
688 if (forward_to_syslog
) {
689 r
= parse_boolean(forward_to_syslog
);
691 stream
->forward_to_syslog
= r
;
694 if (forward_to_kmsg
) {
695 r
= parse_boolean(forward_to_kmsg
);
697 stream
->forward_to_kmsg
= r
;
700 if (forward_to_console
) {
701 r
= parse_boolean(forward_to_console
);
703 stream
->forward_to_console
= r
;
709 r
= sd_id128_from_string(stream_id
, &id
);
711 xsprintf(stream
->id_field
, "_STREAM_ID=" SD_ID128_FORMAT_STR
, SD_ID128_FORMAT_VAL(id
));
717 static int stdout_stream_restore(Server
*s
, const char *fname
, int fd
) {
718 StdoutStream
*stream
;
725 if (s
->n_stdout_streams
>= STDOUT_STREAMS_MAX
) {
726 log_warning("Too many stdout streams, refusing restoring of stream.");
730 r
= stdout_stream_install(s
, fd
, &stream
);
734 stream
->state
= STDOUT_STREAM_RUNNING
;
735 stream
->fdstore
= true;
737 /* Ignore all parsing errors */
738 (void) stdout_stream_load(stream
, fname
);
743 int server_restore_streams(Server
*s
, FDSet
*fds
) {
744 _cleanup_closedir_
DIR *d
= NULL
;
748 d
= opendir("/run/systemd/journal/streams");
753 return log_warning_errno(errno
, "Failed to enumerate /run/systemd/journal/streams: %m");
756 FOREACH_DIRENT(de
, d
, goto fail
) {
757 unsigned long st_dev
, st_ino
;
762 if (sscanf(de
->d_name
, "%lu:%lu", &st_dev
, &st_ino
) != 2)
765 FDSET_FOREACH(fd
, fds
, i
) {
768 if (fstat(fd
, &st
) < 0)
769 return log_error_errno(errno
, "Failed to stat %s: %m", de
->d_name
);
771 if (S_ISSOCK(st
.st_mode
) && st
.st_dev
== st_dev
&& st
.st_ino
== st_ino
) {
778 /* No file descriptor? Then let's delete the state file */
779 log_debug("Cannot restore stream file %s", de
->d_name
);
780 unlinkat(dirfd(d
), de
->d_name
, 0);
784 fdset_remove(fds
, fd
);
786 r
= stdout_stream_restore(s
, de
->d_name
, fd
);
794 return log_error_errno(errno
, "Failed to read streams directory: %m");
797 int server_open_stdout_socket(Server
*s
) {
798 static const union sockaddr_union sa
= {
799 .un
.sun_family
= AF_UNIX
,
800 .un
.sun_path
= "/run/systemd/journal/stdout",
806 if (s
->stdout_fd
< 0) {
807 s
->stdout_fd
= socket(AF_UNIX
, SOCK_STREAM
|SOCK_CLOEXEC
|SOCK_NONBLOCK
, 0);
808 if (s
->stdout_fd
< 0)
809 return log_error_errno(errno
, "socket() failed: %m");
811 (void) unlink(sa
.un
.sun_path
);
813 r
= bind(s
->stdout_fd
, &sa
.sa
, SOCKADDR_UN_LEN(sa
.un
));
815 return log_error_errno(errno
, "bind(%s) failed: %m", sa
.un
.sun_path
);
817 (void) chmod(sa
.un
.sun_path
, 0666);
819 if (listen(s
->stdout_fd
, SOMAXCONN
) < 0)
820 return log_error_errno(errno
, "listen(%s) failed: %m", sa
.un
.sun_path
);
822 fd_nonblock(s
->stdout_fd
, 1);
824 r
= sd_event_add_io(s
->event
, &s
->stdout_event_source
, s
->stdout_fd
, EPOLLIN
, stdout_stream_new
, s
);
826 return log_error_errno(r
, "Failed to add stdout server fd to event source: %m");
828 r
= sd_event_source_set_priority(s
->stdout_event_source
, SD_EVENT_PRIORITY_NORMAL
+5);
830 return log_error_errno(r
, "Failed to adjust priority of stdout server event source: %m");
835 void stdout_stream_send_notify(StdoutStream
*s
) {
836 struct iovec iovec
= {
837 .iov_base
= (char*) "FDSTORE=1",
838 .iov_len
= strlen("FDSTORE=1"),
840 struct msghdr msghdr
= {
844 struct cmsghdr
*cmsg
;
849 assert(s
->in_notify_queue
);
851 assert(s
->server
->notify_fd
>= 0);
853 /* Store the connection fd in PID 1, so that we get it passed
854 * in again on next start */
856 msghdr
.msg_controllen
= CMSG_SPACE(sizeof(int));
857 msghdr
.msg_control
= alloca0(msghdr
.msg_controllen
);
859 cmsg
= CMSG_FIRSTHDR(&msghdr
);
860 cmsg
->cmsg_level
= SOL_SOCKET
;
861 cmsg
->cmsg_type
= SCM_RIGHTS
;
862 cmsg
->cmsg_len
= CMSG_LEN(sizeof(int));
864 memcpy(CMSG_DATA(cmsg
), &s
->fd
, sizeof(int));
866 l
= sendmsg(s
->server
->notify_fd
, &msghdr
, MSG_DONTWAIT
|MSG_NOSIGNAL
);
871 log_error_errno(errno
, "Failed to send stream file descriptor to service manager: %m");
873 log_debug("Successfully sent stream file descriptor to service manager.");
877 LIST_REMOVE(stdout_stream_notify_queue
, s
->server
->stdout_streams_notify_queue
, s
);
878 s
->in_notify_queue
= false;