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.

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

tune2fs error causes ignition-ostree-uuid-boot.service to fail #735

Closed
ArneCL opened this issue Feb 5, 2021 · 29 comments · Fixed by coreos/fedora-coreos-config#1054
Closed
Assignees
Labels

Comments

@ArneCL
Copy link

ArneCL commented Feb 5, 2021

Describe the bug
After installing FCOS on a BHyve VM, the VM gets stuck in a boot-loop. On the emergency-console, I can see the error
messages pasted below: Failed to start Ignition OSTree: Generate filesystem UUID (boot). The error occurs with VirtIO disks as well as with AHCI Disks (UEFI).
Please note that FCOS 31.20200517.3.0-live.x86_64.iso installs and runs fine, however FCOS >=32.20201104.3.0-live.x86_64.iso fails with the described error.

[  253.279062] systemd[1]: Starting dracut pre-udev hook...
Starting dracut pre-udev hook...
[  OK  ] Finished dracut pre-udev hook.
[  253.324905] systemd[1]: Finished dracut pre-udev hook.
         Starting udev Kernel Device Manager...
[  253.330576] systemd[1]: Starting udev Kernel Device Manager...
[  OK  ] Started udev Kernel Device Manager.
[  253.384466] systemd[1]: Started udev Kernel Device Manager.
         Starting Generate new UUID for boot disk GPT...
[  253.389490] systemd[1]: Starting Generate new UUID for boot disk GPT...
         Starting dracut pre-trigger hook...
[  253.400210] systemd[1]: Starting dracut pre-trigger hook...
[  OK  ] Finished Generate new UUID for boot disk GPT.
[  253.420155] systemd[1]: Finished Generate new UUID for boot disk GPT.
         Starting Ignition OSTree: …rate filesystem UUID (boot)...
[  253.425985] systemd[1]: Starting Ignition OSTree: Regenerate filesystem UUID (boot)...

[  253.446333] ignition-ostree-firstboot-uuid[10686]: e2fsck 1.45.5 (07-Jan-2020)
[  253.453487] ignition-ostree-firstboot-uuid[10686]: Pass 1: Checking inodes, blocks, and sizes
[  253.461100] ignition-ostree-firstboot-uuid[10686]: Pass 2: Checking directory structure
[  253.470285] dracut-pre-trigger[10677]: rd.md=0: removing MD RAID activation
[  253.478754] ignition-ostree-firstboot-uuid[10686]: Pass 3: Checking directory connectivity
[  253.485191] ignition-ostree-firstboot-uuid[10686]: Pass 4: Checking reference counts
[FAILED] Failed to start Ignition O…nerate filesystem UUID (boot).
See 'systemctl status ignition-ostree-uuid-boot.service' for details.
[DEPEND] Dependency failed for Ignition Boot Disk Set

Reproduction steps
Steps to reproduce the behavior:

  1. Create a VM in TrueNAS (UEFI), VirtIO Disk or AHCI
  2. Boot Live-ISO as CDROM
  3. Retrieve ignition-file via curl -LO
  4. Install with sudo coreos-installer install /dev/vda --ignition fcos.ign

Expected behavior
FCOS / VM booting to shell
A clear and concise description of what actually happened.

Actual behavior
FCOS rebooting due to error while creating Filesystem UUID

System details

  • TrueNAS 12.0-U1.1 BHyve VM
  • Bare Metal live.x86_64.iso
  • FCOS >=32.20201104.3.0

Ignition config

variant: fcos
version: 1.0.0
passwd:
  users:
    - name: core
      ssh_authorized_keys:

Additional information
Add any other information about the problem here.

@ArneCL ArneCL added the kind/bug label Feb 5, 2021
@jlebon
Copy link
Member

jlebon commented Feb 5, 2021

Can you provide the full logs for ignition-ostree-uuid-boot.service?

@jlebon
Copy link
Member

jlebon commented Feb 5, 2021

It's probably either e2fsck or tune2fs failing. set -x would've been useful here (which actually... we should just enable that in all our initrd scripts when rd.debug is enabled).

@ArneCL
Copy link
Author

ArneCL commented Feb 5, 2021

@jlebon I could do so, if it would not continue to reboot ... Is there any magic key-combination or ignition option to boot to shel/ssh even with error occuring?

@lucab
Copy link
Contributor

lucab commented Feb 9, 2021

@ArneCL you should get an emergency prompt in the initramfs, right after the failure. It can be activated by following the on-screen instructions (i.e. pressing Enter) within 5 minutes. If you don't see the prompt, you may first need to adjust the console settings according to your environment, see https://docs.fedoraproject.org/en-US/fedora-coreos/emergency-shell/.

@ArneCL
Copy link
Author

ArneCL commented Feb 9, 2021

@lucab I do get a serial console - However I do not get a prompt to press enter :( However, in the GRUB-Edit section, i can see that two terminals are configured . Do I understand correctly that the emergency-console might be displayed on the "wrong" terminal, if two terminals are configured?

@bgilbert
Copy link
Contributor

bgilbert commented Feb 9, 2021

@ArneCL Yes. You may need to remove one console from the kernel command line arguments.

@lucab
Copy link
Contributor

lucab commented Feb 9, 2021

@ArneCL yes, it may happen if you only have a virtual console and no serial. In that case, dropping the wrong entry from the command-line (or even both, if kernel autodetection can handle your hardware) should give you back the missing prompt.

@ArneCL
Copy link
Author

ArneCL commented Feb 9, 2021

@bgilbert @lucab Unfortunately, this is giving me a hard time:

As stated I do have access to the serial console - However, removing the second console in the GRUB-Edit does not seem to get me an emergency console, only a "virtual console" .

I can see that my changes to the GRUB-Edit take effect, i.e. i can also disable the console I'm accessing it with - Thus giving me a blank screen after hitting ctrl-x to boot....

Any Ideas? Can I provide you with more Input from my Side?

@ArneCL
Copy link
Author

ArneCL commented Feb 9, 2021

@bgilbert @lucab Good news - I was able to obtain some additional debug info by routing the systemd-output to console by setting the kernel parameters systemd.log_level=debug systemd.log_target=console systemd.journald.forward_to_console=1

ignition-ostree-uuid-root.service: Changed dead -> start
         Starting Ignition OSTree: …rate filesystem UUID (root)...
systemd-journald.service: Got notification message from PID 207 (FDSTORE=1)
systemd-journald.service: Added fd 36 (n/a) to fd store.
[   34.024586] ignition-ostree-firstboot-uuid[933]: No changes required for /dev/disk/by-label/root TYPE=xfs UUID=135bed75-bfb2-4a89-8fe6-1f7ea7b8789d
systemd-journald.service: Received EPOLLHUP on stored fd 36 (stored), closing.
Received SIGCHLD from PID 933 (ignition-ostree).
Child 933 (ignition-ostree) died (code=exited, status=0/SUCCESS)
ignition-ostree-uuid-root.service: Failed to read oom_kill field of memory.events cgroup attribute: No such file or directory
ignition-ostree-uuid-root.service: Child 933 belongs to ignition-ostree-uuid-root.service.
ignition-ostree-uuid-root.service: Main process exited, code=exited, status=0/SUCCESS
ignition-ostree-uuid-root.service: Changed start -> exited
ignition-ostree-uuid-root.service: Job 280 ignition-ostree-uuid-root.service/start finished, result=done
[  OK  ] Finished Ignition OSTree: …nerate filesystem UUID (root).
ignition-ostree-uuid-root.service: Control group is empty.
ignition-ostree-mount-firstboot-sysroot.service: ConditionPathExists=!/run/ostree-live succeeded.
ignition-ostree-mount-firstboot-sysroot.service: ConditionKernelCommandLine=ostree succeeded.
ignition-ostree-mount-firstboot-sysroot.service: ConditionKernelCommandLine=!root succeeded.
Failed to read pids.max attribute of cgroup root, ignoring: No such file or directory
ignition-ostree-mount-firstboot-sysroot.service: Passing 0 fds to service
ignition-ostree-mount-firstboot-sysroot.service: About to execute: /usr/sbin/ignition-ostree-mount-sysroot
ignition-ostree-mount-firstboot-sysroot.service: Forked /usr/sbin/ignition-ostree-mount-sysroot as 936
ignition-ostree-mount-firstboot-sysroot.service: Executing: /usr/sbin/ignition-ostree-mount-sysroot
ignition-ostree-mount-firstboot-sysroot.service: Changed dead -> start
         Starting Ignition OSTree: Mount (firstboot) /sysroot...
systemd-journald.service: Got notification message from PID 207 (FDSTORE=1)
systemd-journald.service: Added fd 36 (n/a) to fd store.
[   34.142748] ignition-ostree-mount-sysroot[939]: mount: /sysroot: /dev/vda4 already mounted on /sysroot/sysroot.
systemd-journald.service: Received EPOLLHUP on stored fd 36 (stored), closing.
Received SIGCHLD from PID 936 (ignition-ostree).
Child 936 (ignition-ostree) died (code=exited, status=32/n/a)
ignition-ostree-mount-firstboot-sysroot.service: Failed to read oom_kill field of memory.events cgroup attribute: No such file or directory
ignition-ostree-mount-firstboot-sysroot.service: Child 936 belongs to ignition-ostree-mount-firstboot-sysroot.service.
ignition-ostree-mount-firstboot-sysroot.service: Main process exited, code=exited, status=32/n/a
ignition-ostree-mount-firstboot-sysroot.service: Failed with result 'exit-code'.
ignition-ostree-mount-firstboot-sysroot.service: Service will not restart (restart setting)
ignition-ostree-mount-firstboot-sysroot.service: Changed start -> failed
ignition-ostree-mount-firstboot-sysroot.service: Job 277 ignition-ostree-mount-firstboot-sysroot.service/start finished, result=failed
[FAILED] Failed to start Ignition O…e: Mount (firstboot) /sysroot.
See 'systemctl status ignition-ostree-m…firstboot-sysroot.service' for details.
ignition-ostree-growfs.service: Job 296 ignition-ostree-growfs.service/start finished, result=dependency
[DEPEND] Dependency failed for Igni… OSTree: Grow root filesystem.
ignition-ostree-growfs.service: Job ignition-ostree-growfs.service/start failed with result 'dependency'.
ignition-ostree-mount-firstboot-sysroot.service: Unit entered failed state.
ignition-ostree-mount-firstboot-sysroot.service: Control group is empty.
ignition-remount-sysroot.service: ConditionPathIsReadWrite=!/sysroot failed.
ignition-remount-sysroot.service: Starting requested but condition failed. Not starting unit.
ignition-remount-sysroot.service: Job 276 ignition-remount-sysroot.service/start finished, result=done
ignition-mount.service: ConditionPathExists=/etc/initrd-release succeeded.
Failed to read pids.max attribute of cgroup root, ignoring: No such file or directory
ignition-mount.service: Passing 0 fds to service
ignition-mount.service: About to execute: /usr/bin/ignition --root=/sysroot --platform=${PLATFORM_ID} --stage=mount --log-to-stdout
ignition-mount.service: Forked /usr/bin/ignition as 940
ignition-mount.service: Changed dead -> startignition-mount.service: Executing: /usr/bin/ignition --root=/sysroot --platform=metal --stage=mount --log-to-stdout

and also

 Starting Ignition OSTree: …rate filesystem UUID (boot)...
ignition-setup-base.service: starting held back, waiting for: ignition-ostree-uuid-boot.service
ignition-setup-user.service: starting held back, waiting for: ignition-ostree-uuid-boot.service
systemd-journald.service: Got notification message from PID 207 (FDSTORE=1)
systemd-journald.service: Added fd 36 (n/a) to fd store.
[   32.306273] ignition-ostree-firstboot-uuid[874]: e2fsck 1.45.5 (07-Jan-2020)
[   32.317993] ignition-ostree-firstboot-uuid[874]: Pass 1: Checking inodes, blocks, and sizes
[   32.332394] ignition-ostree-firstboot-uuid[874]: Pass 2: Checking directory structure
[   32.337020] ignition-ostree-firstboot-uuid[874]: Pass 3: Checking directory connectivity
[   32.341191] ignition-ostree-firstboot-uuid[874]: Pass 4: Checking reference counts
[   32.349878] ignition-ostree-firstboot-uuid[874]: Pass 5: Checking group summary information
[   32.360987] ignition-ostree-firstboot-uuid[874]: boot: 314/98304 files (0.0% non-contiguous), 111226/393216 blocks
[   32.375961] ignition-ostree-firstboot-uuid[882]: tune2fs 1.45.5 (07-Jan-2020)
[   32.378688] ignition-ostree-firstboot-uuid[882]: This operation requires a freshly checked filesystem.systemd-journald.service: Received EPOLLHUP on stored fd 36 (stored), closing.

[   32.387856] Received SIGCHLD from PID 869 (ignition-ostree).
Child 869 (ignition-ostree) died (code=exited, status=1/FAILURE)
ignition-ostree-firstboot-uuid[882]: Please run e2fsck -f on the filesystem.ignition-ostree-uuid-boot.service: Failed to read oom_kill field of memory.events cgroup attribute: No such file or directory
ignition-ostree-uuid-boot.service: Child 869 belongs to ignition-ostree-uuid-boot.service.
ignition-ostree-uuid-boot.service: Main process exited, code=exited, status=1/FAILURE

@openstacker
Copy link

openstacker commented Apr 6, 2021

I'm getting the same issue withe FCOS 33.20210301.3.1, see the console log below.

Enabling Passive Release
[    0.675671] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[    0.677300] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[    0.705099] PCI Interrupt Link [LNKD] enabled at IRQ 11
[    0.733223] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6c0 took 52892 usecs
[    0.735416] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
[    0.737783] PCI: CLS 0 bytes, default 64
[    0.739002] Trying to unpack rootfs image as initramfs...
[    1.552279] Freeing initrd memory: 73316K
[    1.553404] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[    1.556988] software IO TLB: mapped [mem 0x00000000bbfe0000-0x00000000bffe0000] (64MB)
[    1.561443] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x21139776891, max_idle_ns: 440795250948 ns
[    1.566570] Initialise system trusted keyrings
[    1.569325] Key type blacklist registered
[    1.571745] workingset: timestamp_bits=36 max_order=20 bucket_order=0
[    1.575340] zbud: loaded
[    1.577013] integrity: Platform Keyring initialized
[    1.590824] NET: Registered protocol family 38
[    1.592150] xor: automatically using best checksumming function   avx       
[    1.594033] Key type asymmetric registered
[    1.595217] Asymmetric key parser 'x509' registered
[    1.596630] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[    1.598722] io scheduler mq-deadline registered
[    1.600060] io scheduler kyber registered
[    1.601297] io scheduler bfq registered
[    1.602564] atomic64_test: passed for x86-64 platform with CX8 and with SSE
[    1.604528] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[    1.606459] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[    1.608674] ACPI: Power Button [PWRF]
[    1.636342] PCI Interrupt Link [LNKC] enabled at IRQ 10
[    1.637881] virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver
[    1.666295] virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver
[    1.694797] PCI Interrupt Link [LNKA] enabled at IRQ 10
[    1.698375] virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver
[    1.727043] PCI Interrupt Link [LNKB] enabled at IRQ 11
[    1.728605] virtio-pci 0000:00:06.0: virtio_pci: leaving for legacy driver
[    1.731237] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[    1.733119] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[    1.735556] 00:05: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A
[    1.739395] Non-volatile memory driver v1.3
[    1.741242] Linux agpgart interface v0.103
[    1.744075] random: fast init done
[    1.745820] random: crng init done
[    1.749458] scsi host0: ata_piix
[    1.751758] scsi host1: ata_piix
[    1.753787] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14
[    1.756452] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15
[    1.758510] libphy: Fixed MDIO Bus: probed
[    1.759914] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[    1.762125] ehci-pci: EHCI PCI platform driver
[    1.763921] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[    1.766203] ohci-pci: OHCI PCI platform driver
[    1.767987] uhci_hcd: USB Universal Host Controller Interface driver
[    1.801864] uhci_hcd 0000:00:01.2: UHCI Host Controller
[    1.803455] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
[    1.805509] uhci_hcd 0000:00:01.2: detected 2 ports
[    1.806917] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c040
[    1.808683] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 5.10
[    1.810978] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[    1.813083] usb usb1: Product: UHCI Host Controller
[    1.814438] usb usb1: Manufacturer: Linux 5.10.19-200.fc33.x86_64 uhci_hcd
[    1.816294] usb usb1: SerialNumber: 0000:00:01.2
[    1.817741] hub 1-0:1.0: USB hub found
[    1.818865] hub 1-0:1.0: 2 ports detected
[    1.820334] usbcore: registered new interface driver usbserial_generic
[    1.822129] usbserial: USB Serial support registered for generic
[    1.823881] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[    1.827501] serio: i8042 KBD port at 0x60,0x64 irq 1
[    1.829020] serio: i8042 AUX port at 0x60,0x64 irq 12
[    1.830682] mousedev: PS/2 mouse device common for all mice
[    1.832722] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[    1.835665] rtc_cmos 00:00: RTC can wake from S4
[    1.837572] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
[    1.842287] rtc_cmos 00:00: registered as rtc0
[    1.845222] rtc_cmos 00:00: setting system clock to 2021-04-06T08:50:39 UTC (1617699039)
[    1.849788] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram
[    1.853546] device-mapper: uevent: version 1.0.3
[    1.853597] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
[    1.858665] device-mapper: ioctl: 4.43.0-ioctl (2020-10-01) initialised: [email protected]
[    1.861312] intel_pstate: CPU model not supported
[    1.862930] hid: raw HID events driver (C) Jiri Kosina
[    1.864417] usbcore: registered new interface driver usbhid
[    1.865928] usbhid: USB HID core driver
[    1.867094] drop_monitor: Initializing network drop monitor service
[    1.868883] Initializing XFRM netlink socket
[    1.870222] NET: Registered protocol family 10
[    1.877319] Segment Routing with IPv6
[    1.878741] RPL Segment Routing with IPv6
[    1.880996] mip6: Mobile IPv6
[    1.882801] NET: Registered protocol family 17
[    1.886250] IPI shorthand broadcast: enabled
[    1.888146] AVX version of gcm_enc/dec engaged.
[    1.889428] AES CTR mode by8 optimization enabled
[    1.920022] sched_clock: Marking stable (1735252144, 184746362)->(2069292869, -149294363)
[    1.925003] registered taskstats version 1
[    1.926810] Loading compiled-in X.509 certificates
[    1.929325] Loaded X.509 cert 'Fedora kernel signing key: ee550b770807bc5d8b1ee4866fab7d72b9f01c5f'
[    1.932075] zswap: loaded using pool lzo/zbud
[    1.933834] Key type ._fscrypt registered
[    1.935306] Key type .fscrypt registered
[    1.936996] Key type fscrypt-provisioning registered
[    1.939061] Btrfs loaded, crc32c=crc32c-generic
[    1.944860] Key type encrypted registered
[    1.946163] ima: No TPM chip found, activating TPM-bypass!
[    1.947752] ima: Allocated hash algorithm: sha256
[    1.949249] ima: No architecture policies found
[    1.950602] evm: Initialising EVM extended attributes:
[    1.952219] evm: security.selinux
[    1.953316] evm: security.ima
[    1.954222] evm: security.capability
[    1.955284] evm: HMAC attrs: 0x1
[    1.956645] PM:   Magic number: 1:73:826
[    1.957935] RAS: Correctable Errors collector initialized.
[    1.962480] Freeing unused decrypted memory: 2036K
[    1.965588] Freeing unused kernel image (initmem) memory: 2540K
[    1.968327] Write protecting the kernel read-only data: 26624k
[    1.972107] Freeing unused kernel image (text/rodata gap) memory: 2036K
[    1.974457] Freeing unused kernel image (rodata/data gap) memory: 532K
[    2.037413] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    2.039244] rodata_test: all tests were successful
[    2.040735] x86/mm: Checking user space page tables
[    2.103963] x86/mm: Checked W+X mappings: passed, no W+X pages found.
[    2.105828] Run /init as init process
[    2.124954] systemd[1]: systemd v246.7-1.fc33 running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +ZSTD +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=unified)
[    2.131456] systemd[1]: Detected virtualization kvm.
[    2.132969] systemd[1]: Detected architecture x86-64.
[    2.134452] systemd[1]: Running in initial RAM disk.

Welcome to [0;38;2;60;110;180mFedora CoreOS 33.20210301.3.1 dracut-050-64.git20200529.fc33 (Initramfs)[0m!

[    2.146166] systemd[1]: No hostname configured.
[    2.148429] systemd[1]: Set hostname to <localhost>.
[    2.150336] systemd[1]: Initializing machine ID from KVM UUID.
[    2.154366] usb 1-1: new full-speed USB device number 2 using uhci_hcd
[    2.268189] systemd[1]: Queued start job for default target Initrd Default Target.
[    2.274042] systemd[1]: Started Forward Password Requests to Clevis Directory Watch.
[[0;32m  OK  [0m] Started [0;1;39mForward Password R?sts to Clevis Directory Watch[0m.
[    2.278829] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[[0;32m  OK  [0m] Started [0;1;39mDispatch Password ?ts to Console Directory Watch[0m.
[    2.283618] systemd[1]: Reached target Local Encrypted Volumes.
[[0;32m  OK  [0m] Reached target [0;1;39mLocal Encrypted Volumes[0m.
[    2.287682] systemd[1]: Reached target Paths.
[[0;32m  OK  [0m] Reached target [0;1;39mPaths[0m.
[    2.289883] systemd[1]: Reached target Slices.
[[0;32m  OK  [0m] Reached target [0;1;39mSlices[0m.
[    2.292225] systemd[1]: Reached target Swap.
[[0;32m  OK  [0m] Reached target [0;1;39mSwap[0m.
[    2.294385] systemd[1]: Reached target Timers.
[[0;32m  OK  [0m] Reached target [0;1;39mTimers[0m.
[    2.296887] systemd[1]: Listening on Journal Audit Socket.
[[0;32m  OK  [0m] Listening on [0;1;39mJournal Audit Socket[0m.
[    2.299851] systemd[1]: Listening on Journal Socket (/dev/log).
[[0;32m  OK  [0m] Listening on [0;1;39mJournal Socket (/dev/log)[0m.
[    2.303225] systemd[1]: Listening on Journal Socket.
[[0;32m  OK  [0m] Listening on [0;1;39mJournal Socket[0m.
[    2.306628] systemd[1]: Listening on udev Control Socket.
[[0;32m  OK  [0m] Listening on [0;1;39mudev Control Socket[0m.
[    2.310204] systemd[1]: Listening on udev Kernel Socket.
[[0;32m  OK  [0m] Listening on [0;1;39mudev Kernel Socket[0m.
[    2.313525] systemd[1]: Reached target Sockets.
[[0;32m  OK  [0m] Reached target [0;1;39mSockets[0m.
[    2.320017] systemd[1]: Starting Afterburn Initrd Setup Network Kernel Arguments...
         Starting [0;1;39mAfterburn Initrd ?up Network Kernel Arguments[0m...
[    2.324975] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
[    2.325014] systemd[1]: Condition check resulted in Check that initrd matches kernel being skipped.
[    2.327206] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
[    2.329960] systemd[1]: Condition check resulted in Persist osmet files (ISO) being skipped.
[    2.331764] usb 1-1: Product: QEMU USB Tablet
[    2.331770] usb 1-1: Manufacturer: QEMU
[    2.331771] usb 1-1: SerialNumber: 42
[    2.338112] systemd[1]: Finished CoreOS Tear Down Initramfs.
[[0;32m  OK  [0m] Finished [0;1;39mCoreOS Tear Down Initramfs[0m.
[    2.341091] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input5
[    2.342179] systemd[1]: Starting Create list of static device nodes for the current kernel...
[    2.344314] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Pointer [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0
         Starting [0;1;39mCreate list of st?odes for the current kernel[0m...
[    2.353087] systemd[1]: Starting Journal Service...
         Starting [0;1;39mJournal Service[0m...
[    2.357463] systemd[1]: Starting Load Kernel Modules...
         Starting [0;1;39mLoad Kernel Modules[0m...
[    2.369651] systemd[1]: Starting Setup Virtual Console...
         Starting [0;1;39mSetup Virtual Console[0m...
[    2.375037] systemd[1]: afterburn-network-kargs.service: Succeeded.
[    2.378876] systemd[1]: Finished Afterburn Initrd Setup Network Kernel Arguments.
[[0;32m  OK  [0m] Finished [0;1;39mAfterburn Initrd Setup Network Kernel Arguments[0m.
[    2.386102] systemd[1]: Finished Create list of static device nodes for the current kernel.
[    2.434765] fuse: init (API version 7.32)
[    2.458585] systemd-modules-load[225]: Inserted module 'fuse'
[    2.458701] systemd-modules-load[225]: Module 'msr' is built in
[[0;32m  OK  [0m] Finished [0;1;39mCreate list of st? nodes for the current kernel[0m.
[    2.475728] audit: type=1130 audit(1617699040.130:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.476236] systemd[1]: Started Journal Service.
[[0;32m  OK  [0m] Started [0;1;39mJournal Service[0m.
[    2.485669] audit: type=1130 audit(1617699040.139:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.486622] systemd[1]: Finished Load Kernel Modules.
[[0;32m  OK  [0m] Finished [0;1;39mLoad Kernel Modules[0m.
[    2.496357] audit: type=1130 audit(1617699040.151:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-modules-load comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.497807] systemd[1]: Finished Setup Virtual Console.
[[0;32m  OK  [0m] Finished [0;1;39mSetup Virtual Console[0m.
[    2.507007] audit: type=1130 audit(1617699040.161:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.509033] systemd[1]: Starting dracut ask for additional cmdline parameters...
         Starting [0;1;39mdracut ask for additional cmdline parameters[0m...
         Starting [0;1;39mApply Kernel Variables[0m...
         Starting [0;1;39mCreate Static Device Nodes in /dev[0m...
[    2.528505] systemd[1]: Starting Apply Kernel Variables...
[[0;32m  OK  [0m] Finished [0;1;39mCreate Static Device Nodes in /dev[0m.
[    2.537262] audit: type=1130 audit(1617699040.191:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.538867] systemd[1]: Starting Create Static Device Nodes in /dev...
[[0;32m  OK  [0m] Finished [0;1;39mApply Kernel Variables[0m.
[    2.557728] systemd[1]: Finished Create Static Device Nodes in /dev.
[    2.559621] audit: type=1130 audit(1617699040.211:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.560648] systemd-sysctl[231]: Not setting net/ipv4/conf/all/rp_filter (explicit setting exists).
[    2.568452] systemd-sysctl[231]: Not setting net/ipv4/conf/default/rp_filter (explicit setting exists).
[[0;32m  OK  [0m] Finished [0;1;39mdracut ask for additional [    2.572426] systemd-sysctl[231]: Not setting net/ipv4/conf/all/accept_source_route (explicit setting exists).
cmdline parameters[0m.
[    2.575463] systemd-sysctl[231]: Not setting net/ipv4/conf/default/accept_source_route (explicit setting exists).
[    2.578416] systemd-sysctl[231]: Not setting net/ipv4/conf/all/promote_secondaries (explicit setting exists).
[    2.578506] audit: type=1130 audit(1617699040.227:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.578520] systemd-sysctl[231]: Not setting net/ipv4/conf/default/promote_secondaries (explicit setting exists).
[    2.578785] systemd[1]: Finished Apply Kernel Variables.
[    2.578959] systemd[1]: Finished dracut ask for additional cmdline parameters.
[    2.579007] systemd[1]: Starting dracut cmdline hook...
[    2.594812] dracut-cmdline[241]: dracut-33.20210301.3.1 (CoreOS) dracut-050-64.git20200529.fc33
[    2.597488] dracut-cmdline[241]: Using kernel command line parameters: rd.driver.pre=btrfs ip=dhcp,dhcp6 BOOT_IMAGE=(hd0,gpt3)/ostree/fedora-coreos-a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/vmlinuz-5.10.19-200.fc33.x86_64 mitigations=auto,nosmt systemd.unified_cgroup_hierarchy=0 console=tty0 console=ttyS0,115200n8 ignition.firstboot ostree=/ostree/boot.1/fedora-coreos/a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/0 ignition.platform.id=openstack
         Starting [0;1;39mdracut cmdline hook[0m...
[[0;32m  OK  [0m] Finished [0;1;39mdracut cmdline hook[0m.
[    2.729776] systemd[1]: Finished dracut cmdline hook.
[    2.731306] audit: type=1130 audit(1617699040.384:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.736724] systemd[1]: Starting dracut pre-udev hook...
         Starting [0;1;39mdracut pre-udev hook[0m...
[    2.783821] systemd[1]: Finished dracut pre-udev hook.
[[0;32m  OK  [0m] Finished [0;1;39mdracut pre-udev hook[0m.
[    2.786946] audit: type=1130 audit(1617699040.441:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[    2.796786] systemd[1]: Starting Rule-based Manager for Device Events and Files...
         Starting [0;1;39mRule-based Manage?for Device Events and Files[0m...
[[0;32m  OK  [[    2.865773] systemd[1]: Started Rule-based Manager for Device Events and Files.
0m] Started [0;1;39mRule-based Manager for Device Events and Files[0m.
         Starting [0;1;39mdracut pre-trigger hook[0m...
[    2.874046] systemd[1]: Starting dracut pre-trigger hook...
[    2.895120] dracut-pre-trigger[341]: rd.md=0: removing MD RAID activation
[    2.965422] systemd[1]: Finished dracut pre-trigger hook.
[[0;32m  OK  [0m] Finished [0;1;39mdracut pre-trigger hook[0m.
         Startin[    2.969826] systemd[1]: Starting Coldplug All udev Devices...
g [0;1;39mColdplug All udev Devices[0m...
[[0;32m  OK  [[    3.091721] systemd[1]: Finished Coldplug All udev Devices.
0m] Finished [0;1;39mColdplug All udev Devices[0m.
         Starting [0;1;39mWait for udev To ?plete Device Initialization[0m...
[    3.099597] systemd[1]: Starting Wait for udev To Complete Device Initialization...
[    3.193971] virtio_blk virtio1: [vda] 41943040 512-byte logical blocks (21.5 GB/20.0 GiB)
[    3.207821] vda: detected capacity change from 0 to 21474836480
[    3.222340]  vda: vda1 vda2 vda3 vda4
[    3.261408] systemd-udevd[385]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
[    3.293430] systemd-udevd[393]: Using default interface naming scheme 'v245'.
[    3.298231] systemd-udevd[393]: ethtool: autonegotiation is unset or enabled, the speed and duplex are not writable.
[    3.302407] virtio_net virtio0 ens3: renamed from eth0
[    3.309519] udevadm[390]: systemd-udev-settle.service is deprecated. Please fix multipathd-configure.service, multipathd.service not to pull it in.
[    3.337413] systemd-udevd[378]: Using default interface naming scheme 'v245'.
[    3.481170] systemd[1]: Found device /dev/disk/by-label/boot.
[[0;32m  OK  [0m] Found device [0;1;39m/dev/disk/by-label/boot[0m.
         Startin[    3.487398] systemd[1]: Starting Generate new UUID for boot disk GPT...
g [0;1;39mGenerate new UUID for boot disk GPT[0m...
[    3.503848] systemd[1]: Finished Wait for udev To Complete Device Initialization.
[[0;32m  OK  [0m] Finished [0;1;39mWait for udev To Complete Device Initialization[0m.
[[0;32m  OK  [[    3.507689] systemd[1]: Finished Generate new UUID for boot disk GPT.
0m] Finished [0;1;39mGenerate new UUID for boot disk GPT[0m.
         Starting [0;1;39mIgnition OSTree: ?rate filesystem UUID (boot)[0m...
[    3.513673] systemd[1]: Starting Ignition OSTree: Regenerate filesystem UUID (boot)...
[    3.516001] systemd[1]: Condition check resulted in Device-Mapper Multipath Default Configuration being skipped.
[    3.551152] ignition-ostree-firstboot-uuid[414]: No changes required for /dev/disk/by-label/boot TYPE=ext4 UUID=7d747235-8036-48e2-aac4-c4c7ae9e9e1e
[[0;32m  OK  [0m] Finished [0;1;39mIgnition OSTree: ?nerate filesystem UUID (boot)[0m.
[    3.560877] systemd[1]: Finished Ignition OSTree: Regenerate filesystem UUID (boot).
         Starting [0;1;39mIgnition (setup user config)[0m...
[    3.565080] systemd[1]: Starting Ignition (setup user config)...
[    3.619045] EXT4-fs (vda3): mounted filesystem with ordered data mode. Opts: (null)
[    3.623060] ignition-setup-user[416]: File /mnt/boot_partition/ignition/config.ign does not exist.. Skipping copy
[[0;32m  OK  [0m] Finished [0;1;39mIgnition (setup user config)[0m.
[    3.628440] systemd[1]: Finished Ignition (setup user config).
         Starting [0;1;39mDevice-Mapper Multipa[    3.631178] systemd[1]: Starting Device-Mapper Multipath Device Controller...
th Device Controller[0m...
[[0;32m  OK  [[    3.641579] systemd[1]: Started Device-Mapper Multipath Device Controller.
0m] Started [0;1;39mDevice-Mapper Multipath Device Controller[0m.
[[0;32m  OK  [0m] Reached target [0;1;39mLocal File Systems (Pre)[0m.
[[0;32m  OK  [0m] Reached target [0;1;39mLocal File Systems[0m.
         Starting [0;1;39mCreate Volatile Files and Directories[0m...
[    3.650644] systemd[1]: Reached target Local File Systems (Pre).
[    3.659139] multipathd[426]: --------start up--------
[    3.661812] multipathd[426]: read /etc/multipath.conf
[    3.663684] multipathd[426]: /etc/multipath.conf does not exist, blacklisting all devices.
[    3.667075] multipathd[426]: You can run "/sbin/mpathconf --enable" to create
[    3.672096] multipathd[426]: /etc/multipath.conf. See man mpathconf(8) for more details
[    3.675097] systemd[1]: Reached target Local File Systems.
[    3.677019] multipathd[426]: failed to increase buffer size
[    3.678990] multipathd[426]: path checkers start up
[[0;32m  OK  [0m] Finished [0;1;39mCreate Vol[    3.680776] multipathd[426]: /etc/multipath.conf does not exist, blacklisting all devices.
atile Files and Directories[0m.
[    3.684140] multipathd[426]: You can run "/sbin/mpathconf --enable" to create
[[0;32m  OK  [0m] Reached target [0;1;39mSyst[    3.686323] multipathd[426]: /etc/multipath.conf. See man mpathconf(8) for more details
em Initialization[0m.
[[0;32m  OK  [[    3.689004] systemd[1]: Starting Create Volatile Files and Directories...
0m] Reached target [0;1;39mBasic System[0m.
[    3.691551] systemd[1]: Finished Create Volatile Files and Directories.
         Startin[    3.693621] systemd[1]: Reached target System Initialization.
g [0;1;39mIgnition (fetch-offline)[0m...
[    3.695992] systemd[1]: Reached target Basic System.
[    3.697589] systemd[1]: Starting Ignition (fetch-offline)...
[    3.712053] ignition[434]: Ignition 2.9.0
[    3.717590] ignition[434]: Stage: fetch-offline
[    3.719080] ignition[434]: reading system config file "/usr/lib/ignition/base.d/00-core.ign"
[[0;32m  OK  [0m] Finished [0;1;39mIgnition (fetch-offline)[0m.
[    3.722653] systemd[1]: Finished Ignition (fetch-offline).
         Starting [0;1;39mCoreOS Enable Network[0m...
[    3.725187] systemd[1]: Starting CoreOS Enable Network...
[    3.727096] ignition[434]: reading system config file "/usr/lib/ignition/base.d/30-afterburn-sshkeys-core.ign"
[    3.730381] ignition[434]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
[    3.732965] ignition[434]: no config URL provided
[    3.734471] ignition[434]: reading system config file "/usr/lib/ignition/user.ign"
[    3.737010] ignition[434]: no config at "/usr/lib/ignition/user.ign"
[    3.739000] ignition[434]: failed to fetch config: resource requires networking
[    3.741783] ignition[434]: Ignition finished successfully
[    3.761116] systemd[1]: Finished CoreOS Enable Network.
[[0;32m  OK  [0m] Finished [0;1;39mCoreOS Enable Network[0m.
         Startin[    3.766653] systemd[1]: Starting Copy CoreOS Firstboot Networking Config...
g [0;1;39mCopy CoreOS Firstboot Networking Config[0m...
[    3.771153] systemd[1]: Starting Ignition (fetch)...
         Starting [0;1;39mIgnition (fetch)[0m...
[    3.785532] ignition[454]: Ignition 2.9.0
[    3.786950] ignition[454]: Stage: fetch
[    3.788405] ignition[454]: reading system config file "/usr/lib/ignition/base.d/00-core.ign"
[    3.790944] EXT4-fs (vda3): mounted filesystem with ordered data mode. Opts: (null)
[    3.793367] ignition[454]: reading system config file "/usr/lib/ignition/base.d/30-afterburn-sshkeys-core.ign"
[    3.796343] ignition[454]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
[    3.799209] coreos-copy-firstboot-network[453]: info: no files to copy from /mnt/boot_partition/coreos-firstboot-network. skipping
[    3.802623] ignition[454]: no config URL provided
[[0;32m  OK  [0m] Finished [0;1;39mCopy CoreO[    3.804239] systemd[1]: Finished Copy CoreOS Firstboot Networking Config.
S Firstboot Networking Config[0m.
[    3.806392] ignition[454]: reading system config file "/usr/lib/ignition/user.ign"
[    3.808801] ignition[454]: no config at "/usr/lib/ignition/user.ign"
[    3.810785] systemd[1]: Starting dracut initqueue hook...
         Starting [0;1;39mdracut initqueue hook[0m...
[    3.813879] ignition[454]: GET http://169.254.169.254/openstack/latest/user_data: attempt #1
[    3.816364] ignition[454]: GET error: Get "http://169.254.169.254/openstack/latest/user_data": dial tcp 169.254.169.254:80: connect: network is unreachable
[    3.888370] NetworkManager[479]: <info>  [1617699041.5425] NetworkManager (version 1.26.6-1.fc33) is starting... (for the first time)
[    3.891846] NetworkManager[479]: <info>  [1617699041.5465] Read config: /etc/NetworkManager/NetworkManager.conf
[    3.897337] NetworkManager[479]: <info>  [1617699041.5519] auth[0x56523a874120]: create auth-manager: D-Bus connection not available. Polkit is disabled and only root will be authorized.
[    3.903152] NetworkManager[479]: <info>  [1617699041.5578] manager[0x56523a880010]: monitoring kernel firmware directory '/lib/firmware'.
[    3.907325] NetworkManager[479]: <info>  [1617699041.5614] hostname: hostname: hostnamed not used as proxy creation failed with: Could not connect: No such file or directory
[    3.911792] NetworkManager[479]: <info>  [1617699041.5616] dns-mgr[0x56523a87a2c0]: init: dns=default,systemd-resolved rc-manager=symlink
[    3.924414] NetworkManager[479]: <info>  [1617699041.5758] manager[0x56523a880010]: rfkill: Wi-Fi hardware radio set enabled
[    3.927716] NetworkManager[479]: <info>  [1617699041.5759] manager[0x56523a880010]: rfkill: WWAN hardware radio set enabled
[    3.931207] NetworkManager[479]: <info>  [1617699041.5787] Loaded device plugin: NMTeamFactory (/usr/lib64/NetworkManager/1.26.6-1.fc33/libnm-device-plugin-team.so)
[    3.935377] NetworkManager[479]: <info>  [1617699041.5788] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
[    3.938606] NetworkManager[479]: <info>  [1617699041.5788] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
[    3.941918] NetworkManager[479]: <info>  [1617699041.5788] manager: Networking is enabled by state file
[    3.944615] NetworkManager[479]: <info>  [1617699041.5789] dhcp-init: Using DHCP client 'internal'
[    3.951804] NetworkManager[479]: <info>  [1617699041.5791] settings: Loaded settings plugin: keyfile (internal)
[    3.955077] NetworkManager[479]: <warn>  [1617699041.5792] settings: could not load plugin 'ifcfg-rh' from file '/usr/lib64/NetworkManager/1.26.6-1.fc33/libnm-settings-plugin-ifcfg-rh.so': No such file or directory
[    3.960787] NetworkManager[479]: <info>  [1617699041.5825] device (lo): carrier: link connected
[    3.963341] NetworkManager[479]: <info>  [1617699041.5826] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
[    3.967119] NetworkManager[479]: <info>  [1617699041.5832] manager: (ens3): new Ethernet device (/org/freedesktop/NetworkManager/Devices/2)
[    3.970525] NetworkManager[479]: <info>  [1617699041.5835] device (ens3): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
[    3.974560] NetworkManager[479]: <info>  [1617699041.5842] device (ens3): carrier: link connected
[    3.977053] NetworkManager[479]: <warn>  [1617699041.5860] sleep-monitor-sd: failed to acquire D-Bus proxy: Could not connect: No such file or directory
[    3.981026] NetworkManager[479]: <info>  [1617699041.5863] device (ens3): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
[    3.984942] NetworkManager[479]: <info>  [1617699041.5867] policy: auto-activating connection 'Wired Connection' (cf00501d-be4b-4ba9-a788-5e8bfede049c)
[    3.988501] NetworkManager[479]: <info>  [1617699041.5871] device (ens3): Activation: starting connection 'Wired Connection' (cf00501d-be4b-4ba9-a788-5e8bfede049c)
[    3.992487] NetworkManager[479]: <info>  [1617699041.5871] device (ens3): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'managed')
[    3.996153] NetworkManager[479]: <info>  [1617699041.5871] manager: NetworkManager state is now CONNECTING
[    3.998954] ignition[454]: GET http://169.254.169.254/openstack/latest/user_data: attempt #2
[    4.001421] NetworkManager[479]: <info>  [1617699041.5872] device (ens3): state change: prepare -> config (reason 'none', sys-iface-state: 'managed')
[    4.004983] NetworkManager[479]: <info>  [1617699041.5875] device (ens3): state change: config -> ip-config (reason 'none', sys-iface-state: 'managed')
[    4.008595] NetworkManager[479]: <info>  [1617699041.5876] dhcp4 (ens3): activation: beginning transaction (timeout in 45 seconds)
[    4.011890] NetworkManager[479]: <info>  [1617699041.6399] dhcp4 (ens3): option dhcp_lease_time      => '86400'
[    4.014777] NetworkManager[479]: <info>  [1617699041.6400] dhcp4 (ens3): option domain_name          => 'openstacklocal'
[    4.017812] NetworkManager[479]: <info>  [1617699041.6400] dhcp4 (ens3): option domain_name_servers  => '8.8.8.8'
[    4.020708] NetworkManager[479]: <info>  [1617699041.6400] dhcp4 (ens3): option expiry               => '1617785441'
[    4.024788] NetworkManager[479]: <info>  [1617699041.6400] dhcp4 (ens3): option host_name            => 'host-10-0-0-10'
[    4.027906] NetworkManager[479]: <info>  [1617699041.6400] dhcp4 (ens3): option ip_address           => '10.0.0.10'
[    4.031423] NetworkManager[479]: <info>  [1617699041.6401] dhcp4 (ens3): option next_server          => '10.0.0.3'
[    4.034760] NetworkManager[479]: <info>  [1617699041.6401] dhcp4 (ens3): option requested_broadcast_address => '1'
[    4.038013] NetworkManager[479]: <info>  [1617699041.6402] dhcp4 (ens3): option requested_domain_name => '1'
[    4.041645] NetworkManager[479]: <info>  [1617699041.6402] dhcp4 (ens3): option requested_domain_name_servers => '1'
[    4.044712] NetworkManager[479]: <info>  [1617699041.6402] dhcp4 (ens3): option requested_domain_search => '1'
[    4.047563] NetworkManager[479]: <info>  [1617699041.6402] dhcp4 (ens3): option requested_host_name  => '1'
[    4.050349] NetworkManager[479]: <info>  [1617699041.6403] dhcp4 (ens3): option requested_interface_mtu => '1'
[    4.053137] NetworkManager[479]: <info>  [1617699041.6403] dhcp4 (ens3): option requested_ms_classless_static_routes => '1'
[    4.056251] NetworkManager[479]: <info>  [1617699041.6403] dhcp4 (ens3): option requested_nis_domain => '1'
[    4.059450] NetworkManager[479]: <info>  [1617699041.6403] dhcp4 (ens3): option requested_nis_servers => '1'
[    4.062763] NetworkManager[479]: <info>  [1617699041.6403] dhcp4 (ens3): option requested_ntp_servers => '1'
[    4.066246] NetworkManager[479]: <info>  [1617699041.6403] dhcp4 (ens3): option requested_rfc3442_classless_static_routes => '1'
[    4.070369] NetworkManager[479]: <info>  [1617699041.6404] dhcp4 (ens3): option requested_root_path  => '1'
[    4.073782] NetworkManager[479]: <info>  [1617699041.6404] dhcp4 (ens3): option requested_routers    => '1'
[[0;32m  OK  [0m] Finished [0;1;39mdracut ini[    4.076715] NetworkManager[479]: <info>  [1617699041.6404] dhcp4 (ens3): option requested_static_routes => '1'
tqueue hook[0m.
[    4.079735] NetworkManager[479]: <info>  [1617699041.6404] dhcp4 (ens3): option requested_subnet_mask => '1'
[[0;32m  OK  [[    4.082535] NetworkManager[479]: <info>  [1617699041.6404] dhcp4 (ens3): option requested_time_offset => '1'
0m] Reached target [0;1;39mRemote File Systems (Pre)[0m.
[    4.085681] NetworkManager[479]: <info>  [1617699041.6404] dhcp4 (ens3): option requested_wpad       => '1'
[[0;32m  OK  [[    4.088454] NetworkManager[479]: <info>  [1617699041.6405] dhcp4 (ens3): option rfc3442_classless_static_routes => '169.254.169.254/32 10.0.0.1 0.0.0.0/0 10.0.0.1'
0m] Reached target [0;1;39mRemote File Systems[0m.
[    4.092742] NetworkManager[479]: <info>  [1617699041.6405] dhcp4 (ens3): option routers              => '10.0.0.1'
[    4.095576] NetworkManager[479]: <info>  [1617699041.6405] dhcp4 (ens3): option subnet_mask          => '255.255.255.0'
[    4.095719] NetworkManager[479]: <info>  [1617699041.6405] dhcp4 (ens3): state changed unknown -> bound
[    4.095954] NetworkManager[479]: <info>  [1617699041.6433] device (ens3): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'managed')
[    4.096118] NetworkManager[479]: <info>  [1617699041.6434] device (ens3): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'managed')
[    4.096176] NetworkManager[479]: <info>  [1617699041.6434] device (ens3): state change: secondaries -> activated (reason 'none', sys-iface-state: 'managed')
[    4.096220] NetworkManager[479]: <info>  [1617699041.6437] manager: NetworkManager state is now CONNECTED_LOCAL
[    4.096264] NetworkManager[479]: <info>  [1617699041.6443] manager: NetworkManager state is now CONNECTED_SITE
[    4.096411] NetworkManager[479]: <info>  [1617699041.6444] policy: set 'Wired Connection' (ens3) as default for IPv4 routing and DNS
[    4.096457] NetworkManager[479]: <info>  [1617699041.6444] policy: set-hostname: set hostname to 'host-10-0-0-10' (from DHCPv4)
[    4.096505] NetworkManager[479]: <info>  [1617699041.6448] device (ens3): Activation: successful, device activated.
[    4.096549] NetworkManager[479]: <info>  [1617699041.6449] manager: NetworkManager state is now CONNECTED_GLOBAL
[    4.096593] NetworkManager[479]: <info>  [1617699041.6453] manager: startup complete
[    4.096657] NetworkManager[479]: <info>  [1617699041.6454] quitting now that startup is complete
[    4.096708] NetworkManager[479]: <info>  [1617699041.6755] dhcp4 (ens3): canceled DHCP transaction
[    4.096759] NetworkManager[479]: <info>  [1617699041.6755] dhcp4 (ens3): state changed bound -> done
[    4.096801] NetworkManager[479]: <info>  [1617699041.6756] device (ens3): DHCPv4: trying to acquire a new lease within 90 seconds
[    4.096848] NetworkManager[479]: <info>  [1617699041.6757] manager: NetworkManager state is now CONNECTED_SITE
[    4.096907] NetworkManager[479]: <info>  [1617699041.6758] exiting (success)
[    4.096953] systemd[1]: Finished dracut initqueue hook.
[    4.097004] systemd[1]: Reached target Remote File Systems (Pre).
[    4.097053] systemd[1]: Reached target Remote File Systems.
[    4.097095] systemd[1]: Condition check resulted in Acquire live PXE rootfs image being skipped.
[    4.097137] systemd[1]: Condition check resulted in Persist osmet files (PXE) being skipped.
[    4.097177] systemd[1]: Starting dracut pre-mount hook...
         Starting [0;1;39mdracut pre-mount hook[0m...
[    4.169912] systemd[1]: Finished dracut pre-mount hook.
[[0;32m  OK  [0m] Finished [0;1;39mdracut pre-mount hook[0m.
[    4.270394] IPv6: ADDRCONF(NETDEV_CHANGE): ens3: link becomes ready
[    4.810739] ignition[454]: GET result: OK
[    4.824168] ignition[454]: warning at $.storage.files.6.filesystem, line 1 col 7165: Unused key filesystem
[    4.828429] ignition[454]: warning at $.storage.files.7.filesystem, line 1 col 8025: Unused key filesystem
[[0;32m  OK  [[    4.831554] ignition[454]: fetched base config from "system"
0m] Finished [0;1;39mIgnition (fetch)[0m.
[    4.833617] ignition[454]: fetch: fetch complete
[    4.835161] [454]: fetched user config from "openstack"
         Startin[    4.836871] ignition[454]: fetch: fetch passed
g [0;1;39mIgnition OSTree: ?ect Partition Transposition[0m...[    4.838880] systemd[1]: Finished Ignition (fetch).

[    4.840428] ignition[454]: Ignition finished successfully
[    4.842038] systemd[1]: Starting Ignition OSTree: Detect Partition Transposition...
[[0;32m  OK  [0m] Finished [0;1;39mIgnition OSTree: Detect Partition Transposition[0m.
[    5.101749] systemd[1]: Finished Ignition OSTree: Detect Partition Transposition.
[    5.107368] systemd[1]: Condition check resulted in Ignition OSTree: Save Partitions being skipped.
[    5.107473] systemd[1]: Starting Ignition (disks)...
         Starting [0;1;39mIgnition (disks)[0m...
[    5.123721] ignition[509]: Ignition 2.9.0
[    5.126362] ignition[509]: Stage: disks
[[0;32m  OK  [0m] Finished [0;1;39mIgnition (disks)[0m.[    5.131443] ignition[509]: reading system config file "/usr/lib/ignition/base.d/00-core.ign"

[[0;32m  OK  [0m] Reached targ[    5.135557] systemd[1]: Finished Ignition (disks).
et [0;1;39mInitrd Root Device[0m.
[    5.138443] systemd[1]: Reached target Initrd Root Device.
[    5.141228] ignition[509]: reading system config file "/usr/lib/ignition/base.d/30-afterburn-sshkeys-core.ign"
[    5.141476] systemd[1]: Starting Ignition OSTree: Regenerate filesystem UUID (root)...
[    5.141849] ignition[509]: no config dir at "/usr/lib/ignition/base.platform.d/openstack"
[    5.141919] ignition[509]: disks: disks passed
         Starting [0;1;39mIgnition OSTree: ?rate filesystem UUID (root)[0m...
[    5.141998] ignition[509]: Ignition finished successfully
[    5.150622] ignition-ostree-firstboot-uuid[515]: No changes required for /dev/disk/by-label/root TYPE=xfs UUID=c5038e0b-2417-4c5b-b9a7-2b2edaba264a
[[0;32m  OK  [0m] Finished [0;1;39mIgnition OSTree: ?nerate filesystem UUID (root)[0m.
[    5.160809] systemd[1]: Finished Ignition OSTree: Regenerate filesystem UUID (root).
[    5.163438] systemd[1]: Condition check resulted in Ignition OSTree: Restore Partitions being skipped.
[    5.166134] systemd[1]: Starting Ignition OSTree: Mount (firstboot) /sysroot...
[    5.169517] ignition-ostree-mount-sysroot[517]: Mounting /dev/disk/by-label/root (/dev/vda4) to /sysroot
         Starting [0;1;39mIgnition OSTree: Mount (firstboot) /sysroot[0m...
[    5.341322] SGI XFS with ACLs, security attributes, scrub, quota, no debug enabled
[    5.348546] XFS (vda4): Mounting V5 Filesystem
[[0m[0;31m*     [0m] A start job is running for Ignition?irstboot) /sysroot (5s / no limit)
M[K[[0;1;31m*[0m[0;31m*    [0m] A start job is running for Ignition?irstboot) /sysroot (5s / no limit)
M[K[[0;31m*[0;1;31m*[0m[0;31m*   [0m] A start job is running for Ignition?irstboot) /sysroot (6s / no limit)
M[K[ [0;31m*[0;1;31m*[0m[0;31m*  [0m] A start job is running for Ignition?irstboot) /sysroot (6s / no limit)
[    9.402326] XFS (vda4): Ending clean mount
[    9.406748] XFS (vda4): Metadata CRC error detected at xfs_dquot_buf_verify_crc+0xe6/0x120 [xfs], xfs_dquot block 0x1478 xfs_dquot_buf_verify_crc
[    9.411544] XFS (vda4): Unmount and run xfs_repair
[    9.413456] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.415428] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.417750] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.419998] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.422200] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.424427] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.426663] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.428901] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.431167] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.433533] XFS (vda4): metadata I/O error in "xfs_dquot_disk_read+0x14a/0x220 [xfs]" at daddr 0x1478 len 8 error 74
[    9.436643] XFS (vda4): Metadata CRC error detected at xfs_dquot_buf_verify_crc+0xe6/0x120 [xfs], xfs_dquot block 0x1478 xfs_dquot_buf_verify_crc
[    9.440078] XFS (vda4): Unmount and run xfs_repair
[    9.441461] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.443201] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.445430] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.447653] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.449858] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.452049] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.454210] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.456452] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.458631] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.460908] XFS (vda4): metadata I/O error in "xfs_dquot_disk_read+0x14a/0x220 [xfs]" at daddr 0x1478 len 8 error 74
[    9.463650] XFS (vda4): Quotacheck needed: Please wait.
[    9.465440] XFS (vda4): Metadata CRC error detected at xfs_dquot_buf_verify_crc+0xe6/0x120 [xfs], xfs_dquot block 0x1478 xfs_dquot_buf_verify_crc
[    9.470577] XFS (vda4): Unmount and run xfs_repair
[    9.472615] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.475195] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.477606] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.479463] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.481337] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.483230] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.485271] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.487098] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.488959] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.490904] XFS (vda4): metadata I/O error in "xfs_qm_reset_dqcounts_all+0x10e/0x1b0 [xfs]" at daddr 0x1478 len 8 error 74
[    9.600012] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f4680 xfs_inode_buf_verify
[    9.606419] XFS (vda4): Unmount and run xfs_repair
[    9.609130] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.611227] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.613580] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.615938] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.618267] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.620520] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.622855] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.625195] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.627548] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.631468] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f46a0 xfs_inode_buf_verify
[    9.635744] XFS (vda4): Unmount and run xfs_repair
[    9.637131] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.638869] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.641164] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.643347] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.645541] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.647832] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.650065] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.652300] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.654516] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.656799] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f7a80 xfs_inode_buf_verify
[    9.659954] XFS (vda4): Unmount and run xfs_repair
[    9.661326] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.663076] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.665468] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.667909] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.670216] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.672542] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.674840] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.677198] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.679617] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.682246] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f7aa0 xfs_inode_buf_verify
[    9.685525] XFS (vda4): Unmount and run xfs_repair
[    9.686921] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.688737] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.690962] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.693234] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.695850] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.698112] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.701128] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.703814] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.706428] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.708705] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f8640 xfs_inode_buf_verify
[    9.711922] XFS (vda4): Unmount and run xfs_repair
[    9.713281] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.714992] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.717179] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.719369] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.721682] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.723881] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.726087] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.728315] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.730663] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.732954] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f8660 xfs_inode_buf_verify
[    9.738753] XFS (vda4): Unmount and run xfs_repair
[    9.740217] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.742000] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.744202] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.746553] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.750936] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.753274] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.755604] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.757868] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.760103] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.762373] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f88c0 xfs_inode_buf_verify
[    9.765555] XFS (vda4): Unmount and run xfs_repair
[    9.766897] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.768642] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.770944] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.770945] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
M[K[  [0;31m*[0;1;31m*[0m[    9.770946] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[0;31m* [0m] A start job is running for Ignitio[    9.770947] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
n?irstboot) /sysroot (7s / no limit)[    9.770948] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................

[    9.770948] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.770949] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.771021] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f88e0 xfs_inode_buf_verify
[    9.771026] XFS (vda4): Unmount and run xfs_repair
[    9.795223] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.797016] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.799292] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.801586] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.803935] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.806207] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.808477] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.810760] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.813004] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.815337] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f9440 xfs_inode_buf_verify
[    9.818569] XFS (vda4): Unmount and run xfs_repair
[    9.819986] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.821752] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.823986] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.826171] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.828393] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.830606] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.832872] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.835307] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.837578] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.839890] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f9460 xfs_inode_buf_verify
[    9.843079] XFS (vda4): Unmount and run xfs_repair
[    9.844490] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.846301] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.849052] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.851704] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.854371] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.858711] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.863196] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.865867] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.868244] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.870646] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fa4c0 xfs_inode_buf_verify
[    9.874003] XFS (vda4): Unmount and run xfs_repair
[    9.875411] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.877382] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.879583] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.881917] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.884355] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.886611] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.889043] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.891284] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.893612] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.896045] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fa4e0 xfs_inode_buf_verify
[    9.901544] XFS (vda4): Unmount and run xfs_repair
[    9.904271] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.907748] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.910136] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.912422] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.914749] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.917069] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.919434] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.921794] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.924144] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.926491] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fb340 xfs_inode_buf_verify
[    9.931307] XFS (vda4): Unmount and run xfs_repair
[    9.933050] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.935004] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.939055] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.944122] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.946791] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.949459] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.951947] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.955302] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.958695] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.975619] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fb360 xfs_inode_buf_verify
[    9.980445] XFS (vda4): Unmount and run xfs_repair
[    9.982472] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[    9.984854] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.987431] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.990041] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.992760] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.995366] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[    9.997945] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.000530] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.003071] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.005710] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fc4c0 xfs_inode_buf_verify
[   10.009325] XFS (vda4): Unmount and run xfs_repair
[   10.010993] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.013077] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.015644] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.018245] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.023440] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.026086] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.028914] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.031534] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.034172] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.036682] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fc4e0 xfs_inode_buf_verify
[   10.039337] XFS (vda4): Unmount and run xfs_repair
[   10.040468] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.041909] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.043711] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.045537] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.047326] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.049150] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.050957] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.052777] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.054594] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.056479] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fd400 xfs_inode_buf_verify
[   10.059091] XFS (vda4): Unmount and run xfs_repair
[   10.060222] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.061645] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.063468] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.065257] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.067056] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.068868] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.070667] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.072462] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.074407] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.076766] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fd420 xfs_inode_buf_verify
[   10.079588] XFS (vda4): Unmount and run xfs_repair
[   10.080725] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.082150] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.083999] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.085837] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.087737] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.089643] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.091507] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.093346] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.095214] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.097156] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fe000 xfs_inode_buf_verify
[   10.099780] XFS (vda4): Unmount and run xfs_repair
[   10.101596] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.105207] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.109850] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.114339] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.117746] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.120003] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.122291] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.124557] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.126791] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.130778] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2fe020 xfs_inode_buf_verify
[   10.135468] XFS (vda4): Unmount and run xfs_repair
[   10.136842] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.138551] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.140759] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.142982] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.145292] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.147491] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.149710] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.151940] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.154128] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.156399] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2ff580 xfs_inode_buf_verify
[   10.159534] XFS (vda4): Unmount and run xfs_repair
[   10.160924] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.162671] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.164933] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.167175] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.169409] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.171717] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.173887] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.176099] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.178305] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.180678] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2ff5a0 xfs_inode_buf_verify
[   10.183909] XFS (vda4): Unmount and run xfs_repair
[   10.185274] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.187072] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.189262] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.191421] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.193590] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.195797] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.198002] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.200218] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.202518] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.204892] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x300800 xfs_inode_buf_verify
[   10.208207] XFS (vda4): Unmount and run xfs_repair
[   10.209575] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.211376] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.213702] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.216062] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.219763] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.224308] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.227030] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.229495] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.231795] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.234250] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x300820 xfs_inode_buf_verify
[   10.237449] XFS (vda4): Unmount and run xfs_repair
[   10.238843] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.240616] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.242832] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.245106] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.249405] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.251676] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.254005] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.256354] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.258563] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.260907] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x306940 xfs_inode_buf_verify
[   10.264211] XFS (vda4): Unmount and run xfs_repair
[   10.265660] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.267476] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.269730] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.271927] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.274160] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.276443] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.278682] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.280926] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.283129] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.285465] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x306960 xfs_inode_buf_verify
[   10.288604] XFS (vda4): Unmount and run xfs_repair
[   10.289994] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.291768] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.294038] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.296324] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.298561] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.300766] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.302934] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.305246] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.307488] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.309883] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x307140 xfs_inode_buf_verify
[   10.313177] XFS (vda4): Unmount and run xfs_repair
[   10.314765] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.317010] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.320049] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.322541] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.324822] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.327022] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.329275] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.331478] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.333706] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.336040] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x307160 xfs_inode_buf_verify
[   10.339236] XFS (vda4): Unmount and run xfs_repair
[   10.340593] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.342301] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.344683] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.346914] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.349258] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.351703] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.354198] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.356746] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.359180] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.361666] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x309840 xfs_inode_buf_verify
[   10.365004] XFS (vda4): Unmount and run xfs_repair
[   10.366410] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.368270] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.370528] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.370529] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
M[K[   [0;31m*[0;1;31m*[0m[   10.370530] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[0;31m*[0m] A start job is running for Ignitio[   10.370531] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
n?irstboot) /sysroot (8s / no limit)
[   10.370532] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.370533] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.370534] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.370598] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x309860 xfs_inode_buf_verify
[   10.370602] XFS (vda4): Unmount and run xfs_repair
[   10.392989] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.394748] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.396997] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.399232] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.401559] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.403887] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.406100] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.408337] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.410578] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.413024] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x309f40 xfs_inode_buf_verify
[   10.416236] XFS (vda4): Unmount and run xfs_repair
[   10.417602] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.419345] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.421577] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.423839] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.426060] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.428351] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.430633] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.432884] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.435122] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.437434] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x309f60 xfs_inode_buf_verify
[   10.440668] XFS (vda4): Unmount and run xfs_repair
[   10.442039] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.443807] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.446039] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.448257] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.450514] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.452809] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.455055] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.457330] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.459544] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.461871] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x30a740 xfs_inode_buf_verify
[   10.465190] XFS (vda4): Unmount and run xfs_repair
[   10.466573] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.468364] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.470648] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.472916] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.477203] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.479423] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.481703] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.483935] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.486151] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.488647] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x30a760 xfs_inode_buf_verify
[   10.491937] XFS (vda4): Unmount and run xfs_repair
[   10.493334] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.495118] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.497376] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.499614] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.501916] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.504243] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.506417] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.508640] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.510862] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.513260] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x31d400 xfs_inode_buf_verify
[   10.516611] XFS (vda4): Unmount and run xfs_repair
[   10.518009] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.519755] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.522078] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.524284] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.526745] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.530520] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.534964] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.537534] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.539732] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.542095] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x31d420 xfs_inode_buf_verify
[   10.545420] XFS (vda4): Unmount and run xfs_repair
[   10.546801] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.548530] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.550984] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.553210] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.555487] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.557806] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.560068] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.562246] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.564477] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.566833] XFS (vda4): Metadata corruption detected at xfs_buf_ioend+0x162/0x570 [xfs], xfs_inode block 0x2f4680 xfs_inode_buf_verify
[   10.570048] XFS (vda4): Unmount and run xfs_repair
[   10.571426] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.573199] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.575491] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.590077] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.592416] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.594732] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.597109] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.599445] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.601739] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.604128] XFS (vda4): metadata I/O error in "xfs_imap_to_bp+0x51/0x90 [xfs]" at daddr 0x2f4680 len 32 error 117
[   10.607055] XFS (vda4): Quotacheck: Unsuccessful (Error -117): Disabling quotas.
[   10.613663] XFS (vda4): Metadata CRC error detected at xfs_agf_read_verify+0xaf/0xd0 [xfs], xfs_agf block 0x387601 
[   10.619311] XFS (vda4): Unmount and run xfs_repair
[   10.621955] XFS (vda4): First 128 bytes of corrupted metadata buffer:
[   10.624776] 00000000: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.626971] 00000010: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.629192] 00000020: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.631448] 00000030: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.633711] 00000040: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.636002] 00000050: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.638296] 00000060: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.640526] 00000070: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00  ................
[   10.642843] XFS (vda4): metadata I/O error in "xfs_read_agf+0x77/0xe0 [xfs]" at daddr 0x387601 len 1 error 74
[   10.645555] XFS (vda4): Error -117 recovering leftover CoW allocations.
[   10.647388] XFS (vda4): xfs_do_force_shutdown(0x8) called from line 985 of file fs/xfs/xfs_mount.c. Return address = 0000000090259f56
[   10.650680] XFS (vda4): Corruption of in-memory data detected.  Shutting down filesystem
[   10.652971] XFS (vda4): Please unmount the filesystem and rectify the problem(s)
[   10.679940] ignition-ostree-mount-sysroot[521]: mount: /sysroot: mount(2) system call failed: Structure needs cleaning.
[   10.687108] systemd[1]: ignition-ostree-mount-firstboot-sysroot.service: Main process exited, code=exited, status=32/n/a
[   10.691301] systemd[1]: ignition-ostree-mount-firstboot-sysroot.service: Failed with result 'exit-code'.
M[K[[0;1;31mFAILED[0m] Failed to start [0;1;39mIgnition O?e: Mount (firstboot) /sysroot[0m.[   10.695154] systemd[1]: Failed to start Ignition OSTree: Mount (firstboot) /sysroot.

[KSee 'systemctl status ignition-ostree-m?firstboot-sysroot.service' for details.
[   10.699407] systemd[1]: Dependency failed for Ignition Boot Disk Setup.
[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mIgnition Boot Disk Setup[0m.
[[0;1;38;5;185m[   10.702062] systemd[1]: Dependency failed for Ignition Complete.
DEPEND[0m] Dependency failed for [0;1;39mIgnition Complete[0m.
[   10.704491] systemd[1]: Dependency failed for Initrd Default Target.
[[0;1;38;5;185mDEPEND[0m] Dependency failed for [0;1;39mInitrd Default Target[0m.
[   10.707029] systemd[1]: initrd.target: Job initrd.target/start failed with result 'dependency'.
[[0;1;38;5;185m[   10.709685] systemd[1]: initrd.target: Triggering OnFailure= dependencies.
DEPEND[0m] Dependency failed for [0;1;39mIgni? OSTree: Grow [   10.712172] systemd[1]: ignition-complete.target: Job ignition-complete.target/start failed with result 'dependency'.
root filesystem[0m.
[   10.715029] kauditd_printk_skb: 20 callbacks suppressed
[   10.715032] audit: type=1130 audit(1617699048.366:31): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-ostree-mount-firstboot-sysroot comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'
[   10.715568] systemd[1]: ignition-diskful.target: Job ignition-diskful.target/start failed with result 'dependency'.
[   10.725640] systemd[1]: Dependency failed for Ignition OSTree: Grow root filesystem.
[[0;32m  OK  [0m] Stopped [0;1;39mDispatch Pa[   10.728170] systemd[1]: ignition-ostree-growfs.service: Job ignition-ostree-growfs.service/start failed with result 'dependency'.
ssword ?ts to Console Directory Watch[0m.[   10.731883] systemd[1]: systemd-ask-password-console.path: Succeeded.

[[0;32m  OK  [[   10.733848] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
0m] Stopped target [0;1;39mBasic System[0m.
[   10.736511] systemd[1]: Stopped target Basic System.
[[0;32m  OK  [0m] Stopped target [0;1;39mSyst[   10.738127] systemd[1]: Stopped target System Initialization.
em Initialization[0m.
[   10.740150] systemd[1]: dracut-pre-mount.service: Succeeded.
[[0;32m  OK  [[   10.741877] systemd[1]: Stopped dracut pre-mount hook.
0m] Stopped [0;1;39mdracut pre-mount hook[0m.
[   10.743999] audit: type=1131 audit(1617699048.398:32): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-mount comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.745639] systemd[1]: dracut-initqueue.service: Succeeded.
[[0;32m  OK  [[   10.751075] systemd[1]: Stopped dracut initqueue hook.
0m] Stopped [0;1;39mdracut initqueue hook[0m.
[   10.753075] audit: type=1131 audit(1617699048.407:33): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-initqueue comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.753444] systemd[1]: dracut-pre-trigger.service: Succeeded.
[[0;32m  OK  [[   10.760149] systemd[1]: Stopped dracut pre-trigger hook.
0m] Stopped [0;1;39mdracut pre-trigger hook[0m.
[   10.762198] audit: type=1131 audit(1617699048.416:34): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.762573] systemd[1]: dracut-pre-udev.service: Succeeded.
[[0;32m  OK  [[   10.769513] systemd[1]: Stopped dracut pre-udev hook.
0m] Stopped [0;1;39mdracut pre-udev hook[0m.
[   10.771479] audit: type=1131 audit(1617699048.426:35): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.771876] systemd[1]: dracut-cmdline.service: Succeeded.
[[0;32m  OK  [[   10.778620] systemd[1]: Stopped dracut cmdline hook.
0m] Stopped [0;1;39mdracut cmdline hook[0m.
[   10.780794] audit: type=1131 audit(1617699048.435:36): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.781185] systemd[1]: dracut-cmdline-ask.service: Succeeded.
[[0;32m  OK  [[   10.791591] systemd[1]: Stopped dracut ask for additional cmdline parameters.
0m] Stopped [0;1;39mdracut ask for additional cmdline parameters[0m.
[   10.795930] systemd[1]: Started Emergency Shell.
[[0;32m  OK  [0m] Started [0;1;39mEmergency Shell[0m.
[   10.798111] systemd[1]: Reached target Emergency Mode.
[[0;32m  OK  [0m] Reached target [0;1;39mEmergency Mode[0m.
[   10.800368] systemd[1]: Condition check resulted in Remount /sysroot read-write for Ignition being skipped.
[   10.801657] audit: type=1131 audit(1617699048.449:37): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline-ask comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.806804] systemd[1]: Starting Dump journal to virtio port...
[   10.808872] audit: type=1130 audit(1617699048.452:38): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=emergency comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.811258] ignition-virtio-dump-journal[533]: Didn't find virtio port /dev/virtio-ports/com.coreos.ignition.journal
         Starting [0;1;39mDump journal to virtio port[0m...
         Starting [0;1;39mOSTree Prepare OS/[0m...
[[0;32m  OK  [0m] Finished [0;1;39mDump journal to virtio port[0m.
[   10.825256] systemd[1]: Starting OSTree Prepare OS/...
[   10.827129] audit: type=1130 audit(1617699048.481:39): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ignition-virtio-dump-journal comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
[   10.827481] systemd[1]: Finished Dump journal to virtio port.
[[0;1;31mFAILED[0m] Failed to [   10.834795] systemd[1]: ostree-prepare-root.service: Main process exited, code=exited, status=1/FAILURE
start [0;1;39mOSTree Prepare OS/[0m.
See 'systemctl status ostree-pre[   10.838261] ostree-prepare-root[534]: ostree-prepare-root: Couldn't find specified OSTree root '/sysroot//ostree/boot.1/fedora-coreos/a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/0': No such file or directory
pare-root.service' for details.
[   10.843910] audit: type=1130 audit(1617699048.498:40): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=ostree-prepare-root comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=failed'
[[0;32m  OK  [0m] Reached target [0;1;39mInitrd Root File System[0m.
[   10.659325] ostree-prepare-root[534]: ostree-prepare-root: Couldn't find specified OSTree root '/sysroot//ostree/boot.1/fedora-coreos/a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/0': No such file or directory
[   10.854130] systemd[1]: ostree-prepare-root.service: Failed with result 'exit-code'.
         Starting [0;1;39mMount OSTree /var[0m...
[   10.859316] systemd[1]: Failed to start OSTree Prepare OS/.
[   10.861907] systemd[1]: ostree-prepare-root.service: Triggering OnFailure= dependencies.
[   10.864565] systemd[1]: Reached target Initrd Root File System.
[   10.866370] systemd[1]: Starting Mount OSTree /var...
[[0;1;31mFAILED[0m] Failed to start [0;1;39mMount OSTree /var[0m.[   10.868378] ignition-ostree-mount-var[535]: /sysroot//ostree/boot.1/fedora-coreos/a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/0 is not a symlink

See 'systemctl s[   10.872519] systemd[1]: ignition-ostree-mount-var.service: Main process exited, code=exited, status=1/FAILURE
tatus ignition-ostree-mount-var.service' for details.
[   10.875571] systemd[1]: ignition-ostree-mount-var.service: Failed with result 'exit-code'.
[[0;32m  OK  [[   10.877991] systemd[1]: Failed to start Mount OSTree /var.
0m] Stopped [0;1;39mForward Password R?sts to Clevis Director[   10.879936] systemd[1]: ignition-ostree-mount-var.service: Triggering OnFailure= dependencies.
y Watch[0m.
[[0;32m  OK  [[   10.882652] systemd[1]: clevis-luks-askpass.path: Succeeded.
0m] Stopped target [0;1;39mLocal Encrypted Volu[   10.884639] systemd[1]: Stopped Forward Password Requests to Clevis Directory Watch.
mes[0m.
[[0;32m  OK  [[   10.886938] systemd[1]: Stopped target Local Encrypted Volumes.
0m] Stopped target [0;1;39mInitrd Root Device[[   10.889017] systemd[1]: Stopped target Initrd Root Device.
0m.
[[0;32m  OK  [[   10.890820] systemd[1]: Stopped target Paths.
0m] Stopped target [0;1;39mPaths[0m.
[   10.893169] systemd[1]: Stopped target Remote File Systems.
[[0;32m  OK  [0m] Stopped target [0;1;39mRemote File Systems[0m.
[   10.896060] systemd[1]: Stopped target Remote File Systems (Pre).
[[0;32m  OK  [0m] Stopped target [0;1;39mRemote File Systems (Pre)[0m.
[   10.898538] systemd[1]: Stopped target Slices.
[[0;32m  OK  [0m] Stopped target [0;1;39mSlices[0m.
[   10.900409] systemd[1]: Stopped target Sockets.
[[0;32m  OK  [0m] Stopped target [0;1;39mSockets[0m.
[   10.902277] systemd[1]: Stopped target Swap.
[[0;32m  OK  [0m] Stopped target [0;1;39mSwap[0m.
[   10.904138] systemd[1]: Stopped target Timers.
[[0;32m  OK  [0m] Stopped target [0;1;39mTimers[0m.
[   10.906052] systemd[1]: coreos-copy-firstboot-network.service: Succeeded.
[[0;32m  OK  [[   10.908046] systemd[1]: Stopped Copy CoreOS Firstboot Networking Config.
0m] Stopped [0;1;39mCopy CoreOS Firstboot Networking Config[0m.
[   10.910812] systemd[1]: Stopped target Initrd Root File System.
[[0;32m  OK  [0m] Stopped target [0;1;39mInitrd Root File System[0m.
[   10.913414] systemd[1]: ignition-ostree-uuid-root.service: Succeeded.
[[0;32m  OK  [[   10.917125] systemd[1]: Stopped Ignition OSTree: Regenerate filesystem UUID (root).
0m] Stopped [0;1;39mIgnition OSTree: R?nerate filesystem UUID (root)[0m.
[[0;32m  OK  [[   10.921679] systemd[1]: ignition-disks.service: Succeeded.
0m] Stopped [0;1;39mIgnition (disks)[0m.
[   10.924052] systemd[1]: Stopped Ignition (disks).
         Stopping [0;1;39mIgnition OSTree: ?ect Partition Transposition[0m...
[[0;32m  OK  [0m] Stopped [0;1;39mApply Kernel Variables[0m.
[[0;32m  OK  [0m] Stopped [0;1;39mLoad Kernel Modules[0m.
[[0;32m  OK  [0m] Stopped [0;1;39mCreate Vola[   10.930947] systemd[1]: Stopping Ignition OSTree: Detect Partition Transposition...
tile Files and Directories[0m.
[[0;32m  OK  [[   10.933493] systemd[1]: systemd-sysctl.service: Succeeded.
0m] Stopped target [0;1;39mLocal File Systems[0m.
[   10.935536] systemd[1]: Stopped Apply Kernel Variables.
[[0;32m  OK  [[   10.937917] systemd[1]: systemd-modules-load.service: Succeeded.
0m] Stopped target [0;1;39mLocal File Systems (Pre)[0m.
[   10.940989] systemd[1]: Stopped Load Kernel Modules.
         Stopping [0;1;39mDevice-Mapper Multipath Device Controller[0m...
[[0;32m  OK  [0m] Stopped [0;1;39mIgnition OSTree: Detect Partition Transposition[0m.
[[0;32m  OK  [0m] Stopped [0;1;39mIgnition (fetch)[0m.
[[0;32m  OK  [0m] Stopped [0;1;39mCoreOS Enable Network[0m.
[[0;32m  OK  [0m] Stopped [0;1;39mIgnition (fetch-offline)[0[   10.950631] systemd[1]: systemd-tmpfiles-setup.service: Succeeded.
m.
[   10.953577] multipathd[540]: Apr 06 08:50:48 | /etc/multipath.conf does not exist, blacklisting all devices.
[   10.956505] multipathd[540]: Apr 06 08:50:48 | You can run "/sbin/mpathconf --enable" to create
[   10.959171] multipathd[540]: Apr 06 08:50:48 | /etc/multipath.conf. See man mpathconf(8) for more details
[[0;32m  OK  [0m] Stopped [0;1;39mDevice-Mapp[   10.962247] systemd[1]: Stopped Create Volatile Files and Directories.
er Multipath Device Controller[[   10.964369] multipathd[540]: ok
0m.
[   10.965823] multipathd[426]: --------shut down-------
[   10.967413] systemd[1]: Stopped target Local File Systems.
[[0;32m  OK  [[   10.970139] systemd[1]: Stopped target Local File Systems (Pre).
0m] Stopped [0;1;39mIgnition (setup user config)[0m.
[   10.973191] systemd[1]: Stopping Device-Mapper Multipath Device Controller...
[[0;32m  OK  [[   10.975418] systemd[1]: ignition-ostree-transposefs-detect.service: Succeeded.
0m] Stopped [0;1;39mIgnition OSTree: R?nerate filesystem UUID[   10.977508] systemd[1]: Stopped Ignition OSTree: Detect Partition Transposition.
 (boot)[0m.
[[0;32m  OK  [[   10.979728] systemd[1]: ignition-fetch.service: Succeeded.
0m] Stopped [0;1;39mGenerate new UUID for boot [   10.981373] systemd[1]: Stopped Ignition (fetch).
disk GPT[0m.
[   10.982829] systemd[1]: coreos-enable-network.service: Succeeded.
[[0;32m  OK  [[   10.984386] systemd[1]: Stopped CoreOS Enable Network.
0m] Stopped [0;1;39mWait for udev To Complete D[   10.985919] systemd[1]: ignition-fetch-offline.service: Succeeded.
evice Initialization[0m.
[   10.987675] systemd[1]: Stopped Ignition (fetch-offline).
[[0;32m  OK  [[   10.989134] systemd[1]: multipathd.service: Succeeded.
0m] Stopped [0;1;39mColdplug All udev Devices[0m.
         Stopping [0;1;39mRule-[   10.991634] systemd[1]: Stopped Device-Mapper Multipath Device Controller.
based Manage?for Device Events and Files[0m...
[   10.995681] systemd[1]: ignition-setup-user.service: Succeeded.
[   10.999532] systemd[1]: Stopped Ignition (setup user config).
[   11.002823] systemd[1]: ignition-ostree-uuid-boot.service: Succeeded.
[[0;32m  OK  [0m] Stopped [0;1;39mRule-based Manager for Device Events and Files[0m.
[   11.007952] systemd[1]: Stopped Ignition OSTree: Regenerate filesystem UUID (boot).
[[0;32m  OK  [0m] Closed [0;1;39mudev Control Socket[0m.
[   11.012807] systemd[1]: coreos-gpt-setup.service: Succeeded.
[[0;32m  OK  [0m] Closed [0;1;39mudev Kernel Socket[0m.
[   11.015347] systemd[1]: Stopped Generate new UUID for boot disk GPT.
[[0;32m  OK  [0m] Stopped [0;1;39mCreate Static Device Nodes in /dev[0m.
[   11.018459] systemd[1]: systemd-udev-settle.service: Succeeded.
[[0;32m  OK  [0m] Stopped [0;1;39mCreate list of sta? nodes for the current kernel[0m.
[   11.021667] systemd[1]: Stopped Wait for udev To Complete Device Initialization.
[   11.024098] systemd[1]: systemd-udev-trigger.service: Succeeded.
[   11.025933] systemd[1]: Stopped Coldplug All udev Devices.
[   11.027787] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
[   11.030131] systemd[1]: systemd-udevd.service: Succeeded.
[   11.031823] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
[   11.034043] systemd[1]: systemd-udevd-control.socket: Succeeded.
[   11.035814] systemd[1]: Closed udev Control Socket.
[   11.037322] systemd[1]: systemd-udevd-kernel.socket: Succeeded.
[   11.039099] systemd[1]: Closed udev Kernel Socket.
[   11.040599] systemd[1]: systemd-tmpfiles-setup-dev.service: Succeeded.
[   11.042660] systemd[1]: Stopped Create Static Device Nodes in /dev.
[   11.044530] systemd[1]: kmod-static-nodes.service: Succeeded.
[   11.046193] systemd[1]: Stopped Create list of static device nodes for the current kernel.
[   11.048683] systemd[1]: Startup finished in 1.931s (kernel) + 0 (initrd) + 8.906s (userspace) = 10.837s.
------
Ignition has failed. Please ensure your config is valid. Note that only
Ignition spec v3.0.0+ configs are accepted.

A CLI validation tool to check this called ignition-validate can be
downloaded from GitHub:
    https://github.com/coreos/ignition/releases
------

Displaying logs from failed units: ignition-ostree-mount-firstboot-sysroot.service
ignition-ostree-mount-var.service
ostree-prepare-root.service
-- Logs begin at Tue 2021-04-06 08:50:40 UTC, end at Tue 2021-04-06 08:50:48 UTC. --
Apr 06 08:50:42 systemd[1]: Starting Ignition OSTree: Mount (firstboot) /sysroot...
Apr 06 08:50:42 ignition-ostree-mount-sysroot[517]: Mounting /dev/disk/by-label/root (/dev/vda4) to /sysroot
Apr 06 08:50:48 ignition-ostree-mount-sysroot[521]: mount: /sysroot: mount(2) system call failed: Structure needs cleaning.
Apr 06 08:50:48 systemd[1]: [0;1;39m[0;1;31m[0;1;39mignition-ostree-mount-firstboot-sysroot.service: Main process exited, code=exited, status=32/n/a[0m
Apr 06 08:50:48 systemd[1]: [0;1;38;5;185m[0;1;39m[0;1;38;5;185mignition-ostree-mount-firstboot-sysroot.service: Failed with result 'exit-code'.[0m
Apr 06 08:50:48 systemd[1]: [0;1;31m[0;1;39m[0;1;31mFailed to start Ignition OSTree: Mount (firstboot) /sysroot.[0m
-- Logs begin at Tue 2021-04-06 08:50:40 UTC, end at Tue 2021-04-06 08:50:48 UTC. --
Apr 06 08:50:48 systemd[1]: Starting Mount OSTree /var...
Apr 06 08:50:48 ignition-ostree-mount-var[535]: /sysroot//ostree/boot.1/fedora-coreos/a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/0 is not a symlink
Apr 06 08:50:48 systemd[1]: [0;1;39m[0;1;31m[0;1;39mignition-ostree-mount-var.service: Main process exited, code=exited, status=1/FAILURE[0m
Apr 06 08:50:48 systemd[1]: [0;1;38;5;185m[0;1;39m[0;1;38;5;185mignition-ostree-mount-var.service: Failed with result 'exit-code'.[0m
Apr 06 08:50:48 systemd[1]: [0;1;31m[0;1;39m[0;1;31mFailed to start Mount OSTree /var.[0m
Apr 06 08:50:48 systemd[1]: ignition-ostree-mount-var.service: Triggering OnFailure= dependencies.
-- Logs begin at Tue 2021-04-06 08:50:40 UTC, end at Tue 2021-04-06 08:50:48 UTC. --
Apr 06 08:50:48 systemd[1]: Starting OSTree Prepare OS/...
Apr 06 08:50:48 systemd[1]: [0;1;39m[0;1;31m[0;1;39mostree-prepare-root.service: Main process exited, code=exited, status=1/FAILURE[0m
Apr 06 08:50:48 ostree-prepare-root[534]: ostree-prepare-root: Couldn't find specified OSTree root '/sysroot//ostree/boot.1/fedora-coreos/a5f8c1cd513bb95170dc8e8fa01a1738effd9484feef28e8f74fa685709af280/0': No such file or directory
Apr 06 08:50:48 systemd[1]: [0;1;38;5;185m[0;1;39m[0;1;38;5;185mostree-prepare-root.service: Failed with result 'exit-code'.[0m
Apr 06 08:50:48 systemd[1]: [0;1;31m[0;1;39m[0;1;31mFailed to start OSTree Prepare OS/.[0m
Apr 06 08:50:48 systemd[1]: ostree-prepare-root.service: Triggering OnFailure= dependencies.
Press Enter for emergency shell or wait 5 minutes for reboot.                 Press Enter for emergency shell or wait 4 minutes 45 seconds for reboot.      Press Enter for emergency shell or wait 4 minutes 30 seconds for reboot.      Press Enter for emergency shell or wait 4 minutes 15 seconds for reboot.      Press Enter for emergency shell or wait 4 minutes for reboot.                 Press Enter for emergency shell or wait 3 minutes 45 seconds for reboot.      Press Enter for emergency shell or wait 3 minutes 30 seconds for reboot.      Press Enter for emergency shell or wait 3 minutes 15 seconds for reboot.      Press Enter for emergency shell or wait 3 minutes for reboot.                 Press Enter for emergency shell or wait 2 minutes 45 seconds for reboot.      Press Enter for emergency shell or wait 2 minutes 30 seconds for reboot.      Press Enter for emergency shell or wait 2 minutes 15 seconds for reboot. 

@jlebon
Copy link
Member

jlebon commented Apr 7, 2021

@openstacker This looks like a different but serious issue. In your case, it looks like no restamping occurred unlike the original post. I've split it out into a separate issue: #784.

@ArneCL
Copy link
Author

ArneCL commented May 29, 2021

@jlebon
I tinkered around with Fedora 34.20210427.3.0 today.

  1. The error still persists, but due to the improved logging it can be seen that tune2fs seems to be failing. By accident, I managed to stop the boot-loop and get an emergency shell (by providing the ignition file at the end of this post)
    error

  2. Running tune2fs -U random /dev/vda3 fails, with error run e2fsck ... EVEN when e2fsck is run (see screenshot below.) I found a related issue at kernel.org, where they suggest to run tune2fs -O metadata_csum_seed -U random as a workaround. Running tune2fs with that option indeed works (see screenshot). Please note that in Support Raspberry Pi #258 / Comment @bjencks mentions facing an error with tune2fs too (not sure if these errors are related)
    tune2fs

Hopefully this provides enough information to fix this issue? If you need more details/logs/... feel free to ask!

Ignition File
With this ignition, fcos will try to write the enable-passwords.conf file two times and failing the second time, as the file already exists. This stopps the boot-loop and enables to access to the emergency-shell.

variant: fcos
version: 1.3.0
storage:
  files:
    - path: /etc/ssh/sshd_config.d/20-enable-passwords.conf
      mode: 0644
      contents:
        inline: |
          # Fedora CoreOS disables SSH password login by default.
          # Enable it.
          # This file must sort before 40-disable-passwords.conf.
          PasswordAuthentication yes

@dustymabe
Copy link
Member

Hey @ArneCL - I'm able to reproduce this on some local hardware I own. Unfortunately I think tune2fs -O metadata_csum_seed -U random will make it so that grub won't be able to access that filesystem. At least that's what happens to me and IIUC right now GRUB doesn't support that feature flag.

What does work for me is to change the UUID after install but before reboot. Something like:

sudo coreos-installer install /dev/sdX --ignition fcos.ign
sudo e2fsck -yf /dev/sdX3
sudo tune2fs -U random /dev/sdX3

The ignition-ostree-uuid-boot.service on the ignition boot will detect the UUID has been changed and gracefully exit and you'll be able to get past that issue.

We need to figure out how to make this problem go away, though. So that we don't need a workaround.

@cgwalters
Copy link
Member

I don't understand why this would only happen in some circumstances, or just on some hardware.

@dustymabe
Copy link
Member

dustymabe commented Jun 7, 2021

I don't understand why this would only happen in some circumstances, or just on some hardware.

Race condition maybe?

In my case I'm using a local build of FCOS for aarch64 and trying to install to a Raspberry Pi4 targetting a external USB drive (2T).

@bhale
Copy link

bhale commented Jun 9, 2021

I believe I am experiencing this same issue on a different hypervisor (KVM/libvirt) and I'm using RHCOS. The commonality is I am using TrueNAS SCALE and the underlying VirtIO/AHCI device being virtualized is backed by a ZFS ZVOL. This might have nothing to do with the loop, but I thought it was interesting that I share this with the OP.

I was attempting to run OCP 4.8 fc3 in my home lab to do some learning. However this boot loop was not resolved by the above instructions about tune2fs - even after e2fsck -yf, or, using tune2fs to mark the device as dirty and fscking again, tune2fs continued to refuse the -U random command, claiming the disk was not clean. Every other utility reported that the disk was clean.

Is there any other work around you could suggest to get past the uuid service not starting?

Are there any logs I could produce that would be helpful to the cause?

@bhale
Copy link

bhale commented Jun 9, 2021

BTW I've been having this same bootloop behavior with FCOS on the first boot, and I assumed I was doing something wrong with my ignition config. Once I hit this in OCP I figured out how to access my serial console for the emergency shell and did some deeper digging, which lead me to this issue. I can readily reproduce this with either FCOS or RHCOS, whichever helps.

@dustymabe
Copy link
Member

@bhale - are you using coreos-installer to install or are you picking up one of the other disk images?

@cgwalters
Copy link
Member

From: Lukas Czerner [email protected] 4:45 AM (5 hours ago)

I quickly went over the links below and it is pretty clear that the
e2fsck is being run right before the tune2fs, so it should work just
fine

    e2fsck -fy "${target}" && tune2fs -U random "${target}"

However the mounting itself is done with a coreos-assembler from the
link below and I understand that those two pieces of code will be run on
a completely different systems ?

One very trivial way to trigger the problem would be if there is a time
inconsistency between the two system such that even though the e2fsck is
being run after the mount in reality, the time set by e2fsck in s_lastcheck
precedes the time set by ext4 driver in s_mtime.

Then we hit this condition in tune2fs:

    /* Refuse to modify anything but a freshly checked valid filesystem. */
    if (!(fs->super->s_state & EXT2_VALID_FS) ||
       (fs->super->s_state & EXT2_ERROR_FS) ||
       (fs->super->s_lastcheck < fs->super->s_mtime)) {

It might explain why the problem is seen only sometimes on some
machines. Is it a likely explanation of what you're seeing ?

Now, e2fsck does have a check to prevent this sort of time related
problems and is able to fix it, however it has been bound to a condition
of a non-zero check interval. Unfortunately since the default is to disable
the periodic fsck, the value of checkinterval is zero and the time check
is bypassed. Maybe we should change that, I'll think about it.

@dustymabe dustymabe added the jira for syncing to jira label Jun 11, 2021
@dustymabe dustymabe self-assigned this Jun 11, 2021
@dustymabe dustymabe changed the title Boot-Loop on BHyve TrueNAS VM / "Failed to start Ignition OSTree: Generate filesystem UUID (boot)" tune2fs error causes ignition-ostree-uuid-boot.service to fail Jun 11, 2021
@dustymabe
Copy link
Member

OK we've been given a patched grub that allows us to use the metadata_csum_seed feature of the ext4 filesystem which will:

Allow the filesystem to store the metadata checksum seed in the superblock, enabling the administrator to change the UUID of a filesystem using the metadata_csum feature while it is mounted.

TL;DR It's a workaround for this problem and should prevent the need for us to run any filesystem checking before we run tune2fs -U random.

@ArneCL @openstacker @bhale - can I get you to test and report if the following dev builds help?

dustymabe added a commit to dustymabe/fedora-coreos-config that referenced this issue Jun 11, 2021
…ature

We're hitting issues in some cases where users are seeing the
`tune2fs -U random` on the /boot filesystem fail even though it's
ran directly after an `e2fsck`. To prevent needing a filesystem
check at all let's store the metadata checksum seed in the superblock
which will allow us to change the UUID without needing any filesystem
checks.

This was not possible before but we recently got a grub fix so that
having this filesystem feature enabled wouldn't cause grub2 to throw
an error.

- https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

Fixes: coreos/fedora-coreos-tracker#735
@bhale
Copy link

bhale commented Jun 12, 2021

@dustymabe That did the trick for me. Thank you for looking into this.

@dustymabe
Copy link
Member

OK Now I've got an easy reproducer for the problem, just setting the time to something in the not too distant past right before running the fsck and tune2fs. cosa build && cosa run with that is at least an easy reproducer. Should make testing fixes easier.

$ git diff HEAD^ overlay.d/05core/usr/lib/dracut/modules.d/40ignition-ostree/ignition-ostree-firstboot-uuid 
diff --git a/overlay.d/05core/usr/lib/dracut/modules.d/40ignition-ostree/ignition-ostree-firstboot-uuid b/overlay.d/05core/usr/lib/dracut/modules.d/40ignition-ostree/ignition-ostree-firstboot-uuid
index 0027bed..c9d734f 100755
--- a/overlay.d/05core/usr/lib/dracut/modules.d/40ignition-ostree/ignition-ostree-firstboot-uuid
+++ b/overlay.d/05core/usr/lib/dracut/modules.d/40ignition-ostree/ignition-ostree-firstboot-uuid
@@ -27,10 +27,9 @@ esac
 
 if [ "${TYPE}" == "${orig_type}" ] && [ "${UUID}" == "${orig_uuid}" ]; then
   case "${TYPE}" in
-    # For now we need to fsck first, see https://github.com/coreos/coreos-assembler/pull/1452
-    # Basically we're not passing `metadata_csum_seed` as a mkfs.ext4 option
-    # because grub2 barfs on it.
-    ext4) e2fsck -fy "${target}" && tune2fs -U random "${target}" ;;
+    ext4)
+          date --set="2021-04-14 20:12:00";
+          e2fsck -fy "${target}" && tune2fs -U random "${target}" ;;
     xfs) xfs_admin -U generate "${target}" ;;
     *) echo "unexpected filesystem type ${TYPE}" 1>&2; exit 1 ;;
   esac

dustymabe added a commit to dustymabe/fedora-coreos-config that referenced this issue Jun 14, 2021
…ature

We're hitting issues in some cases where users are seeing the
`tune2fs -U random` on the /boot filesystem fail even though it's
ran directly after an `e2fsck`. To prevent needing a filesystem
check at all let's store the metadata checksum seed in the superblock
which will allow us to change the UUID without needing any filesystem
checks.

This was not possible before but we recently got a grub fix so that
having this filesystem feature enabled wouldn't cause grub2 to throw
an error.

- https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

Fixes: coreos/fedora-coreos-tracker#735
dustymabe added a commit to dustymabe/fedora-coreos-config that referenced this issue Jun 14, 2021
…t metadata_csum_seed

It will be some time before we can support metadata_csum_seed in grub
on all our target platforms. This commit adds a workaround for the case
where grub doesn't support it yet. We specifically workaround the
behavior of tune2fs that isn't sensitive to timing inconsistencies.

See coreos/fedora-coreos-tracker#735 (comment)

Fixes: coreos/fedora-coreos-tracker#735
dustymabe added a commit to dustymabe/fedora-coreos-config that referenced this issue Jun 15, 2021
…t metadata_csum_seed

It will be some time before we can support metadata_csum_seed in grub
on all our target platforms. This commit adds a workaround for the case
where grub doesn't support it yet. We specifically workaround the
behavior of tune2fs that isn't sensitive to timing inconsistencies.

See coreos/fedora-coreos-tracker#735 (comment)

Fixes: coreos/fedora-coreos-tracker#735
jlebon pushed a commit to coreos/fedora-coreos-config that referenced this issue Jun 15, 2021
…ature

We're hitting issues in some cases where users are seeing the
`tune2fs -U random` on the /boot filesystem fail even though it's
ran directly after an `e2fsck`. To prevent needing a filesystem
check at all let's store the metadata checksum seed in the superblock
which will allow us to change the UUID without needing any filesystem
checks.

This was not possible before but we recently got a grub fix so that
having this filesystem feature enabled wouldn't cause grub2 to throw
an error.

- https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

Fixes: coreos/fedora-coreos-tracker#735
jlebon pushed a commit to coreos/fedora-coreos-config that referenced this issue Jun 15, 2021
…t metadata_csum_seed

It will be some time before we can support metadata_csum_seed in grub
on all our target platforms. This commit adds a workaround for the case
where grub doesn't support it yet. We specifically workaround the
behavior of tune2fs that isn't sensitive to timing inconsistencies.

See coreos/fedora-coreos-tracker#735 (comment)

Fixes: coreos/fedora-coreos-tracker#735
@dustymabe dustymabe added the status/pending-testing-release Fixed upstream. Waiting on a testing release. label Jun 15, 2021
dustymabe added a commit to dustymabe/coreos-assembler that referenced this issue Jun 15, 2021
Add support for a bootfs_metadata_csum_seed image.yaml knob that tells
us to enabled the metadata_csum_seed ext4 filesystem feature.
This is gated behind an image.yaml knob because support for this feature
flag was only recently added to grub.
https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

This helps us not have to run a filesystem check before running tune2fs
to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more
context.

The knob in image.yaml will look like:

```
bootfs_metadata_csum_seed: true
```
dustymabe added a commit to dustymabe/fedora-coreos-config that referenced this issue Jun 15, 2021
This will tell COSA to set the metadata_csum_seed filesystem feature
for the boot filesystem. This helps us not have to run a filesystem
check before running tune2fs to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.
dustymabe added a commit to dustymabe/fedora-coreos-config that referenced this issue Jun 15, 2021
This will tell COSA to set the metadata_csum_seed filesystem feature
for the boot filesystem. This helps us not have to run a filesystem
check before running tune2fs to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

Depends on coreos/coreos-assembler#2228
dustymabe added a commit to dustymabe/coreos-assembler that referenced this issue Jun 16, 2021
Add support for a bootfs_metadata_csum_seed image.yaml knob that tells
us to enabled the metadata_csum_seed ext4 filesystem feature.
This is gated behind an image.yaml knob because support for this feature
flag was only recently added to grub.
https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

This helps us not have to run a filesystem check before running tune2fs
to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more
context.

The knob in image.yaml will look like:

```
bootfs_metadata_csum_seed: true
```
dustymabe added a commit to dustymabe/coreos-assembler that referenced this issue Jun 16, 2021
Add support for a bootfs_metadata_csum_seed image.yaml knob that tells
us to enable the metadata_csum_seed ext4 filesystem feature. This is
gated behind an image.yaml knob because support for this feature flag
was only recently added to grub.
https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

This helps us not have to run a filesystem check before running tune2fs
to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

The knob in image.yaml will look like:

```
bootfs_metadata_csum_seed: true
```
darkmuggle pushed a commit to coreos/coreos-assembler that referenced this issue Jun 16, 2021
Add support for a bootfs_metadata_csum_seed image.yaml knob that tells
us to enable the metadata_csum_seed ext4 filesystem feature. This is
gated behind an image.yaml knob because support for this feature flag
was only recently added to grub.
https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

This helps us not have to run a filesystem check before running tune2fs
to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

The knob in image.yaml will look like:

```
bootfs_metadata_csum_seed: true
```
dustymabe added a commit to coreos/fedora-coreos-config that referenced this issue Jul 1, 2021
This will tell COSA to set the metadata_csum_seed filesystem feature
for the boot filesystem. This helps us not have to run a filesystem
check before running tune2fs to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

Depends on coreos/coreos-assembler#2228
@dustymabe
Copy link
Member

The fix for this went into testing stream release 34.20210626.2.0. Please try out the new release and report issues.

@dustymabe dustymabe added status/pending-stable-release Fixed upstream and in testing. Waiting on stable release. and removed status/pending-testing-release Fixed upstream. Waiting on a testing release. labels Jul 1, 2021
@dustymabe
Copy link
Member

The fix for this went into stable stream release 34.20210626.3.1.

@dustymabe dustymabe removed the status/pending-stable-release Fixed upstream and in testing. Waiting on stable release. label Jul 15, 2021
ravanelli pushed a commit to ravanelli/coreos-assembler that referenced this issue Aug 25, 2021
Add support for a bootfs_metadata_csum_seed image.yaml knob that tells
us to enable the metadata_csum_seed ext4 filesystem feature. This is
gated behind an image.yaml knob because support for this feature flag
was only recently added to grub.
https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

This helps us not have to run a filesystem check before running tune2fs
to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

The knob in image.yaml will look like:

```
bootfs_metadata_csum_seed: true
```
HuijingHei pushed a commit to HuijingHei/fedora-coreos-config that referenced this issue Oct 10, 2023
…ature

We're hitting issues in some cases where users are seeing the
`tune2fs -U random` on the /boot filesystem fail even though it's
ran directly after an `e2fsck`. To prevent needing a filesystem
check at all let's store the metadata checksum seed in the superblock
which will allow us to change the UUID without needing any filesystem
checks.

This was not possible before but we recently got a grub fix so that
having this filesystem feature enabled wouldn't cause grub2 to throw
an error.

- https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

Fixes: coreos/fedora-coreos-tracker#735
HuijingHei pushed a commit to HuijingHei/fedora-coreos-config that referenced this issue Oct 10, 2023
…t metadata_csum_seed

It will be some time before we can support metadata_csum_seed in grub
on all our target platforms. This commit adds a workaround for the case
where grub doesn't support it yet. We specifically workaround the
behavior of tune2fs that isn't sensitive to timing inconsistencies.

See coreos/fedora-coreos-tracker#735 (comment)

Fixes: coreos/fedora-coreos-tracker#735
HuijingHei pushed a commit to HuijingHei/fedora-coreos-config that referenced this issue Oct 10, 2023
This will tell COSA to set the metadata_csum_seed filesystem feature
for the boot filesystem. This helps us not have to run a filesystem
check before running tune2fs to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

Depends on coreos/coreos-assembler#2228
HuijingHei pushed a commit to HuijingHei/fedora-coreos-config that referenced this issue Oct 10, 2023
…ature

We're hitting issues in some cases where users are seeing the
`tune2fs -U random` on the /boot filesystem fail even though it's
ran directly after an `e2fsck`. To prevent needing a filesystem
check at all let's store the metadata checksum seed in the superblock
which will allow us to change the UUID without needing any filesystem
checks.

This was not possible before but we recently got a grub fix so that
having this filesystem feature enabled wouldn't cause grub2 to throw
an error.

- https://lists.gnu.org/archive/html/grub-devel/2021-06/msg00031.html

Fixes: coreos/fedora-coreos-tracker#735
HuijingHei pushed a commit to HuijingHei/fedora-coreos-config that referenced this issue Oct 10, 2023
…t metadata_csum_seed

It will be some time before we can support metadata_csum_seed in grub
on all our target platforms. This commit adds a workaround for the case
where grub doesn't support it yet. We specifically workaround the
behavior of tune2fs that isn't sensitive to timing inconsistencies.

See coreos/fedora-coreos-tracker#735 (comment)

Fixes: coreos/fedora-coreos-tracker#735
HuijingHei pushed a commit to HuijingHei/fedora-coreos-config that referenced this issue Oct 10, 2023
This will tell COSA to set the metadata_csum_seed filesystem feature
for the boot filesystem. This helps us not have to run a filesystem
check before running tune2fs to randomize the filesystem UUID on first boot. See
coreos/fedora-coreos-tracker#735 for more context.

Depends on coreos/coreos-assembler#2228
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
Projects
None yet
Development

Successfully merging a pull request may close this issue.

9 participants