Console Output
22:05:25 [2025-02-24T22:05:25.427Z] + set -xeuo pipefail
22:05:25 [2025-02-24T22:05:25.427Z] ++ umask
22:05:25 [2025-02-24T22:05:25.427Z] + '[' 0022 = 0000 ']'
22:05:25 [2025-02-24T22:05:25.427Z] + cd /home/jenkins/agent/workspace/test-override
22:05:25 [2025-02-24T22:05:25.427Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-TCtr1/kola-x86_64 --on-warn-failure-exit-77 --arch=x86_64 '--tag=!reprovision' --parallel=5
22:05:25 [2025-02-24T22:05:25.427Z] kola -p qemu --build latest run --rerun --allow-rerun-success=tags=needs-internet --on-warn-failure-exit-77 --arch=x86_64 --tag=!reprovision --parallel=5 --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-TCtr1/kola-x86_64
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.nmstate.policy
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.swap.zram-generator
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.misc.disk.varlibcontainers
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.groups
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.docker.basic
22:05:25 [2025-02-24T22:05:25.984Z] === RUN podman.base
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.no-default-initramfs-net-propagation.bootif
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.butane.grub-users
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.kargs
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.kdump.crash
22:05:25 [2025-02-24T22:05:25.984Z] === RUN rhcos.selinux.boolean.persist
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.delete-config
22:05:25 [2025-02-24T22:05:25.984Z] === RUN multipath.day2
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.hostname.fallback-hostname
22:05:25 [2025-02-24T22:05:25.984Z] === RUN multipath.day1
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.sethostname
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.bridge-static-via-kargs
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.systemd.condition-needs-update
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.ifname-karg.udev-rule-firstboot-propagation
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.unique.boot.failure
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.prefer-ignition-networking
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.instantiated.enable-unit
22:05:25 [2025-02-24T22:05:25.984Z] === RUN basic
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.rd-net-timeout-carrier
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.rpm-ostree-countme
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.v2.users
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.systemd.network-online
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.force-persist-ip
22:05:25 [2025-02-24T22:05:25.984Z] === RUN rpmostree.upgrade-rollback
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.selinux.boolean
22:05:25 [2025-02-24T22:05:25.984Z] === RUN rpmostree.status
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.systemd-enable-units
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.systemd-disable
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.extensions.package
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.gshadow
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.resource.remote
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ostree.remote
22:05:25 [2025-02-24T22:05:25.984Z] === RUN podman.network-single
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.var-mount.scsi-id
22:05:25 [2025-02-24T22:05:25.984Z] === RUN rootfs.uuid
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.kargs-rd-net
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.podman.rootless-systemd
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.toolbox
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.mtu-on-bond-ignition
22:05:25 [2025-02-24T22:05:25.984Z] === RUN fcos.users.shells
22:05:25 [2025-02-24T22:05:25.984Z] === RUN rpmostree.install-uninstall
22:05:25 [2025-02-24T22:05:25.984Z] === RUN basic.nvme
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.nameserver
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.boot.bootupd-validate
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ntp.timesyncd.dhcp-propagation
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.unique.boot.ignition.failure
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.boot.grub2-install
22:05:25 [2025-02-24T22:05:25.984Z] === RUN kdump.crash.ssh
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.selinux.enforcing
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.ifname-karg.everyboot-systemd-link-file
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.auth.verify
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.containers.quadlet
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ssh.custom-host-key-permissions
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.failure
22:05:25 [2025-02-24T22:05:25.984Z] === RUN fcos.network.listeners
22:05:25 [2025-02-24T22:05:25.984Z] === RUN basic.uefi
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.disks.lvmdevices
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.mtu-on-bond-kargs
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.stable-boot
22:05:25 [2025-02-24T22:05:25.984Z] === RUN multipath.partition
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.team-dhcp-via-ignition
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.once
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.networking.nmstate.state
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.symlink
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.remote
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.var-mount.simple
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ntp.chrony.dhcp-propagation
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.clhm.ignition-warnings
22:05:25 [2025-02-24T22:05:25.984Z] === RUN basic.uefi-secure
22:05:25 [2025-02-24T22:05:25.984Z] === RUN fcos.filesystem
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.mount.partitions
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ostree.unlock
22:05:25 [2025-02-24T22:05:25.984Z] === RUN coreos.ignition.mount.disks
22:05:25 [2025-02-24T22:05:25.984Z] === RUN ext.config.ignition.systemd-unmasking
22:05:25 [2025-02-24T22:05:25.985Z] === RUN non-exclusive-test-bucket-0
22:05:25 [2025-02-24T22:05:25.985Z] === RUN ostree.hotfix
22:05:25 [2025-02-24T22:05:25.985Z] === RUN ext.config.var-mount.luks
22:05:25 [2025-02-24T22:05:25.985Z] === RUN podman.workflow
22:05:25 [2025-02-24T22:05:25.985Z] === RUN ext.config.reboot
22:05:25 [2025-02-24T22:05:25.985Z] === RUN ext.config.firewall.iptables-legacy
22:05:25 [2025-02-24T22:05:25.985Z] === RUN ext.config.networking.no-persist-ip
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/MachineID
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/FCOSGrowpart
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/PortSSH
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/DbusPerms
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/ServicesActive
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/ReadOnly
22:06:04 [2025-02-24T22:06:04.606Z] === RUN basic/Useradd
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: coreos.auth.verify (36.16s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: fcos.users.shells (36.18s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic (37.86s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/MachineID (0.12s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/FCOSGrowpart (0.15s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/PortSSH (0.11s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/DbusPerms (0.35s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/ServicesActive (0.12s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/ReadOnly (0.11s)
22:06:04 [2025-02-24T22:06:04.606Z] --- [32mPASS[0m: basic/Useradd (0.22s)
22:06:51 [2025-02-24T22:06:51.179Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-ignition (47.00s)
22:08:12 [2025-02-24T22:08:12.498Z] --- [32mPASS[0m: ext.config.toolbox (125.42s)
22:08:13 [2025-02-24T22:08:13.055Z] --- [32mPASS[0m: ext.config.podman.rootless-systemd (84.09s)
22:08:45 [2025-02-24T22:08:45.303Z] === RUN rootfs.uuid/RandomUUID
22:08:48 [2025-02-24T22:08:48.558Z] --- [32mPASS[0m: rootfs.uuid (35.40s)
22:08:48 [2025-02-24T22:08:48.558Z] --- [32mPASS[0m: rootfs.uuid/RandomUUID (0.43s)
22:08:49 [2025-02-24T22:08:49.911Z] --- [32mPASS[0m: ext.config.networking.kargs-rd-net (40.72s)
22:09:36 [2025-02-24T22:09:36.482Z] --- [32mPASS[0m: ext.config.var-mount.scsi-id (43.94s)
22:10:08 [2025-02-24T22:10:08.451Z] === RUN ostree.remote/add
22:10:08 [2025-02-24T22:10:08.451Z] === RUN ostree.remote/list
22:10:08 [2025-02-24T22:10:08.451Z] === RUN ostree.remote/show-url
22:10:08 [2025-02-24T22:10:08.451Z] === RUN ostree.remote/refs
22:10:08 [2025-02-24T22:10:08.451Z] === RUN ostree.remote/summary
22:10:08 [2025-02-24T22:10:08.451Z] === RUN ostree.remote/delete
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote (37.99s)
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote/add (0.24s)
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote/list (0.11s)
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote/show-url (0.20s)
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote/refs (0.15s)
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote/summary (0.28s)
22:10:10 [2025-02-24T22:10:10.955Z] --- [32mPASS[0m: ostree.remote/delete (0.43s)
22:10:58 [2025-02-24T22:10:58.007Z] --- [32mPASS[0m: ext.config.gshadow (39.87s)
22:11:12 [2025-02-24T22:11:12.871Z] === RUN rpmostree.upgrade-rollback/upgrade
22:13:04 [2025-02-24T22:13:04.200Z] --- [31mFAIL[0m: coreos.ignition.once (444.56s)
22:13:04 [2025-02-24T22:13:04.200Z] harness.go:1740: Found kernel oops on machine 2dc31e2d-cda1-400c-9de8-56abd85b51bc console
22:13:22 [2025-02-24T22:13:22.529Z] --- [32mPASS[0m: ext.config.ignition.systemd-disable (29.27s)
22:13:54 [2025-02-24T22:13:54.513Z] --- [31mFAIL[0m: ext.config.networking.nmstate.policy (506.61s)
22:13:54 [2025-02-24T22:13:54.513Z] harness.go:1740: Found kernel oops on machine 4b9270da-668a-4a36-a183-49b9ce5f85a3 console
22:13:58 [2025-02-24T22:13:58.664Z] --- [32mPASS[0m: ext.config.ignition.systemd-enable-units (38.47s)
22:14:25 [2025-02-24T22:14:25.112Z] --- [32mPASS[0m: rpmostree.status (25.00s)
22:14:35 [2025-02-24T22:14:35.015Z] --- [31mFAIL[0m: ext.config.ignition.resource.remote (42.01s)
22:14:35 [2025-02-24T22:14:35.015Z] harness.go:1740: Found kernel oops on machine 5df1ac0c-cbcd-43e1-846b-561ad62929e3 console
22:15:01 [2025-02-24T22:15:01.478Z] --- [32mPASS[0m: coreos.ignition.v2.users (24.66s)
22:15:33 [2025-02-24T22:15:33.465Z] --- [32mPASS[0m: ext.config.networking.force-persist-ip (29.82s)
22:18:24 [2025-02-24T22:18:24.794Z] === RUN rpmostree.upgrade-rollback/rollback
22:21:16 [2025-02-24T22:21:16.138Z] 2025-02-24T22:21:07Z kola: Test timed out. Adding as candidate for rerun success: ext.config.extensions.package
22:21:16 [2025-02-24T22:21:16.138Z] --- [31mFAIL[0m: ext.config.extensions.package (905.18s)
22:21:16 [2025-02-24T22:21:16.138Z] harness.go:106: TIMEOUT[15m0s]: ssh: sudo /usr/local/bin/kolet run-test-unit kola-runext.service
22:21:16 [2025-02-24T22:21:16.138Z] harness.go:106: TIMEOUT[15m0s]: ssh: journalctl -t kola-runext-package
22:21:16 [2025-02-24T22:21:16.138Z] harness.go:1740: Found kernel oops on machine ee080db9-c55d-40d2-b7dd-9d300004696a console
22:21:16 [2025-02-24T22:21:16.138Z] harness.go:1740: Found kernel soft lockup on machine ee080db9-c55d-40d2-b7dd-9d300004696a console
22:21:37 [2025-02-24T22:21:37.994Z] --- [31mFAIL[0m: coreos.selinux.boolean (432.47s)
22:21:37 [2025-02-24T22:21:37.994Z] harness.go:1740: Found kernel oops on machine 4d96d6db-d683-4fb9-893f-628ddae925fb console
22:21:46 [2025-02-24T22:21:46.050Z] --- [32mPASS[0m: ext.config.systemd.network-online (38.56s)
22:22:07 [2025-02-24T22:22:07.895Z] === RUN ostree.unlock/unlock
22:22:07 [2025-02-24T22:22:07.895Z] === RUN ostree.unlock/install
22:22:07 [2025-02-24T22:22:07.895Z] === RUN ostree.unlock/uninstall
22:22:08 [2025-02-24T22:22:08.148Z] === RUN ostree.unlock/discard
22:22:13 [2025-02-24T22:22:13.366Z] --- [32mPASS[0m: ext.config.clhm.ignition-warnings (37.59s)
22:22:59 [2025-02-24T22:22:59.929Z] --- [31mFAIL[0m: coreos.ignition.mount.disks (444.84s)
22:22:59 [2025-02-24T22:22:59.929Z] harness.go:1740: Found kernel oops on machine 36f5388c-0b36-4ed1-a6cd-fda5e9975b12 console
22:23:14 [2025-02-24T22:23:14.751Z] === RUN fcos.filesystem/writablefiles
22:23:15 [2025-02-24T22:23:15.307Z] === RUN fcos.filesystem/writabledirs
22:23:15 [2025-02-24T22:23:15.560Z] === RUN fcos.filesystem/stickydirs
22:23:16 [2025-02-24T22:23:16.126Z] === RUN fcos.filesystem/denylist
22:23:20 [2025-02-24T22:23:20.270Z] --- [32mPASS[0m: fcos.filesystem (26.25s)
22:23:20 [2025-02-24T22:23:20.270Z] --- [32mPASS[0m: fcos.filesystem/writablefiles (0.90s)
22:23:20 [2025-02-24T22:23:20.270Z] --- [32mPASS[0m: fcos.filesystem/writabledirs (0.27s)
22:23:20 [2025-02-24T22:23:20.270Z] --- [32mPASS[0m: fcos.filesystem/stickydirs (0.31s)
22:23:20 [2025-02-24T22:23:20.270Z] --- [32mPASS[0m: fcos.filesystem/denylist (0.37s)
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/MachineID
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/FCOSGrowpart
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/PortSSH
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/DbusPerms
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/ServicesActive
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/ReadOnly
22:23:58 [2025-02-24T22:23:58.900Z] === RUN basic.uefi-secure/Useradd
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure (38.61s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/MachineID (0.11s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/FCOSGrowpart (0.15s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/PortSSH (0.12s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/DbusPerms (0.37s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/ServicesActive (0.13s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/ReadOnly (0.12s)
22:23:58 [2025-02-24T22:23:58.900Z] --- [32mPASS[0m: basic.uefi-secure/Useradd (0.21s)
22:24:45 [2025-02-24T22:24:45.475Z] --- [32mPASS[0m: ext.config.networking.no-persist-ip (39.45s)
22:25:17 [2025-02-24T22:25:17.465Z] --- [32mPASS[0m: ext.config.firewall.iptables-legacy (37.79s)
22:25:18 [2025-02-24T22:25:18.020Z] --- [31mFAIL[0m: rpmostree.upgrade-rollback (867.73s)
22:25:18 [2025-02-24T22:25:18.021Z] --- [32mPASS[0m: rpmostree.upgrade-rollback/upgrade (430.27s)
22:25:18 [2025-02-24T22:25:18.021Z] --- [32mPASS[0m: rpmostree.upgrade-rollback/rollback (412.54s)
22:25:18 [2025-02-24T22:25:18.021Z] harness.go:1740: Found kernel oops on machine 2351cfde-e1e2-4481-a291-b6a0375ee59c console
22:25:56 [2025-02-24T22:25:56.643Z] === RUN ostree.hotfix/unlock
22:26:01 [2025-02-24T22:26:01.861Z] === RUN ostree.hotfix/install
22:26:02 [2025-02-24T22:26:02.149Z] === RUN ostree.hotfix/uninstall
22:26:03 [2025-02-24T22:26:03.077Z] === RUN ostree.hotfix/persist
22:29:09 [2025-02-24T22:29:09.444Z] 2025-02-24T22:28:54Z kola: Test timed out. Adding as candidate for rerun success: podman.network-single
22:29:09 [2025-02-24T22:29:09.444Z] --- [31mFAIL[0m: podman.network-single (1204.89s)
22:29:09 [2025-02-24T22:29:09.444Z] harness.go:106: TIMEOUT[20m0s]: ssh: for i in $(seq 1 100); do
22:29:09 [2025-02-24T22:29:09.444Z] echo -n "$i: "
22:29:09 [2025-02-24T22:29:09.444Z] sudo podman run --rm ping sh -c 'ping -i 0.2 10.88.0.1 -w 1 >/dev/null && echo PASS || echo FAIL'
22:29:09 [2025-02-24T22:29:09.444Z] done
22:29:09 [2025-02-24T22:29:09.444Z] harness.go:1740: Found kernel oops on machine 4ccd31ce-d731-438f-9abe-b09394feed7c console
22:29:09 [2025-02-24T22:29:09.444Z] harness.go:1740: Found kernel soft lockup on machine 4ccd31ce-d731-438f-9abe-b09394feed7c console
22:29:09 [2025-02-24T22:29:09.444Z] --- [31mFAIL[0m: ostree.unlock (434.19s)
22:29:09 [2025-02-24T22:29:09.444Z] --- [32mPASS[0m: ostree.unlock/unlock (0.60s)
22:29:09 [2025-02-24T22:29:09.444Z] --- [32mPASS[0m: ostree.unlock/install (0.55s)
22:29:09 [2025-02-24T22:29:09.444Z] --- [32mPASS[0m: ostree.unlock/uninstall (0.41s)
22:29:09 [2025-02-24T22:29:09.444Z] --- [32mPASS[0m: ostree.unlock/discard (408.51s)
22:29:09 [2025-02-24T22:29:09.444Z] harness.go:1740: Found kernel oops on machine 1e6a3773-10ef-4747-8faf-2b787907bcf5 console
22:29:21 [2025-02-24T22:29:21.584Z] === RUN podman.workflow/run
22:29:39 [2025-02-24T22:29:39.587Z] --- [31mFAIL[0m: coreos.ignition.mount.partitions (444.19s)
22:29:39 [2025-02-24T22:29:39.587Z] harness.go:1740: Found kernel oops on machine 4d66cc3e-7abc-4362-8a17-3c4031244635 console
22:29:46 [2025-02-24T22:29:46.104Z] === RUN non-exclusive-test-bucket-0/ext.config.files.check-symlink
22:29:47 [2025-02-24T22:29:47.022Z] === RUN non-exclusive-test-bucket-0/ext.config.files.logrotate-service
22:29:48 [2025-02-24T22:29:48.904Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.growfs
22:29:49 [2025-02-24T22:29:49.158Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context
22:29:51 [2025-02-24T22:29:51.033Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default
22:29:52 [2025-02-24T22:29:52.339Z] === RUN non-exclusive-test-bucket-0/ext.config.clhm.network-device-info
22:29:53 [2025-02-24T22:29:53.271Z] === RUN non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking
22:29:59 [2025-02-24T22:29:59.789Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.nm-start
22:30:00 [2025-02-24T22:30:00.345Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context
22:30:01 [2025-02-24T22:30:01.263Z] === RUN non-exclusive-test-bucket-0/ext.config.files.license
22:30:01 [2025-02-24T22:30:01.818Z] === RUN non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts
22:30:03 [2025-02-24T22:30:03.691Z] === RUN non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir
22:30:03 [2025-02-24T22:30:03.944Z] === RUN non-exclusive-test-bucket-0/ext.config.files.fcos_groups
22:30:05 [2025-02-24T22:30:05.816Z] === RUN non-exclusive-test-bucket-0/ext.config.files.kernel-headers
22:30:06 [2025-02-24T22:30:06.370Z] === RUN non-exclusive-test-bucket-0/ext.config.files.fcos_users
22:30:08 [2025-02-24T22:30:08.252Z] === RUN non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch
22:30:10 [2025-02-24T22:30:10.750Z] === RUN non-exclusive-test-bucket-0/ext.config.files.sudoers
22:30:11 [2025-02-24T22:30:11.305Z] === RUN non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite
22:30:11 [2025-02-24T22:30:11.860Z] === RUN non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit
22:30:12 [2025-02-24T22:30:12.778Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.tmpfs
22:30:13 [2025-02-24T22:30:13.334Z] === RUN non-exclusive-test-bucket-0/ext.config.swap.zram-default
22:30:13 [2025-02-24T22:30:13.888Z] === RUN non-exclusive-test-bucket-0/ext.config.podman.dns
22:30:15 [2025-02-24T22:30:15.760Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service
22:30:17 [2025-02-24T22:30:17.120Z] === RUN non-exclusive-test-bucket-0/ext.config.boot.bootupd
22:30:18 [2025-02-24T22:30:18.990Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.network-online-service
22:30:20 [2025-02-24T22:30:20.871Z] === RUN non-exclusive-test-bucket-0/ext.config.files.initrd.compression
22:30:22 [2025-02-24T22:30:22.222Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match
22:30:34 [2025-02-24T22:30:34.358Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.tls
22:30:38 [2025-02-24T22:30:38.514Z] === RUN non-exclusive-test-bucket-0/ext.config.files.aleph-version
22:30:40 [2025-02-24T22:30:40.385Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin
22:30:41 [2025-02-24T22:30:41.737Z] === RUN non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps
22:30:43 [2025-02-24T22:30:43.611Z] === RUN non-exclusive-test-bucket-0/ext.config.files.setuid
22:30:44 [2025-02-24T22:30:44.964Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved
22:30:46 [2025-02-24T22:30:46.847Z] === RUN non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2
22:30:47 [2025-02-24T22:30:47.401Z] === RUN non-exclusive-test-bucket-0/ext.config.files.root-bash
22:30:49 [2025-02-24T22:30:49.285Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change
22:30:50 [2025-02-24T22:30:50.650Z] === RUN non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot
22:30:52 [2025-02-24T22:30:52.533Z] === RUN non-exclusive-test-bucket-0/ext.config.security.passwd
22:30:54 [2025-02-24T22:30:54.405Z] === RUN non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents
22:32:01 [2025-02-24T22:32:01.976Z] === RUN non-exclusive-test-bucket-0/ext.config.firewall.iptables
22:32:48 [2025-02-24T22:32:48.557Z] --- [31mFAIL[0m: ext.config.reboot (446.58s)
22:32:48 [2025-02-24T22:32:48.557Z] harness.go:1740: Found kernel oops on machine 248da929-da01-47d9-933d-6aba2e1d8b73 console
22:32:51 [2025-02-24T22:32:51.815Z] === RUN ostree.hotfix/rollback
22:33:23 [2025-02-24T22:33:23.804Z] --- [32mPASS[0m: ext.config.ignition.systemd-unmasking (38.61s)
22:33:35 [2025-02-24T22:33:35.949Z] --- [32mPASS[0m: coreos.unique.boot.ignition.failure (14.71s)
22:37:27 [2025-02-24T22:37:27.348Z] --- [31mFAIL[0m: ext.config.var-mount.luks (458.24s)
22:37:27 [2025-02-24T22:37:27.348Z] harness.go:1740: Found kernel oops on machine 5fda5c65-d72b-4400-a041-f37c0c28314a console
22:39:33 [2025-02-24T22:39:33.692Z] === RUN podman.workflow/exec
22:39:33 [2025-02-24T22:39:33.692Z] === RUN podman.workflow/stop
22:39:33 [2025-02-24T22:39:33.692Z] === RUN podman.workflow/remove
22:39:33 [2025-02-24T22:39:33.692Z] === RUN podman.workflow/delete
22:39:33 [2025-02-24T22:39:33.692Z] --- [31mFAIL[0m: podman.workflow (623.97s)
22:39:33 [2025-02-24T22:39:33.692Z] --- [31mFAIL[0m: podman.workflow/run (600.00s)
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:151: Getting image source signatures
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:151: Copying blob sha256:414996200a113ee98b3f12ebfbb1778efad68e4e5767192f1928df7bfb875b3d
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:151: Copying config sha256:0954472fae24a5cb03525ed4f98bcad7a7f6c3a400b840a880b33117977bdedd
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:151: Writing manifest to image destination
22:39:33 [2025-02-24T22:39:33.692Z] harness.go:106: TIMEOUT[10m0s]: ssh: curl -f http://localhost 2>/dev/null
22:39:33 [2025-02-24T22:39:33.692Z] --- [34mSKIP[0m: podman.workflow/exec (0.00s)
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:54: A previous test has already failed
22:39:33 [2025-02-24T22:39:33.692Z] --- [34mSKIP[0m: podman.workflow/stop (0.00s)
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:54: A previous test has already failed
22:39:33 [2025-02-24T22:39:33.692Z] --- [34mSKIP[0m: podman.workflow/remove (0.00s)
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:54: A previous test has already failed
22:39:33 [2025-02-24T22:39:33.692Z] --- [34mSKIP[0m: podman.workflow/delete (0.00s)
22:39:33 [2025-02-24T22:39:33.692Z] cluster.go:54: A previous test has already failed
22:39:33 [2025-02-24T22:39:33.692Z] harness.go:1740: Found kernel oops on machine b87fce6a-b631-4ac1-8f35-2ce440b3ae54 console
22:39:33 [2025-02-24T22:39:33.692Z] harness.go:1740: Found kernel soft lockup on machine b87fce6a-b631-4ac1-8f35-2ce440b3ae54 console
22:39:45 [2025-02-24T22:39:45.838Z] --- [31mFAIL[0m: ostree.hotfix (866.13s)
22:39:45 [2025-02-24T22:39:45.838Z] --- [32mPASS[0m: ostree.hotfix/unlock (10.49s)
22:39:45 [2025-02-24T22:39:45.838Z] --- [32mPASS[0m: ostree.hotfix/install (0.70s)
22:39:45 [2025-02-24T22:39:45.838Z] --- [32mPASS[0m: ostree.hotfix/uninstall (0.42s)
22:39:45 [2025-02-24T22:39:45.838Z] --- [32mPASS[0m: ostree.hotfix/persist (408.27s)
22:39:45 [2025-02-24T22:39:45.838Z] --- [32mPASS[0m: ostree.hotfix/rollback (409.26s)
22:39:45 [2025-02-24T22:39:45.838Z] harness.go:1740: Found kernel oops on machine 38c5dabc-6722-4a4a-955d-3bd7a4bee50f console
22:40:12 [2025-02-24T22:40:12.293Z] --- [32mPASS[0m: ext.config.ignition.remote (47.86s)
22:41:08 [2025-02-24T22:41:08.411Z] --- [31mFAIL[0m: ext.config.networking.rd-net-timeout-carrier (448.96s)
22:41:08 [2025-02-24T22:41:08.411Z] harness.go:1740: Found kernel oops on machine c8974441-3733-413a-8875-5a330108baa8 console
22:44:14 [2025-02-24T22:44:14.788Z] --- [31mFAIL[0m: kdump.crash.ssh (237.02s)
22:44:14 [2025-02-24T22:44:14.788Z] kdump.go:197: Timed out while waiting for kdump.service to be ready: Process exited with status 3
22:44:36 [2025-02-24T22:44:36.645Z] --- [32mPASS[0m: ext.config.rpm-ostree-countme (27.23s)
22:44:46 [2025-02-24T22:44:46.554Z] --- [31mFAIL[0m: ext.config.networking.ifname-karg.everyboot-systemd-link-file (449.24s)
22:44:46 [2025-02-24T22:44:46.554Z] harness.go:1740: Found kernel oops on machine a8921dcc-c391-4fad-b797-041b0846434b console
22:45:04 [2025-02-24T22:45:04.548Z] --- [32mPASS[0m: ext.config.boot.grub2-install (27.25s)
22:48:41 [2025-02-24T22:48:41.065Z] --- [31mFAIL[0m: ext.config.var-mount.simple (446.59s)
22:48:41 [2025-02-24T22:48:41.065Z] harness.go:1740: Found kernel oops on machine 05798031-9624-4800-88bc-9475e7e9a262 console
22:52:17 [2025-02-24T22:52:17.449Z] --- [31mFAIL[0m: ext.config.selinux.enforcing (445.72s)
22:52:17 [2025-02-24T22:52:17.449Z] harness.go:1740: Found kernel oops on machine 7c4b000f-c63a-4f12-bccb-ee0404761ba8 console
22:52:56 [2025-02-24T22:52:56.069Z] --- [32mPASS[0m: ext.config.networking.bridge-static-via-kargs (41.13s)
22:53:34 [2025-02-24T22:53:34.696Z] --- [32mPASS[0m: coreos.ignition.instantiated.enable-unit (37.24s)
22:53:56 [2025-02-24T22:53:56.545Z] --- [32mPASS[0m: coreos.ignition.sethostname (24.48s)
22:54:52 [2025-02-24T22:54:52.666Z] 2025-02-24T22:54:49Z kola: Test timed out. Adding as candidate for rerun success: ext.config.ntp.chrony.dhcp-propagation
22:54:52 [2025-02-24T22:54:52.666Z] --- [31mFAIL[0m: ext.config.ntp.chrony.dhcp-propagation (905.12s)
22:54:52 [2025-02-24T22:54:52.666Z] harness.go:106: TIMEOUT[15m0s]: ssh: sudo /usr/local/bin/kolet run-test-unit kola-runext.service
22:54:52 [2025-02-24T22:54:52.666Z] harness.go:106: TIMEOUT[15m0s]: ssh: journalctl -t kola-runext-dhcp-propagation
22:54:52 [2025-02-24T22:54:52.667Z] harness.go:1740: Found kernel oops on machine d13b754e-e9f9-4bd8-9e13-b22c34ab52db console
22:55:31 [2025-02-24T22:55:31.288Z] --- [32mPASS[0m: ext.config.networking.prefer-ignition-networking (41.35s)
22:56:27 [2025-02-24T22:56:27.416Z] --- [32mPASS[0m: multipath.day1 (55.62s)
22:57:13 [2025-02-24T22:57:13.990Z] --- [32mPASS[0m: ext.config.networking.team-dhcp-via-ignition (41.21s)
22:57:13 [2025-02-24T22:57:13.990Z] mke2fs 1.47.1 (20-May-2024)
22:57:20 [2025-02-24T22:57:20.499Z] --- [32mPASS[0m: coreos.unique.boot.failure (12.33s)
22:57:59 [2025-02-24T22:57:59.119Z] --- [32mPASS[0m: ext.config.networking.hostname.fallback-hostname (38.89s)
22:59:06 [2025-02-24T22:59:06.737Z] 2025-02-24T22:59:04Z kola: Test timed out. Adding as candidate for rerun success: ext.config.ignition.delete-config
22:59:06 [2025-02-24T22:59:06.737Z] --- [31mFAIL[0m: ext.config.ignition.delete-config (841.31s)
22:59:06 [2025-02-24T22:59:06.737Z] harness.go:106: TIMEOUT[10m0s]: ssh: sudo /usr/local/bin/kolet run-test-unit kola-runext.service
22:59:06 [2025-02-24T22:59:06.737Z] harness.go:106: TIMEOUT[10m0s]: ssh: journalctl -t kola-runext-test.sh
22:59:06 [2025-02-24T22:59:06.737Z] harness.go:1740: Found kernel oops on machine 003784aa-84eb-4875-a078-ea446ce61312 console
23:01:28 [2025-02-24T23:01:28.104Z] --- [31mFAIL[0m: ext.config.disks.lvmdevices (446.59s)
23:01:28 [2025-02-24T23:01:28.104Z] harness.go:1740: Found kernel oops on machine 479a1a34-48bb-42cc-9ced-15aff45047fa console
23:03:04 [2025-02-24T23:03:04.437Z] 2025-02-24T23:03:01Z kola: Test timed out. Adding as candidate for rerun success: ext.config.systemd.condition-needs-update
23:03:04 [2025-02-24T23:03:04.437Z] --- [31mFAIL[0m: ext.config.systemd.condition-needs-update (870.43s)
23:03:04 [2025-02-24T23:03:04.437Z] harness.go:106: TIMEOUT[10m0s]: ssh: sudo /usr/local/bin/kolet run-test-unit kola-runext.service
23:03:04 [2025-02-24T23:03:04.437Z] harness.go:106: TIMEOUT[10m0s]: ssh: journalctl -t kola-runext-condition-needs-update
23:03:04 [2025-02-24T23:03:04.437Z] harness.go:1740: Found kernel oops on machine 70c354a0-1173-480e-b219-cc50bc871258 console
23:03:36 [2025-02-24T23:03:36.431Z] --- [32mPASS[0m: ext.config.networking.no-default-initramfs-net-propagation.bootif (29.34s)
23:04:02 [2025-02-24T23:04:02.889Z] --- [32mPASS[0m: ext.config.ignition.stable-boot (28.57s)
23:04:41 [2025-02-24T23:04:41.503Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-kargs (41.04s)
23:05:28 [2025-02-24T23:05:28.087Z] --- [31mFAIL[0m: ext.config.networking.ifname-karg.udev-rule-firstboot-propagation (447.30s)
23:05:28 [2025-02-24T23:05:28.087Z] harness.go:1740: Found kernel oops on machine 526d2ed3-31ba-4560-8e8b-94685aaae1ae console
23:06:35 [2025-02-24T23:06:35.670Z] --- [31mFAIL[0m: multipath.partition (444.90s)
23:06:35 [2025-02-24T23:06:35.670Z] harness.go:1740: Found kernel oops on machine cbc6f77f-e0c8-407a-8768-a14dba0117fe console
23:07:07 [2025-02-24T23:07:07.674Z] --- [32mPASS[0m: ext.config.ignition.kargs (38.01s)
23:07:25 [2025-02-24T23:07:25.681Z] --- [32mPASS[0m: coreos.ignition.failure (15.81s)
23:08:12 [2025-02-24T23:08:12.260Z] systemctl status kola-runext.service:
23:08:12 [2025-02-24T23:08:12.260Z] �� kola-runext.service
23:08:12 [2025-02-24T23:08:12.260Z] Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
23:08:12 [2025-02-24T23:08:12.260Z] Drop-In: /usr/lib/systemd/system/service.d
23:08:12 [2025-02-24T23:08:12.260Z] ������10-timeout-abort.conf, 50-keep-warm.conf
23:08:12 [2025-02-24T23:08:12.260Z] Active: failed (Result: exit-code) since Mon 2025-02-24 23:08:05 UTC; 566ms ago
23:08:12 [2025-02-24T23:08:12.260Z] Duration: 2min 1.637s
23:08:12 [2025-02-24T23:08:12.261Z] Invocation: c8c221badd0444c3bb4e22c525a9f014
23:08:12 [2025-02-24T23:08:12.261Z] Process: 3839 ExecStart=/usr/local/bin/kola-runext-test.sh (code=exited, status=1/FAILURE)
23:08:12 [2025-02-24T23:08:12.261Z] Main PID: 3839 (code=exited, status=1/FAILURE)
23:08:12 [2025-02-24T23:08:12.261Z] Mem peak: 2.1M
23:08:12 [2025-02-24T23:08:12.261Z] CPU: 914ms
23:08:12 [2025-02-24T23:08:12.261Z]
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:19 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:19 qemu0 kola-runext-test.sh[7344]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:19 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:19 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:20 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:20 qemu0 kola-runext-test.sh[7346]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:20 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:20 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:21 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:21 qemu0 kola-runext-test.sh[7348]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:21 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:21 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:22 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:22 qemu0 kola-runext-test.sh[7350]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:22 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:22 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:23 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:23 qemu0 kola-runext-test.sh[7353]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:23 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:23 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:24 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:24 qemu0 kola-runext-test.sh[7358]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:24 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:24 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:25 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:25 qemu0 kola-runext-test.sh[7360]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:25 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:25 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:26 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:26 qemu0 kola-runext-test.sh[7362]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:26 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:26 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:27 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:27 qemu0 kola-runext-test.sh[7364]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:27 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:27 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:28 qemu0 kola-runext-test.sh[3839]: + for _x in $(seq "${timeout}")
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:28 qemu0 kola-runext-test.sh[7366]: ++ systemctl is-active kdump.service
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:28 qemu0 kola-runext-test.sh[3839]: + '[' activating '!=' activating ']'
23:08:12 [2025-02-24T23:08:12.261Z] Feb 24 23:06:28 qemu0 kola-runext-test.sh[3839]: + sleep 1
23:08:12 [2025-02-24T23:08:12.261Z] --- [31mFAIL[0m: ext.config.kdump.crash (164.37s)
23:08:12 [2025-02-24T23:08:12.261Z] cluster.go:151: Error: Unit kola-runext.service exited with code 1
23:08:12 [2025-02-24T23:08:12.261Z] cluster.go:151: 2025-02-24T23:08:06Z cli: Unit kola-runext.service exited with code 1
23:08:12 [2025-02-24T23:08:12.261Z] harness.go:1265: kolet failed: : kolet run-test-unit failed: Process exited with status 1
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/Useradd
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/MachineID
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/FCOSGrowpart
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/PortSSH
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/DbusPerms
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/ServicesActive
23:08:50 [2025-02-24T23:08:50.878Z] === RUN basic.uefi/ReadOnly
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi (38.81s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/Useradd (0.21s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/MachineID (0.11s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/FCOSGrowpart (0.15s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/PortSSH (0.12s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/DbusPerms (0.39s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/ServicesActive (0.14s)
23:08:50 [2025-02-24T23:08:50.878Z] --- [32mPASS[0m: basic.uefi/ReadOnly (0.12s)
23:09:03 [2025-02-24T23:09:03.032Z] --- [31mFAIL[0m: multipath.day2 (462.89s)
23:09:03 [2025-02-24T23:09:03.032Z] harness.go:1740: Found kernel oops on machine b31519a2-8a94-47cc-b56d-075f328539d7 console
23:09:29 [2025-02-24T23:09:29.503Z] --- [32mPASS[0m: coreos.ignition.symlink (24.01s)
23:09:51 [2025-02-24T23:09:51.355Z] --- [32mPASS[0m: coreos.ignition.groups (24.46s)
23:10:30 [2025-02-24T23:10:30.207Z] --- [32mPASS[0m: ext.config.ssh.custom-host-key-permissions (38.51s)
23:10:52 [2025-02-24T23:10:52.050Z] === RUN podman.base/info
23:10:52 [2025-02-24T23:10:52.050Z] === RUN podman.base/resources
23:11:00 [2025-02-24T23:11:00.102Z] --- [32mPASS[0m: podman.base (28.95s)
23:11:00 [2025-02-24T23:11:00.102Z] --- [32mPASS[0m: podman.base/info (0.42s)
23:11:00 [2025-02-24T23:11:00.102Z] --- [32mPASS[0m: podman.base/resources (4.58s)
23:11:26 [2025-02-24T23:11:26.556Z] --- [32mPASS[0m: fcos.network.listeners (24.08s)
23:12:05 [2025-02-24T23:12:05.164Z] --- [32mPASS[0m: ext.config.networking.nameserver (40.84s)
23:12:05 [2025-02-24T23:12:05.720Z] --- [31mFAIL[0m: rhcos.selinux.boolean.persist (444.86s)
23:12:05 [2025-02-24T23:12:05.720Z] harness.go:1740: Found kernel oops on machine c0a896a3-5f92-4b4f-9d39-cb0d76352844 console
23:12:52 [2025-02-24T23:12:52.295Z] --- [32mPASS[0m: ext.config.docker.basic (47.55s)
23:13:30 [2025-02-24T23:13:30.919Z] --- [32mPASS[0m: ext.config.boot.bootupd-validate (37.19s)
23:14:02 [2025-02-24T23:14:02.903Z] === RUN rpmostree.install-uninstall/install
23:14:49 [2025-02-24T23:14:49.473Z] --- [31mFAIL[0m: ext.config.networking.nmstate.state (444.20s)
23:14:49 [2025-02-24T23:14:49.473Z] harness.go:1740: Found kernel oops on machine 5d7fc400-15e8-4f11-b452-921d2ffa16a0 console
23:15:28 [2025-02-24T23:15:28.081Z] --- [32mPASS[0m: ext.config.containers.quadlet (38.43s)
23:16:00 [2025-02-24T23:16:00.052Z] === RUN basic.nvme/ReadOnly
23:16:00 [2025-02-24T23:16:00.052Z] === RUN basic.nvme/Useradd
23:16:00 [2025-02-24T23:16:00.052Z] === RUN basic.nvme/MachineID
23:16:00 [2025-02-24T23:16:00.052Z] === RUN basic.nvme/FCOSGrowpart
23:16:00 [2025-02-24T23:16:00.052Z] === RUN basic.nvme/PortSSH
23:16:00 [2025-02-24T23:16:00.052Z] === RUN basic.nvme/DbusPerms
23:16:00 [2025-02-24T23:16:00.314Z] === RUN basic.nvme/ServicesActive
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme (37.90s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/ReadOnly (0.12s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/Useradd (0.22s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/MachineID (0.13s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/FCOSGrowpart (0.15s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/PortSSH (0.12s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/DbusPerms (0.35s)
23:16:04 [2025-02-24T23:16:04.467Z] --- [32mPASS[0m: basic.nvme/ServicesActive (0.13s)
23:16:26 [2025-02-24T23:16:26.307Z] --- [31mFAIL[0m: ext.config.butane.grub-users (453.86s)
23:16:26 [2025-02-24T23:16:26.307Z] harness.go:1740: Found kernel oops on machine 7e78244d-b38b-41ea-9e7b-2d7f5fe53b23 console
23:16:52 [2025-02-24T23:16:52.756Z] --- [32mPASS[0m: ext.config.swap.zram-generator (25.76s)
23:21:29 [2025-02-24T23:21:29.164Z] === RUN rpmostree.install-uninstall/uninstall
23:23:35 [2025-02-24T23:23:35.504Z] --- [31mFAIL[0m: coreos.misc.disk.varlibcontainers (446.57s)
23:23:35 [2025-02-24T23:23:35.504Z] cluster.go:151: Created symlink '/etc/systemd/system/var-lib-containers.mount.wants/systemd-mkfs@dev-disk-by-id-virtio-disk1.service' ��� '/etc/systemd/system/systemd-mkfs@dev-disk-by-id-virtio-disk1.service'.
23:23:35 [2025-02-24T23:23:35.504Z] cluster.go:151: Created symlink '/etc/systemd/system/local-fs.target.wants/var-lib-containers.mount' ��� '/etc/systemd/system/var-lib-containers.mount'.
23:23:35 [2025-02-24T23:23:35.504Z] harness.go:1740: Found kernel oops on machine 92976e90-eaaf-47e7-a998-71de8c647c46 console
23:27:11 [2025-02-24T23:27:11.917Z] 2025-02-24T23:27:10Z kola: Test timed out. Adding as candidate for rerun success: ext.config.ntp.timesyncd.dhcp-propagation
23:27:11 [2025-02-24T23:27:11.917Z] --- [31mFAIL[0m: ext.config.ntp.timesyncd.dhcp-propagation (905.07s)
23:27:11 [2025-02-24T23:27:11.917Z] harness.go:106: TIMEOUT[15m0s]: ssh: sudo /usr/local/bin/kolet run-test-unit kola-runext.service
23:27:11 [2025-02-24T23:27:11.917Z] harness.go:106: TIMEOUT[15m0s]: ssh: journalctl -t kola-runext-test.sh
23:27:11 [2025-02-24T23:27:11.917Z] harness.go:1740: Found kernel oops on machine 915c2db8-b0ce-4c5b-8d05-27c45c0cc169 console
23:27:11 [2025-02-24T23:27:11.918Z] harness.go:1740: Found kernel soft lockup on machine 915c2db8-b0ce-4c5b-8d05-27c45c0cc169 console
23:28:33 [2025-02-24T23:28:33.244Z] --- [31mFAIL[0m: rpmostree.install-uninstall (899.80s)
23:28:33 [2025-02-24T23:28:33.244Z] --- [32mPASS[0m: rpmostree.install-uninstall/install (435.70s)
23:28:33 [2025-02-24T23:28:33.244Z] --- [32mPASS[0m: rpmostree.install-uninstall/uninstall (427.92s)
23:28:33 [2025-02-24T23:28:33.244Z] harness.go:1740: Found kernel oops on machine db80d3d7-e51e-4824-beea-e6d252c8afbb console
00:18:02 [2025-02-25T00:18:02.772Z] Sending interrupt signal to process
00:18:02 [2025-02-25T00:18:02.772Z] Killing processes
00:18:03 [2025-02-25T00:18:03.071Z] kill finished with exit code 0
00:18:10 [2025-02-25T00:18:10.840Z] qemu-system-x86_64: terminating on signal 15 from pid 14576 ()
00:18:10 [2025-02-25T00:18:10.840Z] qemu-system-x86_64: tpm-emulator: Could not cleanly shutdown the TPM: Invalid argument
00:18:10 [2025-02-25T00:18:10.845Z] script returned exit code 143