--- Begin Message ---
- To: Debian Bug Tracking System <submit@bugs.debian.org>
- Subject: linux-image-4.19.0-9-marvell: boot_id never changes on reboot
- From: Pekka Paalanen <ppaalanen@gmail.com>
- Date: Mon, 29 Jun 2020 19:02:30 +0300
- Message-id: <20200629190230.52f34202@ferris.localdomain>
Package: src:linux
Version: 4.19.118-2
Severity: normal
Dear Maintainer,
I have a Qnap TS-112 with Debian installed on it. I very rarely need to
reboot it, but when I do, the systemd journal looks more messed up every
time. I think entries from different boots are being interleaved, and
'journalctl --list-boots' does not show all boots. I have observed that
_BOOT_ID recorded in the messages does not seem to change. From that, I
assume that the kernel boot_id does not change as it should either.
This machine does not have a battery-backed RTC.
I'm not quite sure if this problem has always existed or is it a
regression. I have seen journal message ordering problems before, but I
thought those were directly caused by the lack of RTC plus me using
ntpd which does not initialize early enough in boot. I've switched to
systemd's own NTP time keeping since then quite a while ago.
I purposefully rebooted the machine with 'shutdown -r now', and after it
restarted, there was no new boot entry in --list-boots. I do use
persistent storage for the journal, and I do see all the messages from
earlier boots as well as some messages from "right now".
-- Package-specific info:
** Version:
Linux version 4.19.0-9-marvell (debian-kernel@lists.debian.org) (gcc version 8.3.0 (Debian 8.3.0-6)) #1 Debian 4.19.118-2 (2020-04-29)
** Command line:
console=ttyS0,115200 root=/dev/ram initrd=0xa00000,0x900000 ramdisk=34816
** Not tainted
** Kernel log:
[ 1.327639] Loaded X.509 cert 'Debian Secure Boot Signer: 00a7468def'
[ 1.334222] AppArmor: AppArmor sha1 policy hashing enabled
[ 1.341049] hctosys: unable to open rtc device (rtc0)
[ 1.348805] Freeing unused kernel memory: 316K
[ 1.353291] This architecture does not have kernel memory protection.
[ 1.359772] Run /init as init process
[ 1.800780] rtc-s35390a 0-0030: rtc core: registered rtc-s35390a as rtc0
[ 1.879332] SCSI subsystem initialized
[ 1.939565] libata version 3.00 loaded.
[ 1.941963] sata_mv f1080000.sata: version 1.28
[ 1.942218] sata_mv f1080000.sata: slots 32 ports 2
[ 1.956601] scsi host0: sata_mv
[ 1.962267] scsi host1: sata_mv
[ 1.966421] ata1: SATA max UDMA/133 irq 35
[ 1.970565] ata2: SATA max UDMA/133 irq 35
[ 2.447840] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl F300)
[ 2.458677] ata1.00: ATA-8: WDC WD2500AAJS-00L7A0, 01.03E01, max UDMA/133
[ 2.465522] ata1.00: 488397168 sectors, multi 0: LBA48 NCQ (depth 31/32)
[ 2.476909] ata1.00: configured for UDMA/133
[ 2.481535] scsi 0:0:0:0: Direct-Access ATA WDC WD2500AAJS-0 3E01 PQ: 0 ANSI: 5
[ 2.806149] ata2: SATA link down (SStatus 0 SControl F300)
[ 2.837515] sd 0:0:0:0: [sda] 488397168 512-byte logical blocks: (250 GB/233 GiB)
[ 2.849404] sd 0:0:0:0: [sda] Write Protect is off
[ 2.854258] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 2.854349] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 2.902094] sda: sda1 sda2 sda3 < sda5 sda6 >
[ 2.910970] sd 0:0:0:0: [sda] Attached SCSI disk
[ 3.769581] EXT4-fs (sda2): mounted filesystem with ordered data mode. Opts: (null)
[ 5.003150] systemd[1]: System time before build time, advancing clock.
[ 5.191939] systemd[1]: Inserted module 'autofs4'
[ 5.277439] NET: Registered protocol family 10
[ 5.449316] Segment Routing with IPv6
[ 5.453864] random: crng init done
[ 5.552715] systemd[1]: systemd 241 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN2 +IDN -PCRE2 default-hierarchy=hybrid)
[ 5.574721] systemd[1]: Detected architecture arm.
[ 5.642395] systemd[1]: Set hostname to <ashur>.
[ 7.195905] systemd[1]: File /lib/systemd/system/systemd-journald.service:12 configures an IP firewall (IPAddressDeny=any), but the local system does not support BPF/cgroup based firewalling.
[ 7.213074] systemd[1]: Proceeding WITHOUT firewalling in effect! (This warning is only shown for the first loaded unit using IP firewalling.)
[ 7.979648] systemd[1]: /lib/systemd/system/dovecot.service:9: PIDFile= references path below legacy directory /var/run/, updating /var/run/dovecot/master.pid \xe2\x86\x92 /run/dovecot/master.pid; please update the unit file accordingly.
[ 8.081041] systemd[1]: Listening on fsck to fsckd communication Socket.
[ 8.104877] systemd[1]: Listening on Journal Socket.
[ 8.126584] systemd[1]: Created slice User and Session Slice.
[ 8.148034] systemd[1]: Reached target Slices.
[ 8.789595] input: gpio_keys as /devices/platform/gpio_keys/input/input0
[ 8.864058] EXT4-fs (sda2): re-mounted. Opts: errors=remount-ro
[ 9.660619] systemd-journald[141]: Received request to flush runtime journal from PID 1
[ 9.697129] systemd-journald[141]: File /var/log/journal/0c4d9c82740545bfaeedcc433021e0d3/system.journal corrupted or uncleanly shut down, renaming and replacing.
[ 11.106934] orion_wdt: Initial timeout 21 sec
[ 11.117987] libphy: orion_mdio_bus: probed
[ 11.124844] mv643xx_eth: MV-643xx 10/100/1000 ethernet driver version 1.4
[ 11.173144] mv643xx_eth_port mv643xx_eth_port.0: DMA mask not set
[ 11.184098] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 11.276966] marvell-cesa f1030000.crypto: CESA device successfully registered
[ 11.333928] usbcore: registered new interface driver usbfs
[ 11.405865] usbcore: registered new interface driver hub
[ 11.454286] usbcore: registered new device driver usb
[ 11.514655] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 11.529407] m25p80 spi0.0: m25p128 (16384 Kbytes)
[ 11.612793] ehci-orion: EHCI orion driver
[ 11.651274] orion-ehci f1050000.ehci: EHCI Host Controller
[ 11.690986] orion-ehci f1050000.ehci: new USB bus registered, assigned bus number 1
[ 11.748284] orion-ehci f1050000.ehci: irq 32, io mem 0xf1050000
[ 11.780401] 6 fixed-partitions partitions found on MTD device spi0.0
[ 11.786887] Creating 6 MTD partitions on "spi0.0":
[ 11.798602] orion-ehci f1050000.ehci: USB 2.0 started, EHCI 1.00
[ 11.819221] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002, bcdDevice= 4.19
[ 11.827745] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 11.835192] usb usb1: Product: EHCI Host Controller
[ 11.840115] usb usb1: Manufacturer: Linux 4.19.0-9-marvell ehci_hcd
[ 11.846591] usb usb1: SerialNumber: f1050000.ehci
[ 11.875921] 0x000000000000-0x000000080000 : "U-Boot"
[ 11.889357] 0x000000200000-0x000000400000 : "Kernel"
[ 11.901352] 0x000000400000-0x000000d00000 : "RootFS1"
[ 11.908440] rtc-mv f1010300.rtc: internal RTC not ticking
[ 11.942660] 0x000000d00000-0x000001000000 : "RootFS2"
[ 11.955870] 0x000000080000-0x0000000c0000 : "U-Boot Config"
[ 11.980736] hub 1-0:1.0: USB hub found
[ 11.991747] 0x0000000c0000-0x000000200000 : "NAS Config"
[ 12.000489] hub 1-0:1.0: 1 port detected
[ 12.076662] mv643xx_eth_port mv643xx_eth_port.0 eth0: port 0 with MAC address 00:08:9b:c2:22:da
[ 12.395921] usb 1-1: new high-speed USB device number 2 using orion-ehci
[ 12.573677] usb 1-1: New USB device found, idVendor=05e3, idProduct=0608, bcdDevice=77.63
[ 12.581929] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
[ 12.589137] usb 1-1: Product: USB2.0 Hub
[ 12.620219] hub 1-1:1.0: USB hub found
[ 12.630814] hub 1-1:1.0: 4 ports detected
[ 13.292132] Adding 740348k swap on /dev/sda5. Priority:-2 extents:1 across:740348k FS
[ 15.138366] EXT4-fs (sda1): mounting ext2 file system using the ext4 subsystem
[ 15.208556] EXT4-fs (sda1): mounted filesystem without journal. Opts: (null)
[ 26.349485] EXT4-fs (sda6): mounted filesystem with ordered data mode. Opts: (null)
[ 26.990202] audit: type=1400 audit(1550139139.984:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/man" pid=215 comm="apparmor_parser"
[ 27.039871] audit: type=1400 audit(1550139139.984:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_filter" pid=215 comm="apparmor_parser"
[ 27.099893] audit: type=1400 audit(1550139139.984:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="man_groff" pid=215 comm="apparmor_parser"
[ 27.167913] audit: type=1400 audit(1550139140.112:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ntpd" pid=218 comm="apparmor_parser"
[ 27.247924] audit: type=1400 audit(1550139140.144:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe" pid=219 comm="apparmor_parser"
[ 27.339167] audit: type=1400 audit(1550139140.144:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="nvidia_modprobe//kmod" pid=219 comm="apparmor_parser"
[ 28.972617] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 29.481154] NET: Registered protocol family 17
[ 30.564670] mv643xx_eth_port mv643xx_eth_port.0 eth0: link up, 100 Mb/s, full duplex, flow control disabled
[ 30.574589] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
** Model information
Hardware : Marvell Kirkwood (Flattened Device Tree)
Revision : 0000
Device Tree model: QNAP TS219 family
** Loaded modules:
af_packet
ofpart
cmdlinepart
ehci_orion
m25p80
ehci_hcd
spi_nor
mtd
marvell
usbcore
usb_common
nls_base
marvell_cesa
sg
mv643xx_eth
mvmdio
orion_wdt
des_generic
spi_orion
evdev
gpio_keys
ip_tables
x_tables
sha256_generic
hmac
ipv6
autofs4
ext4
crc16
mbcache
jbd2
crc32c_generic
fscrypto
ecb
sd_mod
sata_mv
libata
scsi_mod
rtc_s35390a
** PCI devices:
00:01.0 PCI bridge [0604]: Marvell Technology Group Ltd. 88F6281 [Kirkwood] ARM SoC [11ab:6281] (rev 03) (prog-if 00 [Normal decode])
Control: I/O- Mem- BusMaster- SpecCycle- MemWINV- VGASnoop- ParErr+ Stepping- SERR+ FastB2B- DisINTx-
Status: Cap+ 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Bus: primary=00, secondary=01, subordinate=01, sec-latency=0
Prefetchable memory behind bridge: 00000000-000fffff
Secondary status: 66MHz- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- <SERR- <PERR-
BridgeCtl: Parity- SERR- NoISA- VGA- MAbort- >Reset- FastB2B-
PriDiscTmr- SecDiscTmr- DiscTmrStat- DiscTmrSERREn-
Capabilities: <access denied>
** USB devices:
Bus 001 Device 002: ID 05e3:0608 Genesys Logic, Inc. Hub
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
-- System Information:
Debian Release: 10.4
APT prefers stable
APT policy: (500, 'stable')
Architecture: armel (armv5tel)
Kernel: Linux 4.19.0-9-marvell
Locale: LANG=en_GB.UTF-8, LC_CTYPE=en_GB.UTF-8 (charmap=UTF-8), LANGUAGE=en_US:en (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Init: systemd (via /run/systemd/system)
LSM: AppArmor: enabled
Versions of packages linux-image-4.19.0-9-marvell depends on:
ii initramfs-tools [linux-initramfs-tool] 0.133+deb10u1
ii kmod 26-1
ii linux-base 4.6
Versions of packages linux-image-4.19.0-9-marvell recommends:
ii apparmor 2.13.2-10
ii firmware-linux-free 3.4
ii u-boot-tools 2019.01+dfsg-7
Versions of packages linux-image-4.19.0-9-marvell suggests:
pn debian-kernel-handbook <none>
pn linux-doc-4.19 <none>
Versions of packages linux-image-4.19.0-9-marvell is related to:
pn firmware-amd-graphics <none>
pn firmware-atheros <none>
pn firmware-bnx2 <none>
pn firmware-bnx2x <none>
pn firmware-brcm80211 <none>
pn firmware-cavium <none>
pn firmware-intel-sound <none>
pn firmware-intelwimax <none>
pn firmware-ipw2x00 <none>
pn firmware-ivtv <none>
pn firmware-iwlwifi <none>
pn firmware-libertas <none>
pn firmware-linux-nonfree <none>
pn firmware-misc-nonfree <none>
pn firmware-myricom <none>
pn firmware-netxen <none>
pn firmware-qlogic <none>
pn firmware-realtek <none>
pn firmware-samsung <none>
pn firmware-siano <none>
pn firmware-ti-connectivity <none>
pn xen-hypervisor <none>
-- no debconf information
--- End Message ---