Bug#755062: systemd: Syslog (contents that journalctl shows) stopped working after upgrading from 204-14 to 208-6
Axel Beckert
abe at debian.org
Thu Jul 17 22:39:24 BST 2014
Control: tag -1 - moreinfo
Hi,
sorry for the comment about "moreinfo" in the last mail. I read that
one first and saw this one only afterwards.
Thanks for the detailed instructions!
Michael Biebl wrote:
> Do you use persistent logging (i.e. do you have a /var/log/journal
> directory) or do you use volatile logging?
AFAIK volatile logging. Otherwise I'd have an real syslog daemon
installed. /var/log/journal does not exist.
> What are the permissions of of the journal directory and the files
> therein (either /var/log/journal or /run/log/journal)?
$ ls -lR /run/log/journal
/run/log/journal:
total 0
drwxr-xr-x 2 root root 140 Jul 17 04:49 492db8f3b777b11e00f22f1853442bf7/
/run/log/journal/492db8f3b777b11e00f22f1853442bf7:
total 69404
-rw-r----- 1 root root 8388608 Jul 17 23:32 system.journal
-rw-r----- 1 root systemd-journal 14618624 Jul 1 13:24 system at 00f9271567a145869260b64961e15f3f-0000000000000001-0004fc8358668c0b.journal
-rw-r----- 1 root systemd-journal 16502784 Jul 5 02:01 system at 00f9271567a145869260b64961e15f3f-0000000000004a8c-0004fd2003dd7bb2.journal
-rw-r----- 1 root systemd-journal 14782464 Jul 10 13:54 system at 00f9271567a145869260b64961e15f3f-000000000000a0ff-0004fd66f2b4c138.journal
-rw-r----- 1 root systemd-journal 16777216 Jul 17 04:48 system at 00f9271567a145869260b64961e15f3f-000000000000f40d-0004fdd57c902758.journal
> What is the output of
> systemctl status systemd-journald.service systemd-journald.socket
# systemctl status systemd-journald.service systemd-journald.socket
systemd-journald.service - Journal Service
Loaded: loaded (/lib/systemd/system/systemd-journald.service; static)
Active: active (running) since Thu 2014-07-17 23:18:02 CEST; 15min ago
Docs: man:systemd-journald.service(8)
man:journald.conf(5)
Main PID: 21568 (systemd-journal)
Status: "Processing requests..."
CGroup: /system.slice/systemd-journald.service
└─21568 /lib/systemd/systemd-journald
systemd-journald.socket - Journal Socket
Loaded: loaded (/lib/systemd/system/systemd-journald.socket; static)
Active: active (running) since Mon 2014-06-23 18:29:20 CEST; 3 weeks 3 days ago
Docs: man:systemd-journald.service(8)
man:journald.conf(5)
Listen: /run/systemd/journal/stdout (Stream)
/run/systemd/journal/socket (Datagram)
/dev/log (Datagram)
Warning: Journal has been rotated since unit was started. Log output is incomplete or unavailable.
#
> Is the systemd-journald process still running?
Running and has been restarted. (See my previous mail.) No change though:
root 21568 0.0 0.0 40788 5308 ? Ss 23:18 0:00 /lib/systemd/systemd-journald
> Can you strace it and trigger a log message via "logger".
{{EPOLLIN, {u32=5, u64=5}}}, 1, -1) = 1
ioctl(5, FIONREAD, [28]) = 0
recvmsg(5, {msg_name(0)=NULL, msg_iov(1)=[{"<13>Jul 17 23:36:05 abe: foo", 2354}], msg_controllen=64, {cmsg_len=32, cmsg_level=SOL_SOCKET, cmsg_type=0x1d /* SCM_??? */, ...}, msg_flags=MSG_CMSG_CLOEXEC}, MSG_DONTWAIT|MSG_CMSG_CLOEXEC) = 28
sendmsg(5, {msg_name(29)={sa_family=AF_LOCAL, sun_path="/run/systemd/journal/syslog"}, msg_iov(1)=[{"<13>Jul 17 23:36:05 abe: foo", 28}], msg_controllen=28, {cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS{pid=2177, uid=0, gid=0}}, msg_flags=0}, MSG_NOSIGNAL) = -1 ESRCH (No such process)
sendmsg(5, {msg_name(29)={sa_family=AF_LOCAL, sun_path="/run/systemd/journal/syslog"}, msg_iov(1)=[{"<13>Jul 17 23:36:05 abe: foo", 28}], msg_controllen=28, {cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS{pid=21568, uid=0, gid=0}}, msg_flags=0}, MSG_NOSIGNAL) = -1 ENOENT (No such file or directory)
open("/proc/1/cgroup", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "8:perf_event:/\n7:blkio:/\n6:net_c"..., 1024) = 105
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/2177/cgroup", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
open("/proc/2177/comm", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
readlink("/proc/2177/exe", 0x1446360, 99) = -1 ENOENT (No such file or directory)
open("/proc/2177/cmdline", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
open("/proc/2177/status", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
capget({_LINUX_CAPABILITY_VERSION_3, 0}, NULL) = 0
capget({_LINUX_CAPABILITY_VERSION_3, 0}, {CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, 0}) = 0
open("/proc/2177/sessionid", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
capget({_LINUX_CAPABILITY_VERSION_3, 0}, NULL) = 0
capget({_LINUX_CAPABILITY_VERSION_3, 0}, {CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, 0}) = 0
open("/proc/2177/loginuid", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
open("/proc/1/cgroup", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "8:perf_event:/\n7:blkio:/\n6:net_c"..., 1024) = 105
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/2177/cgroup", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
open("/proc/2177/attr/current", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
uname({sys="Linux", node="c-cactus", ...}) = 0
ftruncate(11, 8388608) = 0
ioctl(5, FIONREAD, [0]) = 0
recvmsg(5, 0x7fff41eb6000, MSG_DONTWAIT|MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable)
epoll_wait(7, {{EPOLLIN, {u32=5, u64=5}}}, 1, -1) = 1
ioctl(5, FIONREAD, [90]) = 0
recvmsg(5, {msg_name(0)=NULL, msg_iov(1)=[{"<30>Jul 17 23:36:07 dhclient: DH"..., 2354}], msg_controllen=64, {cmsg_len=32, cmsg_level=SOL_SOCKET, cmsg_type=0x1d /* SCM_??? */, ...}, msg_flags=MSG_CMSG_CLOEXEC}, MSG_DONTWAIT|MSG_CMSG_CLOEXEC) = 90
sendmsg(5, {msg_name(29)={sa_family=AF_LOCAL, sun_path="/run/systemd/journal/syslog"}, msg_iov(1)=[{"<30>Jul 17 23:36:07 dhclient: DH"..., 90}], msg_controllen=28, {cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SCM_CREDENTIALS{pid=5553, uid=0, gid=0}}, msg_flags=0}, MSG_NOSIGNAL) = -1 ENOENT (No such file or directory)
open("/proc/1/cgroup", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "8:perf_event:/\n7:blkio:/\n6:net_c"..., 1024) = 105
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/5553/cgroup", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "8:perf_event:/\n7:blkio:/\n6:net_c"..., 1024) = 124
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/5553/comm", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "dhclient\n", 1024) = 9
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
readlink("/proc/5553/exe", "/sbin/dhclient", 99) = 14
open("/proc/5553/cmdline", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "/sbin/dhclient\0-v\0wlan0\0", 1024) = 24
read(12, "", 1024) = 0
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/5553/status", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "Name:\tdhclient\nState:\tS (sleepin"..., 2048) = 779
read(12, "", 1024) = 0
read(12, "", 3072) = 0
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
capget({_LINUX_CAPABILITY_VERSION_3, 0}, NULL) = 0
capget({_LINUX_CAPABILITY_VERSION_3, 0}, {CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, 0}) = 0
open("/proc/5553/sessionid", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "4294967295", 1024) = 10
read(12, "", 1024) = 0
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
capget({_LINUX_CAPABILITY_VERSION_3, 0}, NULL) = 0
capget({_LINUX_CAPABILITY_VERSION_3, 0}, {CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, CAP_CHOWN|CAP_DAC_OVERRIDE|CAP_DAC_READ_SEARCH|CAP_FOWNER|CAP_SETGID|CAP_SETUID|CAP_SYS_PTRACE|CAP_SYS_ADMIN|CAP_AUDIT_CONTROL, 0}) = 0
open("/proc/5553/loginuid", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "4294967295", 1024) = 10
read(12, "", 1024) = 0
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/1/cgroup", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "8:perf_event:/\n7:blkio:/\n6:net_c"..., 1024) = 105
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/5553/cgroup", O_RDONLY|O_CLOEXEC) = 12
fstat(12, {st_mode=S_IFREG|0444, st_size=0, ...}) = 0
mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f7cf11ce000
read(12, "8:perf_event:/\n7:blkio:/\n6:net_c"..., 1024) = 124
close(12) = 0
munmap(0x7f7cf11ce000, 4096) = 0
open("/proc/5553/attr/current", O_RDONLY|O_CLOEXEC) = 12
read(12, 0x1446cd0, 4095) = -1 EINVAL (Invalid argument)
close(12) = 0
uname({sys="Linux", node="c-cactus", ...}) = 0
ftruncate(11, 8388608) = 0
ioctl(5, FIONREAD, [0]) = 0
recvmsg(5, 0x7fff41eb6000, MSG_DONTWAIT|MSG_CMSG_CLOEXEC) = -1 EAGAIN (Resource temporarily unavailable)
epoll_wait(7,
HTH
Regards, Axel
--
,''`. | Axel Beckert <abe at debian.org>, http://people.debian.org/~abe/
: :' : | Debian Developer, ftp.ch.debian.org Admin
`. `' | 1024D: F067 EA27 26B9 C3FC 1486 202E C09E 1D89 9593 0EDE
`- | 4096R: 2517 B724 C5F6 CA99 5329 6E61 2FF9 CD59 6126 16B5
More information about the Pkg-systemd-maintainers
mailing list