Bug 30381 - Незапуск сервиса systemd-journald.service
Summary: Незапуск сервиса systemd-journald.service
Status: CLOSED NOTABUG
Alias: None
Product: Sisyphus
Classification: Development
Component: systemd (show other bugs)
Version: unstable
Hardware: all Linux
: P3 normal
Assignee: Alexey Shabalin
QA Contact: qa-sisyphus
URL:
Keywords:
Depends on:
Blocks:
 
Reported: 2014-10-06 11:04 MSK by serpiph
Modified: 2015-08-11 13:03 MSK (History)
2 users (show)

See Also:


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description serpiph 2014-10-06 11:04:08 MSK
Не запускается нормально journald. Падает с такой ошибкой:
         Starting Journal Service...
[FAILED] Failed to start Journal Service.
See 'systemctl status systemd-journald.service' for details.
[DEPEND] Dependency failed for Trigger Flushing of Journal to Persistent Storage.
         Starting Journal Service...
[FAILED] Failed to start Journal Service.
See 'systemctl status systemd-journald.service' for details.

Состояние после загрузки:
$ systemctl status systemd-journald.service
? systemd-journald.service - Journal Service
   Loaded: loaded (/lib/systemd/system/systemd-journald.service; static)
   Active: failed (Result: start-limit) since Пн 2014-10-06 08:23:40 MSK; 1min 28s ago
     Docs: man:systemd-journald.service(8)
           man:journald.conf(5)
  Process: 481 ExecStart=/lib/systemd/systemd-journald (code=exited, status=127)
 Main PID: 481 (code=exited, status=127)
$ systemctl status systemd-journald.socket
? systemd-journald.socket - Journal Socket
   Loaded: loaded (/lib/systemd/system/systemd-journald.socket; static)
   Active: failed (Result: service-failed-permanent) since Mon 2014-10-06 08:23:49 MSK; 36min ago
     Docs: man:systemd-journald.service(8)
           man:journald.conf(5)
   Listen: /run/systemd/journal/stdout (Stream)
           /run/systemd/journal/socket (Datagram)
$ systemctl status systemd-journald-dev-log.socket
? systemd-journald-dev-log.socket - Journal Socket (/dev/log)
   Loaded: loaded (/lib/systemd/system/systemd-journald-dev-log.socket; static)
   Active: failed (Result: service-failed-permanent) since Пн 2014-10-06 08:23:49 MSK; 37min ago
     Docs: man:systemd-journald.service(8)
           man:journald.conf(5)
   Listen: /run/systemd/journal/dev-log (Datagram)
$

Все нужные файлы лежат на своих местах. После перезапуска вручную данного сервиса всё запускается. Система - текущий Сизиф, повторение: на всех моих машинах (7 штук).
Comment 1 Alexey Shabalin 2015-07-22 20:22:11 MSK
дайте больше информации, хотя бы намекните что у вас особенного.
Comment 2 serpiph 2015-08-03 09:36:56 MSK
Даже не знаю, на что намекать. Только одно: каталоги /usr и /var - это отдельные разделы. С точки зрения journald я ничего не делал, самоличных запусков/незапусков сокетов и подобного нет. С установкой версии systemd-221 это восстановилось самостоятельно, без моих вмешательств, если не считать первого перезапуска системы после обновления, когда система вообще ушла в emergency mode и пришлось круто лечить её, потому что в fstab оказались прописаны smb-шары, которые без сети не поднимались.
Единственно, написал такое:
$ cat /etc/rc.d/rc.local
#!/bin/sh

systemctl start systemd-journald
/bin/true
$
В этом месте запуск журнала срабатывает:
$ journalctl -b -u systemd-journald
-- Logs begin at Пн 2013-04-29 10:40:03 MSK, end at Пн 2015-08-03 09:23:33 MSK. --
авг 03 08:55:05 comp systemd-journal[350]: Runtime journal is using 8.0M (max allowed 1.1G, trying to leave 1.7G free of 11.7G available → current limit 1.1G).
авг 03 08:55:05 comp systemd-journal[350]: Runtime journal is using 8.0M (max allowed 1.1G, trying to leave 1.7G free of 11.7G available → current limit 1.1G).
авг 03 08:55:05 comp systemd-journal[350]: Missed 1 kernel messages
авг 03 08:55:05 comp systemd-journal[350]: Missed 1 kernel messages
авг 03 08:55:05 comp systemd-journal[350]: Missed 13 kernel messages
авг 03 08:55:05 comp systemd-journal[350]: Journal started
авг 03 08:55:05 comp systemd-journal[350]: Missed 36 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 1 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 24 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 4 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 3 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 4 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 1 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 2 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 3 kernel messages
авг 03 08:55:06 comp systemd-journal[350]: Missed 26 kernel messages
авг 03 08:55:07 comp systemd-journal[350]: Missed 1 kernel messages                     
авг 03 08:55:07 comp systemd-journal[350]: Missed 5 kernel messages                     
авг 03 08:55:08 comp systemd-journal[350]: Missed 4 kernel messages                     
авг 03 08:55:10 comp systemd-journal[350]: Permanent journal is using 1.3G (max allowed 1.9G, trying to leave 2.9G free of 15.1G available → current limit 1.9G).
авг 03 08:55:12 comp systemd-journal[350]: Time spent on flushing to /var is 1.028752s for 1187 entries.
авг 03 08:55:12 comp systemd-journal[350]: Missed 3 kernel messages                     
авг 03 08:55:13 comp systemd-journal[350]: Missed 2 kernel messages                     
авг 03 08:55:15 comp systemd-journal[350]: Missed 5 kernel messages
авг 03 08:55:17 comp systemd-journal[350]: Missed 8 kernel messages
авг 03 08:55:20 comp systemd-journal[350]: Missed 2 kernel messages
авг 03 08:55:38 comp systemd[1]: Started Journal Service.
авг 03 08:55:38 comp systemd-journal[350]: Missed 25 kernel messages
авг 03 08:55:38 comp systemd-journal[350]: Missed 1 kernel messages
авг 03 08:55:38 comp systemd-journal[350]: Missed 1 kernel messages
авг 03 08:56:56 comp systemd-journal[350]: Missed 9 kernel messages
авг 03 09:23:33 comp systemd-journal[350]: Missed 237 kernel messages
$
Comment 3 Alexey Shabalin 2015-08-10 19:08:06 MSK
Установлены ли еще какие-нибудь syslog'и ? (syslog-ng, rsyslog, klog, syslog ?)
Я не могу понять где может возникнуть проблема.
systemd-journald.service стартует на ранних этапах после
systemd-journald.socket systemd-journald-dev-log.socket systemd-journald-audit.socket syslog.socket.
И должен работать с /run(который на tmpfs в оперативной памяти). Если он не запустился, то через 1 минуту должен стартовать по WatchdogSec=1min.
После монтирования  /var/log/journal, запускается systemd-journal-flush.service и перекладывает логи из /run в /var.
Comment 4 serpiph 2015-08-11 12:51:34 MSK
Ругань шла на эти юниты:
systemd-journald.socket
systemd-journald-dev-log.socket
Почему-то они не запускались как надо. В системе не создавались эти сокеты (после появления приглашения ко входу я заходил в систему и не обнаруживал сокетов, которые должны были бы создаться вышеуказанными юнитами). На данный момент стоит klogd и syslogd.

Вот что происходит, что за 5 сек набирается 11 сообщений ядра, которые благополучно теряются, при том, что до этого за секунду отрабатывают десятки сообщений без потери:
авг 11 09:33:10 comp systemd[1]: Started User Manager for UID 500.
авг 11 09:33:10 comp systemd[1]: Started Console Manager.
авг 11 09:33:15 comp systemd-journal[357]: Missed 11 kernel messages
Comment 5 Alexey Shabalin 2015-08-11 13:03:09 MSK
(В ответ на комментарий №4)
> Ругань шла на эти юниты:
> systemd-journald.socket
> systemd-journald-dev-log.socket
> Почему-то они не запускались как надо. В системе не создавались эти сокеты
> (после появления приглашения ко входу я заходил в систему и не обнаруживал
> сокетов, которые должны были бы создаться вышеуказанными юнитами). На данный
> момент стоит klogd и syslogd.

klogd и syslogd не готовы к работе под systemd. Либо совсем удалите, либо используйте rsyslog|syslog-ng.
Смотрите также 
https://bugzilla.altlinux.org/show_bug.cgi?id=27868