]> git.ipfire.org Git - thirdparty/systemd.git/blame - src/journal/journald-stream.c
sd-event: re-check new epoll events when a child event is queued
[thirdparty/systemd.git] / src / journal / journald-stream.c
CommitLineData
db9ecf05 1/* SPDX-License-Identifier: LGPL-2.1-or-later */
a45b9fca 2
4871690d 3#include <stddef.h>
07630cea 4#include <unistd.h>
a45b9fca 5
349cc4a5 6#if HAVE_SELINUX
a45b9fca
LP
7#include <selinux/selinux.h>
8#endif
9
13790add 10#include "sd-daemon.h"
4f5dd394
LP
11#include "sd-event.h"
12
b5efdb8a 13#include "alloc-util.h"
a0956174 14#include "dirent-util.h"
686d13b9 15#include "env-file.h"
4ff9bc2e 16#include "errno-util.h"
4f5dd394 17#include "escape.h"
3ffd4af2 18#include "fd-util.h"
13790add 19#include "fileio.h"
a30e35f8 20#include "fs-util.h"
afc5dbf3 21#include "io-util.h"
4f5dd394 22#include "journald-console.h"
22e3a02b 23#include "journald-context.h"
4f5dd394 24#include "journald-kmsg.h"
d025f1e4 25#include "journald-server.h"
3ffd4af2 26#include "journald-stream.h"
a45b9fca 27#include "journald-syslog.h"
40b71e89 28#include "journald-wall.h"
4f5dd394 29#include "mkdir.h"
6bedfcbb 30#include "parse-util.h"
22e3a02b 31#include "process-util.h"
4f5dd394
LP
32#include "selinux-util.h"
33#include "socket-util.h"
15a5e950 34#include "stdio-util.h"
07630cea 35#include "string-util.h"
7ccbd1ae 36#include "syslog-util.h"
e4de7287 37#include "tmpfile-util.h"
7a1f1aaa 38#include "unit-name.h"
a45b9fca
LP
39
40#define STDOUT_STREAMS_MAX 4096
41
42typedef enum StdoutStreamState {
43 STDOUT_STREAM_IDENTIFIER,
44 STDOUT_STREAM_UNIT_ID,
45 STDOUT_STREAM_PRIORITY,
46 STDOUT_STREAM_LEVEL_PREFIX,
47 STDOUT_STREAM_FORWARD_TO_SYSLOG,
48 STDOUT_STREAM_FORWARD_TO_KMSG,
49 STDOUT_STREAM_FORWARD_TO_CONSOLE,
50 STDOUT_STREAM_RUNNING
51} StdoutStreamState;
52
ec20fe5f
LP
53/* The different types of log record terminators: a real \n was read, a NUL character was read, the maximum line length
54 * was reached, or the end of the stream was reached */
55
56typedef enum LineBreak {
57 LINE_BREAK_NEWLINE,
58 LINE_BREAK_NUL,
59 LINE_BREAK_LINE_MAX,
60 LINE_BREAK_EOF,
45ba1ea5 61 LINE_BREAK_PID_CHANGE,
549b7379 62 _LINE_BREAK_MAX,
2d93c20e 63 _LINE_BREAK_INVALID = -EINVAL,
ec20fe5f
LP
64} LineBreak;
65
a45b9fca
LP
66struct StdoutStream {
67 Server *server;
68 StdoutStreamState state;
69
70 int fd;
71
72 struct ucred ucred;
2de56f70 73 char *label;
a45b9fca
LP
74 char *identifier;
75 char *unit_id;
76 int priority;
77 bool level_prefix:1;
78 bool forward_to_syslog:1;
79 bool forward_to_kmsg:1;
80 bool forward_to_console:1;
81
13790add 82 bool fdstore:1;
e22aa3d3 83 bool in_notify_queue:1;
13790add 84
ec20fe5f 85 char *buffer;
a45b9fca 86 size_t length;
ec20fe5f 87 size_t allocated;
a45b9fca 88
f9a810be
LP
89 sd_event_source *event_source;
90
13790add
LP
91 char *state_file;
92
22e3a02b
LP
93 ClientContext *context;
94
a45b9fca 95 LIST_FIELDS(StdoutStream, stdout_stream);
e22aa3d3 96 LIST_FIELDS(StdoutStream, stdout_stream_notify_queue);
ec20fe5f 97
fbd0b64f 98 char id_field[STRLEN("_STREAM_ID=") + SD_ID128_STRING_MAX];
a45b9fca
LP
99};
100
75db809a 101StdoutStream* stdout_stream_free(StdoutStream *s) {
13790add 102 if (!s)
75db809a 103 return NULL;
13790add
LP
104
105 if (s->server) {
22e3a02b
LP
106
107 if (s->context)
108 client_context_release(s->server, s->context);
109
13790add 110 assert(s->server->n_stdout_streams > 0);
313cefa1 111 s->server->n_stdout_streams--;
13790add 112 LIST_REMOVE(stdout_stream, s->server->stdout_streams, s);
e22aa3d3
LP
113
114 if (s->in_notify_queue)
115 LIST_REMOVE(stdout_stream_notify_queue, s->server->stdout_streams_notify_queue, s);
65c398c0
LP
116
117 (void) server_start_or_stop_idle_timer(s->server); /* Maybe we are idle now? */
13790add
LP
118 }
119
120 if (s->event_source) {
121 sd_event_source_set_enabled(s->event_source, SD_EVENT_OFF);
122 s->event_source = sd_event_source_unref(s->event_source);
123 }
124
125 safe_close(s->fd);
2de56f70 126 free(s->label);
13790add
LP
127 free(s->identifier);
128 free(s->unit_id);
129 free(s->state_file);
ec20fe5f 130 free(s->buffer);
13790add 131
75db809a 132 return mfree(s);
13790add
LP
133}
134
135DEFINE_TRIVIAL_CLEANUP_FUNC(StdoutStream*, stdout_stream_free);
136
9541f5ff 137void stdout_stream_destroy(StdoutStream *s) {
13790add
LP
138 if (!s)
139 return;
140
141 if (s->state_file)
e22aa3d3 142 (void) unlink(s->state_file);
13790add
LP
143
144 stdout_stream_free(s);
145}
146
147static int stdout_stream_save(StdoutStream *s) {
a30e35f8 148 _cleanup_(unlink_and_freep) char *temp_path = NULL;
13790add
LP
149 _cleanup_fclose_ FILE *f = NULL;
150 int r;
151
152 assert(s);
153
154 if (s->state != STDOUT_STREAM_RUNNING)
155 return 0;
156
157 if (!s->state_file) {
158 struct stat st;
159
160 r = fstat(s->fd, &st);
161 if (r < 0)
162 return log_warning_errno(errno, "Failed to stat connected stream: %m");
163
164 /* We use device and inode numbers as identifier for the stream */
b1852c48
LP
165 r = asprintf(&s->state_file, "%s/streams/%lu:%lu", s->server->runtime_directory, (unsigned long) st.st_dev, (unsigned long) st.st_ino);
166 if (r < 0)
13790add
LP
167 return log_oom();
168 }
169
b1852c48 170 (void) mkdir_parents(s->state_file, 0755);
13790add
LP
171
172 r = fopen_temporary(s->state_file, &f, &temp_path);
173 if (r < 0)
dacd6cee 174 goto fail;
13790add
LP
175
176 fprintf(f,
177 "# This is private data. Do not parse\n"
178 "PRIORITY=%i\n"
179 "LEVEL_PREFIX=%i\n"
180 "FORWARD_TO_SYSLOG=%i\n"
181 "FORWARD_TO_KMSG=%i\n"
ec20fe5f
LP
182 "FORWARD_TO_CONSOLE=%i\n"
183 "STREAM_ID=%s\n",
13790add
LP
184 s->priority,
185 s->level_prefix,
186 s->forward_to_syslog,
187 s->forward_to_kmsg,
ec20fe5f 188 s->forward_to_console,
fbd0b64f 189 s->id_field + STRLEN("_STREAM_ID="));
13790add
LP
190
191 if (!isempty(s->identifier)) {
192 _cleanup_free_ char *escaped;
193
194 escaped = cescape(s->identifier);
195 if (!escaped) {
196 r = -ENOMEM;
dacd6cee 197 goto fail;
13790add
LP
198 }
199
200 fprintf(f, "IDENTIFIER=%s\n", escaped);
201 }
202
203 if (!isempty(s->unit_id)) {
204 _cleanup_free_ char *escaped;
205
206 escaped = cescape(s->unit_id);
207 if (!escaped) {
208 r = -ENOMEM;
dacd6cee 209 goto fail;
13790add
LP
210 }
211
212 fprintf(f, "UNIT=%s\n", escaped);
213 }
214
215 r = fflush_and_check(f);
216 if (r < 0)
dacd6cee 217 goto fail;
13790add
LP
218
219 if (rename(temp_path, s->state_file) < 0) {
220 r = -errno;
dacd6cee 221 goto fail;
13790add
LP
222 }
223
a30e35f8
LP
224 temp_path = mfree(temp_path);
225
e22aa3d3
LP
226 if (!s->fdstore && !s->in_notify_queue) {
227 LIST_PREPEND(stdout_stream_notify_queue, s->server->stdout_streams_notify_queue, s);
228 s->in_notify_queue = true;
229
230 if (s->server->notify_event_source) {
231 r = sd_event_source_set_enabled(s->server->notify_event_source, SD_EVENT_ON);
232 if (r < 0)
233 log_warning_errno(r, "Failed to enable notify event source: %m");
234 }
13790add
LP
235 }
236
dacd6cee 237 return 0;
13790add 238
dacd6cee
LP
239fail:
240 (void) unlink(s->state_file);
dacd6cee 241 return log_error_errno(r, "Failed to save stream data %s: %m", s->state_file);
13790add
LP
242}
243
549b7379
LP
244static int stdout_stream_log(
245 StdoutStream *s,
246 const char *p,
247 LineBreak line_break) {
248
d3070fbd 249 struct iovec *iovec;
a45b9fca 250 int priority;
e3bfb7be 251 char syslog_priority[] = "PRIORITY=\0";
fbd0b64f 252 char syslog_facility[STRLEN("SYSLOG_FACILITY=") + DECIMAL_STR_MAX(int) + 1];
e3bfb7be 253 _cleanup_free_ char *message = NULL, *syslog_identifier = NULL;
d3070fbd 254 size_t n = 0, m;
22e3a02b 255 int r;
a45b9fca
LP
256
257 assert(s);
258 assert(p);
259
549b7379
LP
260 assert(line_break >= 0);
261 assert(line_break < _LINE_BREAK_MAX);
262
d3070fbd
LP
263 if (s->context)
264 (void) client_context_maybe_refresh(s->server, s->context, NULL, NULL, 0, NULL, USEC_INFINITY);
265 else if (pid_is_valid(s->ucred.pid)) {
266 r = client_context_acquire(s->server, s->ucred.pid, &s->ucred, s->label, strlen_ptr(s->label), s->unit_id, &s->context);
267 if (r < 0)
268 log_warning_errno(r, "Failed to acquire client context, ignoring: %m");
269 }
270
a45b9fca
LP
271 priority = s->priority;
272
273 if (s->level_prefix)
e3bfb7be 274 syslog_parse_priority(&p, &priority, false);
a45b9fca 275
d3070fbd
LP
276 if (!client_context_test_priority(s->context, priority))
277 return 0;
278
6f526243
EV
279 if (isempty(p))
280 return 0;
281
a45b9fca
LP
282 if (s->forward_to_syslog || s->server->forward_to_syslog)
283 server_forward_syslog(s->server, syslog_fixup_facility(priority), s->identifier, p, &s->ucred, NULL);
284
285 if (s->forward_to_kmsg || s->server->forward_to_kmsg)
286 server_forward_kmsg(s->server, priority, s->identifier, p, &s->ucred);
287
288 if (s->forward_to_console || s->server->forward_to_console)
289 server_forward_console(s->server, priority, s->identifier, p, &s->ucred);
290
40b71e89
ST
291 if (s->server->forward_to_wall)
292 server_forward_wall(s->server, priority, s->identifier, p, &s->ucred);
293
d3070fbd
LP
294 m = N_IOVEC_META_FIELDS + 7 + client_context_extra_fields_n_iovec(s->context);
295 iovec = newa(struct iovec, m);
296
e6a7ec4b
LP
297 iovec[n++] = IOVEC_MAKE_STRING("_TRANSPORT=stdout");
298 iovec[n++] = IOVEC_MAKE_STRING(s->id_field);
ec20fe5f 299
fbd0b64f 300 syslog_priority[STRLEN("PRIORITY=")] = '0' + LOG_PRI(priority);
e6a7ec4b 301 iovec[n++] = IOVEC_MAKE_STRING(syslog_priority);
a45b9fca 302
e3bfb7be 303 if (priority & LOG_FACMASK) {
5ffa8c81 304 xsprintf(syslog_facility, "SYSLOG_FACILITY=%i", LOG_FAC(priority));
e6a7ec4b 305 iovec[n++] = IOVEC_MAKE_STRING(syslog_facility);
e3bfb7be 306 }
a45b9fca
LP
307
308 if (s->identifier) {
b910cc72 309 syslog_identifier = strjoin("SYSLOG_IDENTIFIER=", s->identifier);
a45b9fca 310 if (syslog_identifier)
e6a7ec4b 311 iovec[n++] = IOVEC_MAKE_STRING(syslog_identifier);
a45b9fca
LP
312 }
313
549b7379
LP
314 static const char * const line_break_field_table[_LINE_BREAK_MAX] = {
315 [LINE_BREAK_NEWLINE] = NULL, /* Do not add field if traditional newline */
316 [LINE_BREAK_NUL] = "_LINE_BREAK=nul",
317 [LINE_BREAK_LINE_MAX] = "_LINE_BREAK=line-max",
318 [LINE_BREAK_EOF] = "_LINE_BREAK=eof",
45ba1ea5 319 [LINE_BREAK_PID_CHANGE] = "_LINE_BREAK=pid-change",
549b7379 320 };
ec20fe5f 321
549b7379 322 const char *c = line_break_field_table[line_break];
ec20fe5f 323
549b7379
LP
324 /* If this log message was generated due to an uncommon line break then mention this in the log
325 * entry */
326 if (c)
e6a7ec4b 327 iovec[n++] = IOVEC_MAKE_STRING(c);
ec20fe5f 328
b910cc72 329 message = strjoin("MESSAGE=", p);
a45b9fca 330 if (message)
e6a7ec4b 331 iovec[n++] = IOVEC_MAKE_STRING(message);
a45b9fca 332
d3070fbd 333 server_dispatch_message(s->server, iovec, n, m, s->context, NULL, priority, 0);
a45b9fca
LP
334 return 0;
335}
336
ec20fe5f 337static int stdout_stream_line(StdoutStream *s, char *p, LineBreak line_break) {
cfa1b98e 338 char *orig;
5fe7fb0b 339 int r;
a45b9fca
LP
340
341 assert(s);
342 assert(p);
343
cfa1b98e 344 orig = p;
a45b9fca
LP
345 p = strstrip(p);
346
ec20fe5f 347 /* line breaks by NUL, line max length or EOF are not permissible during the negotiation part of the protocol */
5fe7fb0b
LP
348 if (line_break != LINE_BREAK_NEWLINE && s->state != STDOUT_STREAM_RUNNING)
349 return log_warning_errno(SYNTHETIC_ERRNO(EINVAL),
350 "Control protocol line not properly terminated.");
ec20fe5f 351
a45b9fca
LP
352 switch (s->state) {
353
354 case STDOUT_STREAM_IDENTIFIER:
7a1f1aaa 355 if (!isempty(p)) {
a45b9fca
LP
356 s->identifier = strdup(p);
357 if (!s->identifier)
358 return log_oom();
359 }
360
361 s->state = STDOUT_STREAM_UNIT_ID;
362 return 0;
363
364 case STDOUT_STREAM_UNIT_ID:
7a1f1aaa
LP
365 if (s->ucred.uid == 0 &&
366 unit_name_is_valid(p, UNIT_NAME_PLAIN|UNIT_NAME_INSTANCE)) {
367
368 s->unit_id = strdup(p);
369 if (!s->unit_id)
370 return log_oom();
a45b9fca
LP
371 }
372
373 s->state = STDOUT_STREAM_PRIORITY;
374 return 0;
375
376 case STDOUT_STREAM_PRIORITY:
377 r = safe_atoi(p, &s->priority);
41891700 378 if (r < 0 || s->priority < 0 || s->priority > 999) {
a45b9fca
LP
379 log_warning("Failed to parse log priority line.");
380 return -EINVAL;
381 }
382
383 s->state = STDOUT_STREAM_LEVEL_PREFIX;
384 return 0;
385
386 case STDOUT_STREAM_LEVEL_PREFIX:
387 r = parse_boolean(p);
388 if (r < 0) {
389 log_warning("Failed to parse level prefix line.");
390 return -EINVAL;
391 }
392
5d904a6a 393 s->level_prefix = r;
a45b9fca
LP
394 s->state = STDOUT_STREAM_FORWARD_TO_SYSLOG;
395 return 0;
396
397 case STDOUT_STREAM_FORWARD_TO_SYSLOG:
398 r = parse_boolean(p);
399 if (r < 0) {
400 log_warning("Failed to parse forward to syslog line.");
401 return -EINVAL;
402 }
403
5d904a6a 404 s->forward_to_syslog = r;
a45b9fca
LP
405 s->state = STDOUT_STREAM_FORWARD_TO_KMSG;
406 return 0;
407
408 case STDOUT_STREAM_FORWARD_TO_KMSG:
409 r = parse_boolean(p);
410 if (r < 0) {
411 log_warning("Failed to parse copy to kmsg line.");
412 return -EINVAL;
413 }
414
5d904a6a 415 s->forward_to_kmsg = r;
a45b9fca
LP
416 s->state = STDOUT_STREAM_FORWARD_TO_CONSOLE;
417 return 0;
418
419 case STDOUT_STREAM_FORWARD_TO_CONSOLE:
420 r = parse_boolean(p);
421 if (r < 0) {
422 log_warning("Failed to parse copy to console line.");
423 return -EINVAL;
424 }
425
5d904a6a 426 s->forward_to_console = r;
a45b9fca 427 s->state = STDOUT_STREAM_RUNNING;
13790add
LP
428
429 /* Try to save the stream, so that journald can be restarted and we can recover */
430 (void) stdout_stream_save(s);
a45b9fca
LP
431 return 0;
432
433 case STDOUT_STREAM_RUNNING:
ec20fe5f 434 return stdout_stream_log(s, orig, line_break);
a45b9fca
LP
435 }
436
437 assert_not_reached("Unknown stream state");
438}
439
45ba1ea5
LP
440static int stdout_stream_found(
441 StdoutStream *s,
442 char *p,
443 size_t l,
444 LineBreak line_break) {
445
446 char saved;
a45b9fca
LP
447 int r;
448
449 assert(s);
45ba1ea5
LP
450 assert(p);
451
452 /* Let's NUL terminate the specified buffer for this call, and revert back afterwards */
453 saved = p[l];
454 p[l] = 0;
455 r = stdout_stream_line(s, p, line_break);
456 p[l] = saved;
a45b9fca 457
45ba1ea5
LP
458 return r;
459}
460
461static int stdout_stream_scan(
462 StdoutStream *s,
463 char *p,
464 size_t remaining,
465 LineBreak force_flush,
466 size_t *ret_consumed) {
95cbb83c 467
45ba1ea5
LP
468 size_t consumed = 0;
469 int r;
470
471 assert(s);
472 assert(p);
95cbb83c 473
a45b9fca 474 for (;;) {
ec20fe5f 475 LineBreak line_break;
45ba1ea5 476 size_t skip, found;
ec20fe5f
LP
477 char *end1, *end2;
478
479 end1 = memchr(p, '\n', remaining);
480 end2 = memchr(p, 0, end1 ? (size_t) (end1 - p) : remaining);
481
482 if (end2) {
483 /* We found a NUL terminator */
45ba1ea5
LP
484 found = end2 - p;
485 skip = found + 1;
ec20fe5f
LP
486 line_break = LINE_BREAK_NUL;
487 } else if (end1) {
488 /* We found a \n terminator */
45ba1ea5
LP
489 found = end1 - p;
490 skip = found + 1;
ec20fe5f
LP
491 line_break = LINE_BREAK_NEWLINE;
492 } else if (remaining >= s->server->line_max) {
493 /* Force a line break after the maximum line length */
45ba1ea5 494 found = skip = s->server->line_max;
ec20fe5f 495 line_break = LINE_BREAK_LINE_MAX;
a45b9fca
LP
496 } else
497 break;
498
45ba1ea5 499 r = stdout_stream_found(s, p, found, line_break);
a45b9fca
LP
500 if (r < 0)
501 return r;
502
a45b9fca 503 p += skip;
45ba1ea5
LP
504 consumed += skip;
505 remaining -= skip;
a45b9fca
LP
506 }
507
45ba1ea5
LP
508 if (force_flush >= 0 && remaining > 0) {
509 r = stdout_stream_found(s, p, remaining, force_flush);
a45b9fca
LP
510 if (r < 0)
511 return r;
512
45ba1ea5 513 consumed += remaining;
a45b9fca
LP
514 }
515
45ba1ea5
LP
516 if (ret_consumed)
517 *ret_consumed = consumed;
a45b9fca
LP
518
519 return 0;
520}
521
f9a810be 522static int stdout_stream_process(sd_event_source *es, int fd, uint32_t revents, void *userdata) {
fb29cdbe 523 CMSG_BUFFER_TYPE(CMSG_SPACE(sizeof(struct ucred))) control;
f9a810be 524 StdoutStream *s = userdata;
45ba1ea5 525 size_t limit, consumed;
371d72e0 526 struct ucred *ucred;
09d0b46a 527 struct iovec iovec;
a45b9fca 528 ssize_t l;
45ba1ea5 529 char *p;
a45b9fca
LP
530 int r;
531
09d0b46a
LB
532 struct msghdr msghdr = {
533 .msg_iov = &iovec,
534 .msg_iovlen = 1,
fb29cdbe
LP
535 .msg_control = &control,
536 .msg_controllen = sizeof(control),
09d0b46a
LB
537 };
538
a45b9fca
LP
539 assert(s);
540
f9a810be
LP
541 if ((revents|EPOLLIN|EPOLLHUP) != (EPOLLIN|EPOLLHUP)) {
542 log_error("Got invalid event from epoll for stdout stream: %"PRIx32, revents);
91bf3b3e 543 goto terminate;
f9a810be
LP
544 }
545
034e9719
BR
546 /* If the buffer is almost full, add room for another 1K */
547 if (s->length + 512 >= s->allocated) {
ec20fe5f
LP
548 if (!GREEDY_REALLOC(s->buffer, s->allocated, s->length + 1 + 1024)) {
549 log_oom();
550 goto terminate;
551 }
552 }
a45b9fca 553
ec20fe5f
LP
554 /* Try to make use of the allocated buffer in full, but never read more than the configured line size. Also,
555 * always leave room for a terminating NUL we might need to add. */
556 limit = MIN(s->allocated - 1, s->server->line_max);
45ba1ea5 557 assert(s->length <= limit);
09d0b46a
LB
558 iovec = IOVEC_MAKE(s->buffer + s->length, limit - s->length);
559
560 l = recvmsg(s->fd, &msghdr, MSG_DONTWAIT|MSG_CMSG_CLOEXEC);
ec20fe5f 561 if (l < 0) {
09d0b46a 562 if (IN_SET(errno, EINTR, EAGAIN))
a45b9fca
LP
563 return 0;
564
56f64d95 565 log_warning_errno(errno, "Failed to read from stream: %m");
91bf3b3e 566 goto terminate;
a45b9fca 567 }
09d0b46a 568 cmsg_close_all(&msghdr);
a45b9fca
LP
569
570 if (l == 0) {
45ba1ea5 571 (void) stdout_stream_scan(s, s->buffer, s->length, /* force_flush = */ LINE_BREAK_EOF, NULL);
91bf3b3e 572 goto terminate;
a45b9fca
LP
573 }
574
45ba1ea5
LP
575 /* Invalidate the context if the PID of the sender changed. This happens when a forked process
576 * inherits stdout/stderr from a parent. In this case getpeercred() returns the ucred of the parent,
577 * which can be invalid if the parent has exited in the meantime. */
371d72e0 578 ucred = CMSG_FIND_DATA(&msghdr, SOL_SOCKET, SCM_CREDENTIALS, struct ucred);
09d0b46a 579 if (ucred && ucred->pid != s->ucred.pid) {
45ba1ea5 580 /* Force out any previously half-written lines from a different process, before we switch to
371d72e0 581 * the new ucred structure for everything we just added */
45ba1ea5 582 r = stdout_stream_scan(s, s->buffer, s->length, /* force_flush = */ LINE_BREAK_PID_CHANGE, NULL);
09d0b46a
LB
583 if (r < 0)
584 goto terminate;
585
020b4a02 586 s->context = client_context_release(s->server, s->context);
45ba1ea5
LP
587
588 p = s->buffer + s->length;
589 } else {
590 p = s->buffer;
591 l += s->length;
09d0b46a
LB
592 }
593
45ba1ea5
LP
594 /* Always copy in the new credentials */
595 if (ucred)
596 s->ucred = *ucred;
597
598 r = stdout_stream_scan(s, p, l, _LINE_BREAK_INVALID, &consumed);
a45b9fca 599 if (r < 0)
91bf3b3e 600 goto terminate;
a45b9fca 601
45ba1ea5
LP
602 /* Move what wasn't consumed to the front of the buffer */
603 assert(consumed <= (size_t) l);
604 s->length = l - consumed;
605 memmove(s->buffer, p + consumed, s->length);
606
a45b9fca
LP
607 return 1;
608
91bf3b3e 609terminate:
13790add 610 stdout_stream_destroy(s);
f9a810be 611 return 0;
a45b9fca
LP
612}
613
9541f5ff 614int stdout_stream_install(Server *s, int fd, StdoutStream **ret) {
13790add 615 _cleanup_(stdout_stream_freep) StdoutStream *stream = NULL;
ec20fe5f 616 sd_id128_t id;
13790add
LP
617 int r;
618
a45b9fca 619 assert(s);
13790add 620 assert(fd >= 0);
a45b9fca 621
ec20fe5f
LP
622 r = sd_id128_randomize(&id);
623 if (r < 0)
624 return log_error_errno(r, "Failed to generate stream ID: %m");
625
d98580e4 626 stream = new(StdoutStream, 1);
13790add
LP
627 if (!stream)
628 return log_oom();
a45b9fca 629
d98580e4
LP
630 *stream = (StdoutStream) {
631 .fd = -1,
632 .priority = LOG_INFO,
633 };
a45b9fca 634
ec20fe5f
LP
635 xsprintf(stream->id_field, "_STREAM_ID=" SD_ID128_FORMAT_STR, SD_ID128_FORMAT_VAL(id));
636
13790add
LP
637 r = getpeercred(fd, &stream->ucred);
638 if (r < 0)
639 return log_error_errno(r, "Failed to determine peer credentials: %m");
a45b9fca 640
09d0b46a
LB
641 r = setsockopt_int(fd, SOL_SOCKET, SO_PASSCRED, true);
642 if (r < 0)
643 return log_error_errno(r, "SO_PASSCRED failed: %m");
644
6d395665 645 if (mac_selinux_use()) {
2de56f70
ZJS
646 r = getpeersec(fd, &stream->label);
647 if (r < 0 && r != -EOPNOTSUPP)
648 (void) log_warning_errno(r, "Failed to determine peer security context: %m");
13790add 649 }
a45b9fca 650
13790add
LP
651 (void) shutdown(fd, SHUT_WR);
652
653 r = sd_event_add_io(s->event, &stream->event_source, fd, EPOLLIN, stdout_stream_process, stream);
654 if (r < 0)
655 return log_error_errno(r, "Failed to add stream to event loop: %m");
656
657 r = sd_event_source_set_priority(stream->event_source, SD_EVENT_PRIORITY_NORMAL+5);
658 if (r < 0)
659 return log_error_errno(r, "Failed to adjust stdout event source priority: %m");
660
661 stream->fd = fd;
662
663 stream->server = s;
664 LIST_PREPEND(stdout_stream, s->stdout_streams, stream);
313cefa1 665 s->n_stdout_streams++;
13790add 666
65c398c0
LP
667 (void) server_start_or_stop_idle_timer(s); /* Maybe no longer idle? */
668
13790add
LP
669 if (ret)
670 *ret = stream;
671
7e7ef3bf 672 TAKE_PTR(stream);
13790add 673 return 0;
a45b9fca
LP
674}
675
f9a810be 676static int stdout_stream_new(sd_event_source *es, int listen_fd, uint32_t revents, void *userdata) {
13790add 677 _cleanup_close_ int fd = -1;
f9a810be 678 Server *s = userdata;
13790add 679 int r;
a45b9fca
LP
680
681 assert(s);
682
baaa35ad
ZJS
683 if (revents != EPOLLIN)
684 return log_error_errno(SYNTHETIC_ERRNO(EIO),
685 "Got invalid event from epoll for stdout server fd: %" PRIx32,
686 revents);
f9a810be 687
a45b9fca
LP
688 fd = accept4(s->stdout_fd, NULL, NULL, SOCK_NONBLOCK|SOCK_CLOEXEC);
689 if (fd < 0) {
4ff9bc2e 690 if (ERRNO_IS_ACCEPT_AGAIN(errno))
a45b9fca
LP
691 return 0;
692
e1427b13 693 return log_error_errno(errno, "Failed to accept stdout connection: %m");
a45b9fca
LP
694 }
695
696 if (s->n_stdout_streams >= STDOUT_STREAMS_MAX) {
c8758e72
EV
697 struct ucred u;
698
699 r = getpeercred(fd, &u);
700
701 /* By closing fd here we make sure that the client won't wait too long for journald to
702 * gather all the data it adds to the error message to find out that the connection has
703 * just been refused.
704 */
705 fd = safe_close(fd);
706
707 server_driver_message(s, r < 0 ? 0 : u.pid, NULL, LOG_MESSAGE("Too many stdout streams, refusing connection."), NULL);
a45b9fca
LP
708 return 0;
709 }
710
13790add
LP
711 r = stdout_stream_install(s, fd, NULL);
712 if (r < 0)
713 return r;
714
7e7ef3bf 715 TAKE_FD(fd);
13790add
LP
716 return 0;
717}
718
719static int stdout_stream_load(StdoutStream *stream, const char *fname) {
720 _cleanup_free_ char
721 *priority = NULL,
722 *level_prefix = NULL,
723 *forward_to_syslog = NULL,
724 *forward_to_kmsg = NULL,
ec20fe5f
LP
725 *forward_to_console = NULL,
726 *stream_id = NULL;
13790add
LP
727 int r;
728
729 assert(stream);
730 assert(fname);
731
732 if (!stream->state_file) {
b1852c48 733 stream->state_file = path_join(stream->server->runtime_directory, "streams", fname);
13790add
LP
734 if (!stream->state_file)
735 return log_oom();
a45b9fca
LP
736 }
737
aa8fbc74 738 r = parse_env_file(NULL, stream->state_file,
13790add
LP
739 "PRIORITY", &priority,
740 "LEVEL_PREFIX", &level_prefix,
741 "FORWARD_TO_SYSLOG", &forward_to_syslog,
742 "FORWARD_TO_KMSG", &forward_to_kmsg,
743 "FORWARD_TO_CONSOLE", &forward_to_console,
744 "IDENTIFIER", &stream->identifier,
745 "UNIT", &stream->unit_id,
13df9c39 746 "STREAM_ID", &stream_id);
13790add
LP
747 if (r < 0)
748 return log_error_errno(r, "Failed to read: %s", stream->state_file);
a45b9fca 749
13790add
LP
750 if (priority) {
751 int p;
752
753 p = log_level_from_string(priority);
754 if (p >= 0)
755 stream->priority = p;
a45b9fca
LP
756 }
757
13790add
LP
758 if (level_prefix) {
759 r = parse_boolean(level_prefix);
760 if (r >= 0)
761 stream->level_prefix = r;
d682b3a7 762 }
a45b9fca 763
13790add
LP
764 if (forward_to_syslog) {
765 r = parse_boolean(forward_to_syslog);
766 if (r >= 0)
767 stream->forward_to_syslog = r;
a45b9fca
LP
768 }
769
13790add
LP
770 if (forward_to_kmsg) {
771 r = parse_boolean(forward_to_kmsg);
772 if (r >= 0)
773 stream->forward_to_kmsg = r;
f9a810be
LP
774 }
775
13790add
LP
776 if (forward_to_console) {
777 r = parse_boolean(forward_to_console);
778 if (r >= 0)
779 stream->forward_to_console = r;
a45b9fca
LP
780 }
781
ec20fe5f
LP
782 if (stream_id) {
783 sd_id128_t id;
784
785 r = sd_id128_from_string(stream_id, &id);
786 if (r >= 0)
787 xsprintf(stream->id_field, "_STREAM_ID=" SD_ID128_FORMAT_STR, SD_ID128_FORMAT_VAL(id));
788 }
789
13790add
LP
790 return 0;
791}
792
793static int stdout_stream_restore(Server *s, const char *fname, int fd) {
794 StdoutStream *stream;
795 int r;
796
797 assert(s);
798 assert(fname);
799 assert(fd >= 0);
800
801 if (s->n_stdout_streams >= STDOUT_STREAMS_MAX) {
802 log_warning("Too many stdout streams, refusing restoring of stream.");
803 return -ENOBUFS;
804 }
805
806 r = stdout_stream_install(s, fd, &stream);
807 if (r < 0)
808 return r;
809
810 stream->state = STDOUT_STREAM_RUNNING;
811 stream->fdstore = true;
812
813 /* Ignore all parsing errors */
814 (void) stdout_stream_load(stream, fname);
a45b9fca
LP
815
816 return 0;
13790add
LP
817}
818
15d91bff 819int server_restore_streams(Server *s, FDSet *fds) {
13790add
LP
820 _cleanup_closedir_ DIR *d = NULL;
821 struct dirent *de;
b1852c48 822 const char *path;
13790add
LP
823 int r;
824
b1852c48
LP
825 path = strjoina(s->runtime_directory, "/streams");
826 d = opendir(path);
13790add
LP
827 if (!d) {
828 if (errno == ENOENT)
829 return 0;
830
b1852c48 831 return log_warning_errno(errno, "Failed to enumerate %s: %m", path);
13790add
LP
832 }
833
834 FOREACH_DIRENT(de, d, goto fail) {
835 unsigned long st_dev, st_ino;
836 bool found = false;
13790add
LP
837 int fd;
838
839 if (sscanf(de->d_name, "%lu:%lu", &st_dev, &st_ino) != 2)
840 continue;
841
90e74a66 842 FDSET_FOREACH(fd, fds) {
13790add
LP
843 struct stat st;
844
845 if (fstat(fd, &st) < 0)
846 return log_error_errno(errno, "Failed to stat %s: %m", de->d_name);
847
848 if (S_ISSOCK(st.st_mode) && st.st_dev == st_dev && st.st_ino == st_ino) {
849 found = true;
850 break;
851 }
852 }
853
854 if (!found) {
855 /* No file descriptor? Then let's delete the state file */
856 log_debug("Cannot restore stream file %s", de->d_name);
cb51ee7a 857 if (unlinkat(dirfd(d), de->d_name, 0) < 0)
74deaff1 858 log_warning_errno(errno, "Failed to remove %s/%s: %m", path, de->d_name);
13790add
LP
859 continue;
860 }
861
862 fdset_remove(fds, fd);
863
864 r = stdout_stream_restore(s, de->d_name, fd);
865 if (r < 0)
866 safe_close(fd);
867 }
a45b9fca 868
7b77ed8c 869 return 0;
13790add
LP
870
871fail:
872 return log_error_errno(errno, "Failed to read streams directory: %m");
a45b9fca
LP
873}
874
b1852c48 875int server_open_stdout_socket(Server *s, const char *stdout_socket) {
a45b9fca 876 int r;
a45b9fca
LP
877
878 assert(s);
b1852c48 879 assert(stdout_socket);
a45b9fca
LP
880
881 if (s->stdout_fd < 0) {
f36a9d59
ZJS
882 union sockaddr_union sa;
883 socklen_t sa_len;
b1852c48
LP
884
885 r = sockaddr_un_set_path(&sa.un, stdout_socket);
886 if (r < 0)
887 return log_error_errno(r, "Unable to use namespace path %s for AF_UNIX socket: %m", stdout_socket);
f36a9d59 888 sa_len = r;
b1852c48 889
a45b9fca 890 s->stdout_fd = socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0);
4a62c710
MS
891 if (s->stdout_fd < 0)
892 return log_error_errno(errno, "socket() failed: %m");
a45b9fca 893
155b6876 894 (void) sockaddr_un_unlink(&sa.un);
a45b9fca 895
f36a9d59 896 r = bind(s->stdout_fd, &sa.sa, sa_len);
4a62c710
MS
897 if (r < 0)
898 return log_error_errno(errno, "bind(%s) failed: %m", sa.un.sun_path);
a45b9fca 899
4a61c3e5 900 (void) chmod(sa.un.sun_path, 0666);
a45b9fca 901
4a62c710
MS
902 if (listen(s->stdout_fd, SOMAXCONN) < 0)
903 return log_error_errno(errno, "listen(%s) failed: %m", sa.un.sun_path);
a45b9fca 904 } else
48440643 905 (void) fd_nonblock(s->stdout_fd, true);
a45b9fca 906
151b9b96 907 r = sd_event_add_io(s->event, &s->stdout_event_source, s->stdout_fd, EPOLLIN, stdout_stream_new, s);
23bbb0de
MS
908 if (r < 0)
909 return log_error_errno(r, "Failed to add stdout server fd to event source: %m");
f9a810be 910
48cef295 911 r = sd_event_source_set_priority(s->stdout_event_source, SD_EVENT_PRIORITY_NORMAL+5);
23bbb0de
MS
912 if (r < 0)
913 return log_error_errno(r, "Failed to adjust priority of stdout server event source: %m");
a45b9fca
LP
914
915 return 0;
916}
e22aa3d3
LP
917
918void stdout_stream_send_notify(StdoutStream *s) {
919 struct iovec iovec = {
920 .iov_base = (char*) "FDSTORE=1",
fbd0b64f 921 .iov_len = STRLEN("FDSTORE=1"),
e22aa3d3
LP
922 };
923 struct msghdr msghdr = {
924 .msg_iov = &iovec,
925 .msg_iovlen = 1,
926 };
927 struct cmsghdr *cmsg;
928 ssize_t l;
929
930 assert(s);
931 assert(!s->fdstore);
932 assert(s->in_notify_queue);
933 assert(s->server);
934 assert(s->server->notify_fd >= 0);
935
936 /* Store the connection fd in PID 1, so that we get it passed
937 * in again on next start */
938
939 msghdr.msg_controllen = CMSG_SPACE(sizeof(int));
940 msghdr.msg_control = alloca0(msghdr.msg_controllen);
941
942 cmsg = CMSG_FIRSTHDR(&msghdr);
943 cmsg->cmsg_level = SOL_SOCKET;
944 cmsg->cmsg_type = SCM_RIGHTS;
945 cmsg->cmsg_len = CMSG_LEN(sizeof(int));
946
947 memcpy(CMSG_DATA(cmsg), &s->fd, sizeof(int));
948
949 l = sendmsg(s->server->notify_fd, &msghdr, MSG_DONTWAIT|MSG_NOSIGNAL);
950 if (l < 0) {
951 if (errno == EAGAIN)
952 return;
953
954 log_error_errno(errno, "Failed to send stream file descriptor to service manager: %m");
955 } else {
956 log_debug("Successfully sent stream file descriptor to service manager.");
957 s->fdstore = 1;
958 }
959
960 LIST_REMOVE(stdout_stream_notify_queue, s->server->stdout_streams_notify_queue, s);
961 s->in_notify_queue = false;
962
963}