Bug#777735: systemd: Disk corruption on reboot initiated through systemd

[Michael Biebl]

Am 12.02.2015 um 07:34 schrieb Michael Biebl:
> Am 12.02.2015 um 07:29 schrieb Peter Colberg:
>> On Thu, Feb 12, 2015 at 07:14:05AM +0100, Michael Biebl wrote:
> 
>> It is curious that the bug only manifests itself with the qemu watchdog.
>> Two physical machines using the hardware iTCO_wdt watchdog reboot fine.
> 
> In my tests, I did indeed have an unclean shutdown, and got an fsck on
> next boot. Which looks to me, as if the watchdog i.e. qemu resets the VM
> before it can shutdown cleanly.

A "systemctl poweroff" does not seem to trigger this issue. In that
case, the system is properly shutdown.
Only on "systemctl reboot" I'm to reproduce the problem, that the VM is
reset after having reached the shutdown target.

With poweroff it looks like this (dump from the serial console log)


...
[^[[32m  OK  ^[[0m] Stopped target Local File Systems.
         Unmounting /run/user/0...
[^[[32m  OK  ^[[0m] Stopped Load/Save Random Seed.
[^[[32m  OK  ^[[0m] Unmounted /run/user/0.
[^[[32m  OK  ^[[0m] Reached target Unmount All Filesystems.
[^[[32m  OK  ^[[0m] Stopped target Local File Systems (Pre).
         Stopping Create Static Device Nodes in /dev...
[^[[32m  OK  ^[[0m] Stopped Create Static Device Nodes in /dev.
         Stopping Remount Root and Kernel File Systems...
[^[[32m  OK  ^[[0m] Stopped Remount Root and Kernel File Systems.
[^[[32m  OK  ^[[0m] Reached target Shutdown.
[    7.381639] systemd-shutdown[1]: Sending SIGTERM to remaining
processes...
[    7.383562] systemd-journald[127]: Received SIGTERM from PID 1
(systemd-shutdow).
[    7.434620] systemd-shutdown[1]: Sending SIGKILL to remaining
processes...
[    7.437469] systemd-shutdown[1]: Unmounting file systems.
[    7.438414] systemd-shutdown[1]: Unmounting /sys/kernel/debug.
[    7.439219] systemd-shutdown[1]: Unmounting /dev/mqueue.
[    7.439959] systemd-shutdown[1]: Unmounting /dev/hugepages.
[    7.474276] EXT4-fs (vda1): re-mounted. Opts: (null)
[    7.475479] EXT4-fs (vda1): re-mounted. Opts: (null)
[    7.475881] EXT4-fs (vda1): re-mounted. Opts: (null)
[    7.476303] systemd-shutdown[1]: All filesystems unmounted.
[    7.476754] systemd-shutdown[1]: Deactivating swaps.
[    7.477228] systemd-shutdown[1]: All swaps deactivated.
[    7.477667] systemd-shutdown[1]: Detaching loop devices.
[    7.478984] systemd-shutdown[1]: All loop devices detached.
[    7.479815] systemd-shutdown[1]: Detaching DM devices.
[    7.480675] systemd-shutdown[1]: All DM devices detached.
[    7.482287] systemd-shutdown[1]: Powering off.
[    7.503279] ACPI: Preparing to enter system sleep state S5
[    7.503821] reboot: Power down


with reboot:

[^[[32m  OK  ^[[0m] Reached target Unmount All Filesystems.
[^[[32m  OK  ^[[0m] Stopped target Local File Systems (Pre).
         Stopping Create Static Device Nodes in /dev...
[^[[32m  OK  ^[[0m] Stopped Create Static Device Nodes in /dev.
         Stopping Remount Root and Kernel File Systems...
[^[[32m  OK  ^[[0m] Stopped Remount Root and Kernel File Systems.
[^[[32m  OK  ^[[0m] Reached target Shutdown.

nothing beyond this line


I then changed the watchdog action to dump. This time I get the
following log on reboot:

[^[[32m  OK  ^[[0m] Stopped Create Static Device Nodes in /dev.
         Stopping Remount Root and Kernel File Systems...
[^[[32m  OK  ^[[0m] Stopped Remount Root and Kernel File Systems.
[^[[32m  OK  ^[[0m] Reached target Shutdown.
[    9.402243] i6300esb: Unexpected close, not stopping watchdog!
[    9.448797] systemd-shutdown[1]: Sending SIGTERM to remaining
processes...
[    9.514019] systemd-journald[127]: Received SIGTERM from PID 1
(systemd-shutdow).
[    9.541822] systemd-shutdown[1]: Sending SIGKILL to remaining
processes...
[    9.546845] systemd-shutdown[1]: Hardware watchdog 'i6300ESB timer',
version 0
[    9.606194] systemd-shutdown[1]: Unmounting file systems.
[    9.608565] systemd-shutdown[1]: Unmounting /sys/kernel/debug.
[    9.610247] systemd-shutdown[1]: Unmounting /dev/mqueue.
[    9.611636] systemd-shutdown[1]: Unmounting /dev/hugepages.
[    9.664149] EXT4-fs (vda1): re-mounted. Opts: (null)
[    9.666461] EXT4-fs (vda1): re-mounted. Opts: (null)
[    9.666976] EXT4-fs (vda1): re-mounted. Opts: (null)
[    9.667571] systemd-shutdown[1]: All filesystems unmounted.
[    9.668304] systemd-shutdown[1]: Deactivating swaps.
[    9.668988] systemd-shutdown[1]: All swaps deactivated.
[    9.669632] systemd-shutdown[1]: Detaching loop devices.
[    9.671348] systemd-shutdown[1]: All loop devices detached.
[    9.672155] systemd-shutdown[1]: Detaching DM devices.
[    9.672949] systemd-shutdown[1]: All DM devices detached.
[    9.674747] systemd-shutdown[1]: Rebooting.


Note this line:
[    9.402243] i6300esb: Unexpected close, not stopping watchdog!



-- 
Why is it that all of the instruments seeking intelligent life in the
universe are pointed away from Earth?

-------------- next part --------------
A non-text attachment was scrubbed...
Name: signature.asc
Type: application/pgp-signature
Size: 819 bytes
Desc: OpenPGP digital signature
URL: <http://alioth-lists.debian.net/pipermail/pkg-systemd-maintainers/attachments/20150212/fde96974/attachment-0002.sig>