Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

TEST-82-SOFTREBOOT is flaky in Github Actions #32834

Closed
DaanDeMeyer opened this issue May 15, 2024 · 3 comments · Fixed by #32880, #32911 or #33013
Closed

TEST-82-SOFTREBOOT is flaky in Github Actions #32834

DaanDeMeyer opened this issue May 15, 2024 · 3 comments · Fixed by #32880, #32911 or #33013
Labels
bug 🐛 Programming errors, that need preferential fixing tests
Milestone
v256

Comments

@DaanDeMeyer
Copy link
Contributor

systemd version the issue has been seen with

main

Used distribution

No response

Linux kernel version used

No response

CPU architectures issue was seen on

None

Component

No response

Expected behaviour you didn't see

No response

Unexpected behaviour you saw

https://github.com/systemd/systemd/actions/runs/9091034899/job/24984872166?pr=32833

gh run download 9091034899 --name ci-mkosi-9091034899-1-debian-testing-failed-test-journals -D ci/ci-mkosi-9091034899-1-debian-testing-failed-test-journals && journalctl --file ci/ci-mkosi-9091034899-1-debian-testing-failed-test-journals/test/journal/TEST-82-SOFTREBOOT.journal --no-hostname -o short-monotonic -u TEST-82-SOFTREBOOT.service -p info

Steps to reproduce the problem

No response

Additional program output to the terminal or log subsystem illustrating the issue

[   34.931421] TEST-82-SOFTREBOOT.sh[1078]: fusectl on /sys/fs/fuse/connections type fusectl (rw,nosuid,nodev,noexec,relatime)
[   34.934592] TEST-82-SOFTREBOOT.sh[1078]: configfs on /sys/kernel/config type configfs (rw,nosuid,nodev,noexec,relatime)
[   34.938493] TEST-82-SOFTREBOOT.sh[1078]: proc on /proc type proc (rw,nosuid,nodev,noexec,relatime)
[   34.942678] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run type tmpfs (rw,nosuid,nodev,size=404788k,nr_inodes=819200,mode=755,inode64)
[   34.946002] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/@system type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.950341] TEST-82-SOFTREBOOT.sh[1078]: systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=38,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=24278)
[   34.954666] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /tmp type tmpfs (rw,nosuid,nodev,nr_inodes=1048576,inode64)
[   34.957930] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-journald.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.964301] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-network-generator.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.971783] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-tmpfiles-setup-dev-early.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.977636] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-udev-load-credentials.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.983935] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-sysctl.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.990564] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-tmpfiles-setup-dev.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   34.996415] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-tmpfiles-setup.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   35.002243] TEST-82-SOFTREBOOT.sh[1078]: binfmt_misc on /proc/sys/fs/binfmt_misc type binfmt_misc (rw,nosuid,nodev,noexec,relatime)
[   35.006160] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-networkd.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   35.011552] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/credentials/systemd-resolved.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   35.017156] TEST-82-SOFTREBOOT.sh[1078]: tmpfs on /run/user/0 type tmpfs (rw,nosuid,nodev,relatime,size=202392k,nr_inodes=50598,mode=700,inode64)
[   35.026689] TEST-82-SOFTREBOOT.sh[1078]: /dev/sda2 on /run/nextroot type btrfs (rw,relatime,discard=async,space_cache=v2,subvolid=5,subvol=/)
[   35.030901] TEST-82-SOFTREBOOT.sh[1049]: + systemd-run --collect --service-type=exec --unit=TEST-82-SOFTREBOOT-nosurvive.service sleep infinity
[   35.041226] TEST-82-SOFTREBOOT.sh[1049]: + touch /run/TEST-82-SOFTREBOOT.touch3
[   35.044969] TEST-82-SOFTREBOOT.sh[1049]: + systemctl --no-block soft-reboot
[   35.046840] TEST-82-SOFTREBOOT.sh[1049]: + exec sleep infinity
[   39.182538] TEST-82-SOFTREBOOT.sh[1219]: + set -o pipefail
[   39.188077] TEST-82-SOFTREBOOT.sh[1221]: ++ dirname /usr/lib/systemd/tests/testdata/units/TEST-82-SOFTREBOOT.sh
[   39.191271] TEST-82-SOFTREBOOT.sh[1219]: + . /usr/lib/systemd/tests/testdata/units/util.sh
[   39.193920] TEST-82-SOFTREBOOT.sh[1219]: ++ [[ -e /var/tmp/.systemd_reboot_count ]]
[   39.196290] TEST-82-SOFTREBOOT.sh[1219]: ++ REBOOT_COUNT=0
[   39.204696] TEST-82-SOFTREBOOT.sh[1219]: + trap at_exit EXIT
[   39.206515] TEST-82-SOFTREBOOT.sh[1219]: + systemd-analyze log-level debug
[   39.212513] TEST-82-SOFTREBOOT.sh[1219]: + export SYSTEMD_LOG_LEVEL=debug
[   39.214948] TEST-82-SOFTREBOOT.sh[1219]: + SYSTEMD_LOG_LEVEL=debug
[   39.224105] TEST-82-SOFTREBOOT.sh[1219]: + '[' -f /run/TEST-82-SOFTREBOOT.touch3 ']'
[   39.225671] TEST-82-SOFTREBOOT.sh[1219]: + echo 'This is the fourth boot!'
[   39.227179] TEST-82-SOFTREBOOT.sh[1219]: This is the fourth boot!
[   39.230956] TEST-82-SOFTREBOOT.sh[1219]: + systemd-notify '--status=Fourth Boot'
[   39.240451] TEST-82-SOFTREBOOT.sh[1227]: ++ busctl -j get-property org.freedesktop.systemd1 /org/freedesktop/systemd1 org.freedesktop.systemd1.Manager SoftRebootsCount
[   39.245422] TEST-82-SOFTREBOOT.sh[1228]: ++ jq -r .data
[   39.262392] TEST-82-SOFTREBOOT.sh[1219]: + test 3 -eq 3
[   39.264151] TEST-82-SOFTREBOOT.sh[1219]: + rm /run/TEST-82-SOFTREBOOT.touch3
[   39.267842] TEST-82-SOFTREBOOT.sh[1219]: + mount
[   39.276190] TEST-82-SOFTREBOOT.sh[1233]: /dev/sda2 on / type btrfs (rw,relatime,discard=async,space_cache=v2,subvolid=5,subvol=/)
[   39.279903] TEST-82-SOFTREBOOT.sh[1233]: devtmpfs on /dev type devtmpfs (rw,nosuid,size=4096k,nr_inodes=234783,mode=755,inode64)
[   39.283577] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /dev/shm type tmpfs (rw,nosuid,nodev,inode64)
[   39.286278] TEST-82-SOFTREBOOT.sh[1233]: devpts on /dev/pts type devpts (rw,nosuid,noexec,relatime,gid=5,mode=620,ptmxmode=000)
[   39.289879] TEST-82-SOFTREBOOT.sh[1233]: hugetlbfs on /dev/hugepages type hugetlbfs (rw,nosuid,nodev,relatime,pagesize=2M)
[   39.293413] TEST-82-SOFTREBOOT.sh[1233]: mqueue on /dev/mqueue type mqueue (rw,nosuid,nodev,noexec,relatime)
[   39.297741] TEST-82-SOFTREBOOT.sh[1233]: sysfs on /sys type sysfs (rw,nosuid,nodev,noexec,relatime)
[   39.297812] TEST-82-SOFTREBOOT.sh[1233]: securityfs on /sys/kernel/security type securityfs (rw,nosuid,nodev,noexec,relatime)
[   39.298206] TEST-82-SOFTREBOOT.sh[1233]: selinuxfs on /sys/fs/selinux type selinuxfs (rw,nosuid,noexec,relatime)
[   39.298600] TEST-82-SOFTREBOOT.sh[1233]: cgroup2 on /sys/fs/cgroup type cgroup2 (rw,nosuid,nodev,noexec,relatime,nsdelegate,memory_recursiveprot)
[   39.299000] TEST-82-SOFTREBOOT.sh[1233]: pstore on /sys/fs/pstore type pstore (rw,nosuid,nodev,noexec,relatime)
[   39.299427] TEST-82-SOFTREBOOT.sh[1233]: bpf on /sys/fs/bpf type bpf (rw,nosuid,nodev,noexec,relatime,mode=700)
[   39.299806] TEST-82-SOFTREBOOT.sh[1233]: debugfs on /sys/kernel/debug type debugfs (rw,nosuid,nodev,noexec,relatime)
[   39.304259] TEST-82-SOFTREBOOT.sh[1233]: tracefs on /sys/kernel/tracing type tracefs (rw,nosuid,nodev,noexec,relatime)
[   39.304643] TEST-82-SOFTREBOOT.sh[1233]: fusectl on /sys/fs/fuse/connections type fusectl (rw,nosuid,nodev,noexec,relatime)
[   39.305023] TEST-82-SOFTREBOOT.sh[1233]: configfs on /sys/kernel/config type configfs (rw,nosuid,nodev,noexec,relatime)
[   39.305417] TEST-82-SOFTREBOOT.sh[1233]: proc on /proc type proc (rw,nosuid,nodev,noexec,relatime)
[   39.307022] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run type tmpfs (rw,nosuid,nodev,size=404788k,nr_inodes=819200,mode=755,inode64)
[   39.307412] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/@system type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.307811] TEST-82-SOFTREBOOT.sh[1233]: systemd-1 on /proc/sys/fs/binfmt_misc type autofs (rw,relatime,fd=40,pgrp=1,timeout=0,minproto=5,maxproto=5,direct,pipe_ino=28733)
[   39.308587] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /tmp type tmpfs (rw,nosuid,nodev,nr_inodes=1048576,inode64)
[   39.308984] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-journald.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.309474] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-network-generator.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.309753] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-tmpfiles-setup-dev-early.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.310135] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-udev-load-credentials.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.310526] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-sysctl.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.310913] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-tmpfiles-setup-dev.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.311331] TEST-82-SOFTREBOOT.sh[1233]: systemd-1 on /boot type autofs (rw,relatime,fd=64,pgrp=1,timeout=120,minproto=5,maxproto=5,direct,pipe_ino=29185)
[   39.311717] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-networkd.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.312498] TEST-82-SOFTREBOOT.sh[1233]: binfmt_misc on /proc/sys/fs/binfmt_misc type binfmt_misc (rw,nosuid,nodev,noexec,relatime)
[   39.312895] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-tmpfiles-setup.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.313287] TEST-82-SOFTREBOOT.sh[1233]: /dev/sda1 on /boot type vfat (rw,nosuid,nodev,noexec,relatime,nosymfollow,fmask=0077,dmask=0077,codepage=437,iocharset=ascii,shortname=mixed,utf8,errors=remount-ro)
[   39.313681] TEST-82-SOFTREBOOT.sh[1233]: tmpfs on /run/credentials/systemd-resolved.service type tmpfs (ro,nosuid,nodev,noexec,relatime,nosymfollow,size=1024k,nr_inodes=1024,mode=700,inode64,noswap)
[   39.314165] TEST-82-SOFTREBOOT.sh[1219]: + rmdir /original-root /run/nextroot
[   39.314447] TEST-82-SOFTREBOOT.sh[1219]: + test 3 -eq 3
[   39.314828] TEST-82-SOFTREBOOT.sh[1219]: + read -r x
[   39.315242] TEST-82-SOFTREBOOT.sh[1219]: + test oinkoink = oinkoink
[   39.315787] TEST-82-SOFTREBOOT.sh[1235]: ++ systemctl show -P ActiveState TEST-82-SOFTREBOOT-survive.service
[   39.316152] TEST-82-SOFTREBOOT.sh[1219]: + test active = active
[   39.316721] TEST-82-SOFTREBOOT.sh[1236]: ++ systemctl show -P ActiveState TEST-82-SOFTREBOOT-survive-argv.service
[   39.389263] TEST-82-SOFTREBOOT.sh[1219]: + test active = active
[   39.389833] TEST-82-SOFTREBOOT.sh[1237]: ++ systemctl show -P ActiveState TEST-82-SOFTREBOOT-nosurvive-sigterm.service
[   39.420223] TEST-82-SOFTREBOOT.sh[1219]: + test inactive '!=' active
[   39.422679] TEST-82-SOFTREBOOT.sh[1238]: ++ systemctl show -P ActiveState TEST-82-SOFTREBOOT-nosurvive.service
[   39.428124] TEST-82-SOFTREBOOT.sh[1219]: + test inactive '!=' active
[   39.430241] TEST-82-SOFTREBOOT.sh[1219]: + journalctl -o short-monotonic --no-hostname --grep '(will soft-reboot|KILL|corrupt)'
[   39.521001] TEST-82-SOFTREBOOT.sh[1239]: -- Journal begins at Wed 2024-05-15 07:32:56 UTC, ends at Wed 2024-05-15 07:33:34 UTC. --
[   39.524953] TEST-82-SOFTREBOOT.sh[1219]: + at_exit
[   39.526663] TEST-82-SOFTREBOOT.sh[1219]: + [[ 1 -ne 0 ]]
[   39.529301] TEST-82-SOFTREBOOT.sh[1219]: + echo 'Test failed, shutting down the machine...'
[   39.531419] TEST-82-SOFTREBOOT.sh[1219]: Test failed, shutting down the machine...
[   39.534934] TEST-82-SOFTREBOOT.sh[1219]: + systemctl poweroff -ff
[   39.541697] reboot: Power down
@DaanDeMeyer DaanDeMeyer added bug 🐛 Programming errors, that need preferential fixing tests labels May 15, 2024
@YHNdnzj YHNdnzj mentioned this issue May 16, 2024
Merged
yuwata added a commit to yuwata/systemd that referenced this issue May 17, 2024
@yuwata
units: do not soft-reboot before soft-reboot.target reached
89a2e00 
Otherwise, at the time systemd-soft-reboot.service succeeds,
services which has Conflicts= and Before=soft-reboot.target may
not be stopped yet, and may be SIGKILLed.

Especially, systemd-journald.service has the dependencies, thus
journal may be corrupted. See systemd#32223.

Follow-up for 13ffc60.

Fixes systemd#32834
yuwata added a commit to yuwata/systemd that referenced this issue May 17, 2024
@yuwata
units: do not soft-reboot before soft-reboot.target reached
4263d76 
Otherwise, at the time systemd-soft-reboot.service succeeds,
services which has Conflicts= and Before=soft-reboot.target may
not be stopped yet, and may be SIGKILLed.

Especially, systemd-journald.service has the dependencies, thus
journal may be corrupted. See systemd#32223.

Follow-up for 13ffc60.

Fixes systemd#32834.
@yuwata yuwata mentioned this issue May 17, 2024
Merged
@yuwata
Copy link
Member

yuwata commented May 17, 2024

Still failed.
https://github.com/systemd/systemd/actions/runs/9132255523/job/25113219795?pr=32902

gh run download 9132255523 --name ci-mkosi-9132255523-1-fedora-40-failed-test-journals -D ci/ci-mkosi-9132255523-1-fedora-40-failed-test-journals && journalctl --file ci/ci-mkosi-9132255523-1-fedora-40-failed-test-journals/test/journal/TEST-82-SOFTREBOOT.journal --no-hostname -o short-monotonic -u TEST-82-SOFTREBOOT.service -p info

@yuwata yuwata reopened this May 17, 2024
yuwata added a commit to yuwata/systemd that referenced this issue May 18, 2024
@yuwata
test: sync journals before reading them
8aec64f 
Workaround for systemd#32834.
@yuwata yuwata mentioned this issue May 18, 2024
Merged
@yuwata yuwata linked a pull request May 18, 2024 that will close this issue
test: sync journals before reading them #32911
Merged
yuwata added a commit to yuwata/systemd that referenced this issue May 18, 2024
@yuwata
test: sync journal before read
51db703 
Workaround for systemd#32834 and systemd#32890.
bluca pushed a commit that referenced this issue May 19, 2024
@yuwata @bluca
test: sync journal before read
a610ba0 
Workaround for #32834 and #32890.
@yuwata
Copy link
Member

yuwata commented May 23, 2024

After #32975, the test fails again:
https://github.com/systemd/systemd/actions/runs/9199086141/job/25303190028?pr=32724

[   44.000421] TEST-82-SOFTREBOOT.sh[1194]: + journalctl --sync
[   44.005127] TEST-82-SOFTREBOOT.sh[1194]: + journalctl -o short-monotonic --no-hostname --grep '(will soft-reboot|KILL|corrupt)'
[   44.162789] TEST-82-SOFTREBOOT.sh[1217]: -- Journal begins at Wed 2024-05-22 23:18:24 UTC, ends at Wed 2024-05-22 23:19:05 UTC. --
[   44.167097] TEST-82-SOFTREBOOT.sh[1194]: + at_exit
[   44.168603] TEST-82-SOFTREBOOT.sh[1194]: + [[ 1 -ne 0 ]]
[   44.170433] TEST-82-SOFTREBOOT.sh[1194]: + echo 'Test failed, shutting down the machine...'
[   44.172509] TEST-82-SOFTREBOOT.sh[1194]: Test failed, shutting down the machine...
[   44.179447] TEST-82-SOFTREBOOT.sh[1194]: + systemctl poweroff -ff
[   44.205208] reboot: Power down
Finishing after writing 95132 entries
Test failed, relevant logs can be viewed with: 

gh run download 9199086141 --name ci-mkosi-9199086141-1-arch-rolling-failed-test-journals -D ci/ci-mkosi-9199086141-1-arch-rolling-failed-test-journals && journalctl --file ci/ci-mkosi-9199086141-1-arch-rolling-failed-test-journals/test/journal/TEST-82-SOFTREBOOT.journal --no-hostname -o short-monotonic -u TEST-82-SOFTREBOOT.service -p info

@yuwata yuwata reopened this May 23, 2024
@bluca bluca added this to the v256 milestone May 23, 2024
@yuwata
Copy link
Member

yuwata commented May 24, 2024

That seems a race between journald and journalctl, and not an issue in soft-reboot:

May 23 08:19:05 TEST-82-SOFTREBOOT.sh[1194]: + journalctl -o short-monotonic --no-hostname --grep '(will soft-reboot|KILL|corrupt)'
May 23 08:19:05 journalctl[1217]: Loaded 'libpcre2-8.so.0' via dlopen()
May 23 08:19:05 journalctl[1217]: Doing case sensitive matching based on request
May 23 08:19:05 journalctl[1217]: Doing case sensitive matching based on pattern casing
May 23 08:19:05 journalctl[1217]: Considering root directory '/run/log/journal'.
May 23 08:19:05 journalctl[1217]: Root directory /run/log/journal added.
May 23 08:19:05 journalctl[1217]: Considering directory '/run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7'.
May 23 08:19:05 journalctl[1217]: Directory /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7 added.
May 23 08:19:05 journalctl[1217]: Journal effective settings seal=no keyed_hash=yes compress=ZSTD compress_threshold_bytes=8B
May 23 08:19:05 journalctl[1217]: File /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7/system@cb17db4ae7394da7a929b91ae95b2488-0000000000000001-0006191326aed5ce.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7/system@cb17db4ae7394da7a929b91ae95b2488-000000000000112d-0006191326bae30d.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7/system@cb17db4ae7394da7a929b91ae95b2488-00000000000025ba-0006191326c73665.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7/system@cb17db4ae7394da7a929b91ae95b2488-00000000000032d8-0006191326d0cf44.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7/system@cb17db4ae7394da7a929b91ae95b2488-0000000000003f58-0006191326d9d881.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/19e0079e990f48bea0cc0be6ff7bdae7/system.journal added.
May 23 08:19:05 journalctl[1217]: Considering directory '/run/log/journal/18d2df692e3d450ca77462dc94c094c1'.
May 23 08:19:05 journalctl[1217]: Directory /run/log/journal/18d2df692e3d450ca77462dc94c094c1 added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-000000000000cb80-0006191327dedcab.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-000000000000d610-00061913280aa999.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-000000000000e5f1-0006191328320159.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-000000000000fab9-0006191328458f73.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000010f7b-00061913285599ef.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000011bde-00061913286c9e8d.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000012781-00061913287db5a5.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000013369-00061913289c31cf.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-00000000000148c6-0006191328abc5e8.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000015d4c-0006191328b8bddd.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000016e49-0006191328ccf860.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-00000000000179e6-0006191328ef972e.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system@cb17db4ae7394da7a929b91ae95b2488-0000000000018ea3-0006191329037cb0.journal added.
May 23 08:19:05 journalctl[1217]: File /run/log/journal/18d2df692e3d450ca77462dc94c094c1/system.journal added.
May 23 08:19:05 journalctl[1217]: Considering root directory '/var/log/journal'.
May 23 08:19:05 journalctl[1217]: Journal filter: none
May 23 08:19:05 journalctl[1217]: Loaded 'libzstd.so.1' via dlopen()
May 23 08:19:05 journalctl[1217]: Attempt to move to uninitialized object: 153664
May 23 08:19:05 journalctl[1217]: Failed to iterate through journal: Bad message
May 23 08:19:05 journalctl[1217]: Directory /run/log/journal/18d2df692e3d450ca77462dc94c094c1 removed.
May 23 08:19:05 journalctl[1217]: Root directory /run/log/journal removed.
May 23 08:19:05 TEST-82-SOFTREBOOT.sh[1217]: -- Journal begins at Wed 2024-05-22 23:18:24 UTC, ends at Wed 2024-05-22 23:19:05 UTC. --
May 23 08:19:05 TEST-82-SOFTREBOOT.sh[1194]: + at_exit

yuwata added a commit to yuwata/systemd that referenced this issue May 24, 2024
@yuwata
test: flush and sync journal everytime before running test script
9611d05 
Hopefully fixes systemd#32834.
systemd#32834 (comment).
This was referenced May 24, 2024
Closed
Merged
mwilck pushed a commit to mwilck/systemd that referenced this issue May 28, 2024
@yuwata @keszybz
test: sync journal before read
77c5b47 
Workaround for systemd#32834 and systemd#32890.

(cherry picked from commit a610ba0)
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug 🐛 Programming errors, that need preferential fixing tests
Milestone
v256
3 participants
@bluca @DaanDeMeyer @yuwata