/lib/systemd/systemd-journald:6:fsync:fsync_directory_of_file:journal_file_rotate:do_rotate:server_rotate

Bug #1773148 reported by errors.ubuntu.com bug bridge on 2018-05-24
14
This bug affects 1 person
Affects Status Importance Assigned to Milestone
systemd
Unknown
Unknown
systemd (Ubuntu)
Status tracked in Cosmic
Xenial
Undecided
Unassigned
Bionic
Undecided
Unassigned
Cosmic
Undecided
Unassigned

Bug Description

[Impact]

 * systemd aborts journald, upon watchdog expiry and generates lots of crash reports
 * it appears that journald is simply stuck in fsync
 * it has been agreed to disable watchdog timer on journald

[Test Case]

 * watch drop-off of errors w.r.t. watchdog timer

[Regression Potential]

 * Potentially journald does get stuck, and thus is no longer automatically restarted with a sigabrt crash. However, so far, it is not known to do that.

[Other Info]

 * Original bug report

The Ubuntu Error Tracker has been receiving reports about a problem regarding systemd. This problem was most recently seen with package version 237-3ubuntu10, the problem page at https://errors.ubuntu.com/problem/ff29f7ff39be0e227f0187ad72e5d458e95f6fcf contains more details, including versions of packages affected, stacktrace or traceback, and individual crash reports.
If you do not have access to the Ubuntu Error Tracker and are a software developer, you can request it at http://forms.canonical.com/reports/.

Dimitri John Ledkov (xnox) wrote :

journald appears to sigabort upon rotating systemd journal file, in fsync... 😱

#0 0x00007f6d47f7c237 in fsync (fd=46) at ../sysdeps/unix/sysv/linux/fsync.c:27
        resultvar = 0
        sc_cancel_oldtype = 0
        sc_ret = <optimized out>
#1 0x00007f6d47abf6a0 in fsync_directory_of_file.lto_priv.56 (fd=<optimized out>) at ../src/journal/journal-file.c:483
        path = 0x55c0f3ce1540 "/var/log/journal/<valid uuid>/system@<valid uuid>-0000000000<suffix>-000<another-suffix>.journal"
        dn = 0x55c0f3cda680 "/var/log/journal/<same uuid>"
        dfd = 46
        st = {st_dev = 64768, st_ino = 29360293, st_nlink = 1, st_mode = 33184, st_uid = 0, st_gid = 101, __pad0 = 0, st_rdev = 0, st_size = 134217728, st_blksize = 4096, st_blocks = 262152, st_atim = {tv_sec = 1523965107, tv_nsec = 217770755}, st_mtim = {tv_sec = 1523965108, tv_nsec = 564627151}, st_ctim = {tv_sec = 1523965108, tv_nsec = 564627151}, __glibc_reserved = {0, 0, 0}}
        r = <optimized out>
#2 0x00007f6d47b347a7 in journal_file_rotate (f=0x7fffc919e0c0, compress=<optimized out>, seal=<optimized out>, deferred_closes=0x55c0f3cd2e00) at ../src/journal/journal-file.c:3496
        p = 0x55c0f3ce1470 "/var/log/journal/<valid uuid>/system@<valid uuid>-0000000000<suffix>-000<another-suffix>.journal"
        l = <optimized out>
        old_file = 0x55c0f3d27760
        new_file = 0x0
        r = <optimized out>
        __PRETTY_FUNCTION__ = "journal_file_rotate"
#3 0x000055c0f2c80f71 in do_rotate (s=<optimized out>, f=0x7fffc919e0c0, name=0x55c0f2c8bae7 "system", seal=<optimized out>, uid=0) at ../src/journal/journald-server.c:466
#4 0x000055c0f2c810ce in server_rotate (s=0x7fffc919e020) at ../src/journal/journald-server.c:488
#5 0x000055c0f2c8372b in write_to_journal (priority=6, n=21, iovec=0x7fffc919a880, uid=0, s=0x7fffc919e020) at ../src/journal/journald-server.c:717
#6 dispatch_message_real (s=0x7fffc919e020, iovec=0x7fffc919a880, n=21, m=<optimized out>, c=<optimized out>, tv=<optimized out>, priority=6, object_pid=0) at ../src/journal/journald-server.c:877
#7 0x000055c0f2c83a78 in server_driver_message (s=0x7fffc919e020, object_pid=<optimized out>, message_id=<optimized out>, format=<optimized out>) at ../src/journal/journald-server.c:911
#8 0x000055c0f2c88692 in dev_kmsg_record (l=163, p=<optimized out>, s=0x7fffc919e020) at ../src/journal/journald-kmsg.c:160
#9 server_read_dev_kmsg (s=<optimized out>, s=<optimized out>) at ../src/journal/journald-kmsg.c:346
#10 0x00007f6d47abb160 in source_dispatch (s=s@entry=0x55c0f3cd44d0) at ../src/libsystemd/sd-event/sd-event.c:2303
#11 0x00007f6d47abb3fa in sd_event_dispatch (e=<optimized out>, e@entry=0x55c0f3cd3f10) at ../src/libsystemd/sd-event/sd-event.c:2663
#12 0x00007f6d47abb589 in sd_event_run (e=<optimized out>, timeout=18446744073709551615) at ../src/libsystemd/sd-event/sd-event.c:2723
#13 0x000055c0f2c78b16 in main (argc=<optimized out>, argv=<optimized out>) at ../src/journal/journald.c:110

Dimitri John Ledkov (xnox) wrote :

I wonder if systemd is actually killing journald, whilst it is stuck fsyncing....

Changed in systemd (Ubuntu Cosmic):
status: New → Fix Committed
Changed in systemd (Ubuntu Bionic):
status: New → In Progress
description: updated
Changed in systemd (Ubuntu Xenial):
status: New → Confirmed
Changed in systemd (Ubuntu Xenial):
status: Confirmed → In Progress
Robie Basak (racb) wrote :

Note: the Cosmic fix for this is in the unapproved queue, and could in theory be rejected by the release team. The Xenial SRU should land in updates only once Cosmic is resolved.

Hello errors.ubuntu.com, or anyone else affected,

Accepted systemd into xenial-proposed. The package will build now and be available at https://launchpad.net/ubuntu/+source/systemd/229-4ubuntu21.5 in a few hours, and then in the -proposed repository.

Please help us by testing this new package. See https://wiki.ubuntu.com/Testing/EnableProposed for documentation on how to enable and use -proposed.Your feedback will aid us getting this update out to other Ubuntu users.

If this package fixes the bug for you, please add a comment to this bug, mentioning the version of the package you tested and change the tag from verification-needed-xenial to verification-done-xenial. If it does not fix the bug for you, please add a comment stating that, and change the tag to verification-failed-xenial. In either case, details of your testing will help us make a better decision.

Further information regarding the verification process can be found at https://wiki.ubuntu.com/QATeam/PerformingSRUVerification . Thank you in advance!

Changed in systemd (Ubuntu Xenial):
status: In Progress → Fix Committed
tags: added: verification-needed verification-needed-xenial
Launchpad Janitor (janitor) wrote :

This bug was fixed in the package systemd - 239-7ubuntu10

---------------
systemd (239-7ubuntu10) cosmic; urgency=medium

  * units: Disable journald Watchdog (LP: #1773148)
  * Add conflicts with upstart and systemd-shim. (LP: #1773859)

 -- Dimitri John Ledkov <email address hidden> Thu, 04 Oct 2018 15:58:51 +0100

Changed in systemd (Ubuntu Cosmic):
status: Fix Committed → Fix Released
To post a comment you must log in.
This report contains Public information  Edit
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.