Status
Console Output
00:34:35 [2025-03-13T00:34:35.623Z] + set -xeuo pipefail
00:34:35 [2025-03-13T00:34:35.623Z] ++ umask
00:34:35 [2025-03-13T00:34:35.623Z] + '[' 0022 = 0000 ']'
00:34:35 [2025-03-13T00:34:35.623Z] + cd /home/jenkins/agent/workspace/test-override
00:34:35 [2025-03-13T00:34:35.623Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-kPfzB/kola-x86_64 --on-warn-failure-exit-77 --arch=x86_64 '--tag=!reprovision' --parallel=5
00:34:35 [2025-03-13T00:34:35.623Z] 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-kPfzB/kola-x86_64
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   fcos.filesystem
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.nameserver
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   rpmostree.install-uninstall
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ignition.systemd-disable
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.groups
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.misc.disk.varlibcontainers
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.symlink
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.docker.basic
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.instantiated.enable-unit
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.var-mount.simple
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.nmstate.policy
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.mtu-on-bond-kargs
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.containers.quadlet
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ostree.unlock
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ostree.remote
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ntp.chrony.dhcp-propagation
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   basic
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.selinux.enforcing
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.unique.boot.failure
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.failure
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.hostname.fallback-hostname
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.unique.boot.ignition.failure
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.rd-net-timeout-carrier
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.ifname-karg.everyboot-systemd-link-file
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.reboot
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ignition.remote
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ostree.hotfix
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.auth.verify
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.swap.zram-generator
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ignition.systemd-unmasking
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.team-dhcp-via-ignition
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   multipath.day2
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.butane.grub-users
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.force-persist-ip
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ignition.kargs
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.extensions.package
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   rpmostree.upgrade-rollback
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   basic.uefi-secure
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.ifname-karg.udev-rule-firstboot-propagation
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.clhm.ignition-warnings
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ignition.systemd-enable-units
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.mount.partitions
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   podman.base
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.disks.lvmdevices
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.ntp.timesyncd.dhcp-propagation
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.selinux.boolean
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.rpm-ostree-countme
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.v2.users
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   coreos.ignition.mount.disks
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.var-mount.luks
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.no-persist-ip
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.kdump.crash
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.networking.nmstate.state
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   fcos.network.listeners
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   multipath.partition
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   non-exclusive-test-bucket-0
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   ext.config.toolbox
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   fcos.users.shells
00:34:35 [2025-03-13T00:34:35.876Z] === RUN   basic.uefi
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   rootfs.uuid
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   coreos.ignition.once
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.boot.bootupd-validate
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   rhcos.selinux.boolean.persist
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.networking.prefer-ignition-networking
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   multipath.day1
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.var-mount.scsi-id
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.systemd.condition-needs-update
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   rpmostree.status
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.networking.mtu-on-bond-ignition
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   kdump.crash.ssh
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.podman.rootless-systemd
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.ignition.resource.remote
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.firewall.iptables-legacy
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.networking.bridge-static-via-kargs
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.ssh.custom-host-key-permissions
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.ignition.stable-boot
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   coreos.ignition.sethostname
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   podman.network-single
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.networking.no-default-initramfs-net-propagation.bootif
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.boot.grub2-install
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   podman.workflow
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.systemd.network-online
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.ignition.delete-config
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   basic.nvme
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.networking.kargs-rd-net
00:34:35 [2025-03-13T00:34:35.877Z] === RUN   ext.config.gshadow
00:35:14 [2025-03-13T00:35:14.497Z] === RUN   fcos.filesystem/writablefiles
00:35:14 [2025-03-13T00:35:14.497Z] === RUN   fcos.filesystem/writabledirs
00:35:14 [2025-03-13T00:35:14.497Z] === RUN   fcos.filesystem/stickydirs
00:35:14 [2025-03-13T00:35:14.497Z] === RUN   fcos.filesystem/denylist
00:35:14 [2025-03-13T00:35:14.497Z] --- [32mPASS[0m: fcos.filesystem (38.52s)
00:35:14 [2025-03-13T00:35:14.497Z]     --- [32mPASS[0m: fcos.filesystem/writablefiles (1.00s)
00:35:14 [2025-03-13T00:35:14.497Z]     --- [32mPASS[0m: fcos.filesystem/writabledirs (0.27s)
00:35:14 [2025-03-13T00:35:14.497Z]     --- [32mPASS[0m: fcos.filesystem/stickydirs (0.31s)
00:35:14 [2025-03-13T00:35:14.497Z]     --- [32mPASS[0m: fcos.filesystem/denylist (0.37s)
00:35:15 [2025-03-13T00:35:15.056Z] --- [32mPASS[0m: ext.config.firewall.iptables-legacy (39.12s)
00:35:53 [2025-03-13T00:35:53.751Z] --- [32mPASS[0m: ext.config.ntp.timesyncd.dhcp-propagation (74.22s)
00:36:15 [2025-03-13T00:36:15.613Z] --- [32mPASS[0m: ext.config.disks.lvmdevices (57.65s)
00:36:15 [2025-03-13T00:36:15.613Z] --- [32mPASS[0m: ext.config.networking.rd-net-timeout-carrier (58.53s)
00:36:18 [2025-03-13T00:36:18.865Z] --- [32mPASS[0m: ext.config.systemd.condition-needs-update (102.44s)
00:36:23 [2025-03-13T00:36:23.017Z] === RUN   podman.base/info
00:36:23 [2025-03-13T00:36:23.272Z] === RUN   podman.base/resources
00:36:31 [2025-03-13T00:36:31.336Z] --- [32mPASS[0m: podman.base (40.87s)
00:36:31 [2025-03-13T00:36:31.336Z]     --- [32mPASS[0m: podman.base/info (0.43s)
00:36:31 [2025-03-13T00:36:31.336Z]     --- [32mPASS[0m: podman.base/resources (4.42s)
00:36:41 [2025-03-13T00:36:41.285Z] --- [32mPASS[0m: ext.config.ignition.systemd-enable-units (27.14s)
00:36:59 [2025-03-13T00:36:59.318Z] --- [32mPASS[0m: ext.config.clhm.ignition-warnings (39.07s)
00:37:09 [2025-03-13T00:37:09.238Z] --- [32mPASS[0m: coreos.ignition.mount.partitions (54.94s)
00:37:14 [2025-03-13T00:37:14.474Z] === RUN   basic.uefi-secure/FCOSGrowpart
00:37:14 [2025-03-13T00:37:14.475Z] === RUN   basic.uefi-secure/PortSSH
00:37:14 [2025-03-13T00:37:14.728Z] === RUN   basic.uefi-secure/DbusPerms
00:37:14 [2025-03-13T00:37:14.982Z] === RUN   basic.uefi-secure/ServicesActive
00:37:15 [2025-03-13T00:37:15.248Z] === RUN   basic.uefi-secure/ReadOnly
00:37:15 [2025-03-13T00:37:15.248Z] === RUN   basic.uefi-secure/Useradd
00:37:15 [2025-03-13T00:37:15.503Z] === RUN   basic.uefi-secure/MachineID
00:37:18 [2025-03-13T00:37:18.756Z] === RUN   rpmostree.upgrade-rollback/upgrade
00:37:19 [2025-03-13T00:37:19.020Z] --- [32mPASS[0m: basic.uefi-secure (38.79s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/FCOSGrowpart (0.15s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/PortSSH (0.13s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/DbusPerms (0.36s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/ServicesActive (0.13s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/ReadOnly (0.12s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/Useradd (0.20s)
00:37:19 [2025-03-13T00:37:19.021Z]     --- [32mPASS[0m: basic.uefi-secure/MachineID (0.13s)
00:37:33 [2025-03-13T00:37:33.840Z] --- [32mPASS[0m: ext.config.networking.ifname-karg.udev-rule-firstboot-propagation (60.95s)
00:37:33 [2025-03-13T00:37:33.840Z] --- [32mPASS[0m: podman.network-single (176.42s)
00:37:48 [2025-03-13T00:37:48.655Z] systemctl status kola-runext.service:
00:37:48 [2025-03-13T00:37:48.655Z] �� kola-runext.service
00:37:48 [2025-03-13T00:37:48.655Z]      Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
00:37:48 [2025-03-13T00:37:48.655Z]     Drop-In: /usr/lib/systemd/system/service.d
00:37:48 [2025-03-13T00:37:48.655Z]              ������10-timeout-abort.conf, 50-keep-warm.conf
00:37:48 [2025-03-13T00:37:48.655Z]      Active: failed (Result: exit-code) since Thu 2025-03-13 00:37:46 UTC; 229ms ago
00:37:48 [2025-03-13T00:37:48.655Z]    Duration: 3.970s
00:37:48 [2025-03-13T00:37:48.655Z]  Invocation: a47b4843447d4b2f9539a55141fdafcc
00:37:48 [2025-03-13T00:37:48.655Z]     Process: 2235 ExecStart=/usr/local/bin/kola-runext-package (code=exited, status=1/FAILURE)
00:37:48 [2025-03-13T00:37:48.655Z]    Main PID: 2235 (code=exited, status=1/FAILURE)
00:37:48 [2025-03-13T00:37:48.655Z]    Mem peak: 6.2M
00:37:48 [2025-03-13T00:37:48.655Z]         CPU: 96ms
00:37:48 [2025-03-13T00:37:48.655Z] 
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 systemd[1]: Started kola-runext.service.
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2235]: + . /var/opt/kola/extdata/commonlib.sh
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2235]: ++ IFS=' '
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2235]: ++ read -r -a cmdline
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2235]: + commands=('htop' 'strace' 'tcpdump' 'tree' 'crio')
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2235]: + case "$(get_fcos_stream)" in
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2236]: ++ get_fcos_stream
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2237]: ++ rpm-ostree status -b --json
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2238]: ++ jq -r '.deployments[0]["base-commit-meta"]["fedora-coreos.stream"]'
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2235]: + rpm-ostree install --apply-live htop strace tcpdump tree crio
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:42 qemu0 kola-runext-package[2245]: notice: auto-inferring -y/--assumeyes when not run interactively; this will change in the future
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:46 qemu0 kola-runext-package[2245]: Checking out tree c5a864c...done
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:46 qemu0 kola-runext-package[2245]: Enabled rpm-md repositories: fedora-cisco-openh264 rawhide
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:46 qemu0 kola-runext-package[2245]: Updating metadata for 'fedora-cisco-openh264'...done
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:46 qemu0 kola-runext-package[2245]: error: Updating rpm-md repo 'fedora-cisco-openh264': cannot update repo 'fedora-cisco-openh264': Cannot download repomd.xml: Cannot download repodata/repomd.xml: All mirrors were tried; Last error: Status code: 404 for https://codecs.fedoraproject.org/openh264/43/x86_64/os/repodata/repomd.xml (IP: 10.3.163.76)
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:46 qemu0 systemd[1]: kola-runext.service: Main process exited, code=exited, status=1/FAILURE
00:37:48 [2025-03-13T00:37:48.655Z] Mar 13 00:37:46 qemu0 systemd[1]: kola-runext.service: Failed with result 'exit-code'.
00:37:50 [2025-03-13T00:37:50.543Z] --- [31mFAIL[0m: ext.config.extensions.package (42.51s)
00:37:50 [2025-03-13T00:37:50.543Z]         cluster.go:151: Error: Unit kola-runext.service exited with code 1
00:37:50 [2025-03-13T00:37:50.543Z]         cluster.go:151: 2025-03-13T00:37:46Z cli: Unit kola-runext.service exited with code 1
00:37:50 [2025-03-13T00:37:50.543Z]         harness.go:1265: kolet failed: : kolet run-test-unit failed: Process exited with status 1
00:37:57 [2025-03-13T00:37:57.069Z] === RUN   rpmostree.upgrade-rollback/rollback
00:37:58 [2025-03-13T00:37:58.425Z] --- [32mPASS[0m: ext.config.ignition.kargs (39.27s)
00:38:01 [2025-03-13T00:38:01.676Z] --- [32mPASS[0m: ext.config.networking.force-persist-ip (29.37s)
00:38:23 [2025-03-13T00:38:23.531Z] --- [32mPASS[0m: rpmostree.upgrade-rollback (84.63s)
00:38:23 [2025-03-13T00:38:23.531Z]     --- [32mPASS[0m: rpmostree.upgrade-rollback/upgrade (37.83s)
00:38:23 [2025-03-13T00:38:23.531Z]     --- [32mPASS[0m: rpmostree.upgrade-rollback/rollback (22.21s)
00:38:28 [2025-03-13T00:38:28.769Z] --- [32mPASS[0m: ext.config.networking.team-dhcp-via-ignition (29.88s)
00:38:28 [2025-03-13T00:38:28.769Z] --- [32mPASS[0m: ext.config.ignition.systemd-unmasking (26.74s)
00:38:35 [2025-03-13T00:38:35.468Z] --- [32mPASS[0m: ext.config.butane.grub-users (62.85s)
00:39:01 [2025-03-13T00:39:01.945Z] --- [32mPASS[0m: ext.config.swap.zram-generator (38.68s)
00:39:03 [2025-03-13T00:39:03.824Z] --- [32mPASS[0m: multipath.day2 (73.36s)
00:39:05 [2025-03-13T00:39:05.182Z] --- [32mPASS[0m: coreos.auth.verify (36.83s)
00:39:07 [2025-03-13T00:39:07.684Z] --- [32mPASS[0m: ext.config.ignition.stable-boot (39.29s)
00:39:09 [2025-03-13T00:39:09.561Z] --- [32mPASS[0m: coreos.ignition.sethostname (34.38s)
00:39:24 [2025-03-13T00:39:24.652Z] --- [32mPASS[0m: coreos.unique.boot.ignition.failure (14.73s)
00:39:32 [2025-03-13T00:39:32.717Z] === RUN   ostree.hotfix/unlock
00:39:44 [2025-03-13T00:39:44.865Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-kargs (41.23s)
00:39:46 [2025-03-13T00:39:46.223Z] === RUN   ostree.hotfix/install
00:39:46 [2025-03-13T00:39:46.781Z] === RUN   ostree.hotfix/uninstall
00:39:47 [2025-03-13T00:39:47.337Z] === RUN   ostree.hotfix/persist
00:39:53 [2025-03-13T00:39:53.855Z] --- [32mPASS[0m: ext.config.ignition.remote (48.33s)
00:39:54 [2025-03-13T00:39:54.109Z] --- [32mPASS[0m: ext.config.reboot (44.60s)
00:39:54 [2025-03-13T00:39:54.109Z] mke2fs 1.47.1 (20-May-2024)
00:40:02 [2025-03-13T00:40:02.066Z] --- [32mPASS[0m: ext.config.networking.hostname.fallback-hostname (39.29s)
00:40:06 [2025-03-13T00:40:06.230Z] === RUN   ostree.hotfix/rollback
00:40:08 [2025-03-13T00:40:08.107Z] --- [32mPASS[0m: coreos.unique.boot.failure (13.91s)
00:40:09 [2025-03-13T00:40:09.988Z] --- [32mPASS[0m: coreos.ignition.failure (16.41s)
00:40:31 [2025-03-13T00:40:31.852Z] --- [32mPASS[0m: ext.config.ssh.custom-host-key-permissions (26.95s)
00:40:31 [2025-03-13T00:40:31.852Z] --- [32mPASS[0m: ostree.hotfix (88.74s)
00:40:31 [2025-03-13T00:40:31.852Z]     --- [32mPASS[0m: ostree.hotfix/unlock (14.20s)
00:40:31 [2025-03-13T00:40:31.852Z]     --- [32mPASS[0m: ostree.hotfix/install (0.55s)
00:40:31 [2025-03-13T00:40:31.852Z]     --- [32mPASS[0m: ostree.hotfix/uninstall (0.43s)
00:40:31 [2025-03-13T00:40:31.852Z]     --- [32mPASS[0m: ostree.hotfix/persist (18.71s)
00:40:31 [2025-03-13T00:40:31.852Z]     --- [32mPASS[0m: ostree.hotfix/rollback (19.65s)
00:40:32 [2025-03-13T00:40:32.410Z] --- [32mPASS[0m: coreos.ignition.symlink (24.19s)
00:40:47 [2025-03-13T00:40:47.232Z] --- [32mPASS[0m: ext.config.networking.ifname-karg.everyboot-systemd-link-file (61.29s)
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/ServicesActive
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/ReadOnly
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/Useradd
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/MachineID
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/FCOSGrowpart
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/PortSSH
00:41:02 [2025-03-13T00:41:02.049Z] === RUN   basic/DbusPerms
00:41:03 [2025-03-13T00:41:03.926Z] --- [32mPASS[0m: ext.config.selinux.enforcing (54.10s)
00:41:05 [2025-03-13T00:41:05.803Z] --- [32mPASS[0m: basic (35.92s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/ServicesActive (0.12s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/ReadOnly (0.12s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/Useradd (0.20s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/MachineID (0.11s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/FCOSGrowpart (0.14s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/PortSSH (0.12s)
00:41:05 [2025-03-13T00:41:05.803Z]     --- [32mPASS[0m: basic/DbusPerms (0.35s)
00:41:45 [2025-03-13T00:41:45.487Z] --- [32mPASS[0m: ext.config.var-mount.simple (56.85s)
00:41:45 [2025-03-13T00:41:45.487Z] --- [32mPASS[0m: ext.config.ignition.resource.remote (38.16s)
00:42:07 [2025-03-13T00:42:07.360Z] === RUN   ostree.remote/add
00:42:07 [2025-03-13T00:42:07.360Z] === RUN   ostree.remote/list
00:42:07 [2025-03-13T00:42:07.360Z] === RUN   ostree.remote/show-url
00:42:07 [2025-03-13T00:42:07.360Z] === RUN   ostree.remote/refs
00:42:07 [2025-03-13T00:42:07.360Z] === RUN   ostree.remote/summary
00:42:07 [2025-03-13T00:42:07.360Z] === RUN   ostree.remote/delete
00:42:08 [2025-03-13T00:42:08.715Z] --- [32mPASS[0m: ostree.remote (25.75s)
00:42:08 [2025-03-13T00:42:08.715Z]     --- [32mPASS[0m: ostree.remote/add (0.24s)
00:42:08 [2025-03-13T00:42:08.715Z]     --- [32mPASS[0m: ostree.remote/list (0.11s)
00:42:08 [2025-03-13T00:42:08.715Z]     --- [32mPASS[0m: ostree.remote/show-url (0.23s)
00:42:08 [2025-03-13T00:42:08.715Z]     --- [32mPASS[0m: ostree.remote/refs (0.14s)
00:42:08 [2025-03-13T00:42:08.715Z]     --- [32mPASS[0m: ostree.remote/summary (0.28s)
00:42:08 [2025-03-13T00:42:08.715Z]     --- [32mPASS[0m: ostree.remote/delete (0.46s)
00:42:08 [2025-03-13T00:42:08.968Z] --- [32mPASS[0m: coreos.ignition.instantiated.enable-unit (25.35s)
00:42:18 [2025-03-13T00:42:18.879Z] --- [32mPASS[0m: ext.config.ntp.chrony.dhcp-propagation (74.09s)
00:42:26 [2025-03-13T00:42:26.949Z] --- [32mPASS[0m: kdump.crash.ssh (113.96s)
00:42:26 [2025-03-13T00:42:26.949Z]         cluster.go:151: Running as unit: run-p7204-i7205.service; invocation ID: 042b4c5972c64196830250ffd1842be9
00:42:28 [2025-03-13T00:42:28.824Z] --- [32mPASS[0m: ext.config.networking.nmstate.policy (120.53s)
00:42:43 [2025-03-13T00:42:43.629Z] === RUN   ostree.unlock/unlock
00:42:43 [2025-03-13T00:42:43.629Z] === RUN   ostree.unlock/install
00:42:43 [2025-03-13T00:42:43.629Z] === RUN   ostree.unlock/uninstall
00:42:43 [2025-03-13T00:42:43.629Z] === RUN   ostree.unlock/discard
00:43:05 [2025-03-13T00:43:05.491Z] --- [32mPASS[0m: ext.config.docker.basic (44.78s)
00:43:05 [2025-03-13T00:43:05.491Z] --- [32mPASS[0m: ext.config.ignition.systemd-disable (38.60s)
00:43:05 [2025-03-13T00:43:05.491Z] --- [32mPASS[0m: ostree.unlock (56.40s)
00:43:05 [2025-03-13T00:43:05.491Z]     --- [32mPASS[0m: ostree.unlock/unlock (0.65s)
00:43:05 [2025-03-13T00:43:05.491Z]     --- [32mPASS[0m: ostree.unlock/install (0.68s)
00:43:05 [2025-03-13T00:43:05.491Z]     --- [32mPASS[0m: ostree.unlock/uninstall (0.48s)
00:43:05 [2025-03-13T00:43:05.491Z]     --- [32mPASS[0m: ostree.unlock/discard (18.67s)
00:43:07 [2025-03-13T00:43:07.368Z] --- [32mPASS[0m: ext.config.podman.rootless-systemd (58.55s)
00:43:07 [2025-03-13T00:43:07.627Z] --- [32mPASS[0m: ext.config.containers.quadlet (38.71s)
00:43:39 [2025-03-13T00:43:39.610Z] --- [32mPASS[0m: ext.config.networking.bridge-static-via-kargs (29.50s)
00:43:47 [2025-03-13T00:43:47.681Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-ignition (41.50s)
00:43:51 [2025-03-13T00:43:51.834Z] --- [32mPASS[0m: ext.config.var-mount.scsi-id (43.58s)
00:43:57 [2025-03-13T00:43:57.060Z] === RUN   non-exclusive-test-bucket-0/ext.config.ignition.journald-log
00:43:58 [2025-03-13T00:43:58.417Z] === RUN   non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2
00:43:59 [2025-03-13T00:43:59.773Z] --- [32mPASS[0m: coreos.misc.disk.varlibcontainers (56.93s)
00:43:59 [2025-03-13T00:43:59.773Z]         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'.
00:43:59 [2025-03-13T00:43:59.773Z]         cluster.go:151: Created symlink '/etc/systemd/system/local-fs.target.wants/var-lib-containers.mount' ��� '/etc/systemd/system/var-lib-containers.mount'.
00:43:59 [2025-03-13T00:43:59.783Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.no-google-device-links
00:44:00 [2025-03-13T00:44:00.341Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.console-config
00:44:02 [2025-03-13T00:44:02.221Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.network-online-service
00:44:03 [2025-03-13T00:44:03.578Z] === RUN   non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust
00:44:05 [2025-03-13T00:44:05.463Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.fwupd-refresh-timer
00:44:06 [2025-03-13T00:44:06.821Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.license
00:44:07 [2025-03-13T00:44:07.743Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.check-symlink
00:44:09 [2025-03-13T00:44:09.101Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match
00:44:13 [2025-03-13T00:44:13.271Z] === RUN   non-exclusive-test-bucket-0/ext.config.clhm.network-device-info
00:44:13 [2025-03-13T00:44:13.525Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.growfs
00:44:14 [2025-03-13T00:44:14.081Z] --- [32mPASS[0m: rpmostree.status (36.82s)
00:44:14 [2025-03-13T00:44:14.081Z] === RUN   non-exclusive-test-bucket-0/ext.config.boot.bootupd
00:44:15 [2025-03-13T00:44:15.959Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nm-start
00:44:17 [2025-03-13T00:44:17.317Z] === RUN   non-exclusive-test-bucket-0/ext.config.logging.printk
00:44:17 [2025-03-13T00:44:17.874Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.initrd.compression
00:44:19 [2025-03-13T00:44:19.755Z] === RUN   non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot
00:44:21 [2025-03-13T00:44:21.635Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.tls
00:44:25 [2025-03-13T00:44:25.789Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.unmodified-policy
00:44:27 [2025-03-13T00:44:27.668Z] --- [32mPASS[0m: coreos.ignition.groups (36.44s)
00:44:27 [2025-03-13T00:44:27.668Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nm-dhcp-client
00:44:29 [2025-03-13T00:44:29.545Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.root-prjquota
00:44:30 [2025-03-13T00:44:30.901Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.aleph-version
00:44:31 [2025-03-13T00:44:31.458Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.file-directory-permissions
00:44:33 [2025-03-13T00:44:33.339Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.validate-symlinks
00:44:41 [2025-03-13T00:44:41.460Z] --- [32mPASS[0m: ext.config.networking.no-persist-ip (41.06s)
00:44:42 [2025-03-13T00:44:42.816Z] --- [32mPASS[0m: multipath.day1 (56.27s)
00:44:46 [2025-03-13T00:44:46.070Z] === RUN   non-exclusive-test-bucket-0/ext.config.firewall.iptables
00:44:47 [2025-03-13T00:44:47.962Z] === RUN   non-exclusive-test-bucket-0/ext.config.podman.dns
00:44:54 [2025-03-13T00:44:54.481Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.fcos_users
00:44:56 [2025-03-13T00:44:56.361Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.fcos_groups
00:44:57 [2025-03-13T00:44:57.715Z] === RUN   non-exclusive-test-bucket-0/ext.config.kubernetes.systemd-env-read
00:44:59 [2025-03-13T00:44:59.593Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context
00:45:00 [2025-03-13T00:45:00.951Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin
00:45:02 [2025-03-13T00:45:02.828Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.kernel-headers
00:45:03 [2025-03-13T00:45:03.082Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service
00:45:04 [2025-03-13T00:45:04.960Z] === RUN   non-exclusive-test-bucket-0/ext.config.ntp.chrony.coreos-platform-chrony-config
00:45:06 [2025-03-13T00:45:06.318Z] === RUN   non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts
00:45:07 [2025-03-13T00:45:07.675Z] --- [32mPASS[0m: ext.config.gshadow (26.81s)
00:45:08 [2025-03-13T00:45:08.232Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change
00:45:08 [2025-03-13T00:45:08.789Z] --- [32mPASS[0m: ext.config.networking.prefer-ignition-networking (41.32s)
00:45:09 [2025-03-13T00:45:09.710Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.systemd-repart-service
00:45:11 [2025-03-13T00:45:11.598Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite
00:45:12 [2025-03-13T00:45:12.518Z] --- [32mPASS[0m: ext.config.networking.kargs-rd-net (29.46s)
00:45:13 [2025-03-13T00:45:13.074Z] === RUN   non-exclusive-test-bucket-0/ext.config.content-origins
00:45:14 [2025-03-13T00:45:14.962Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.sudoers
00:45:15 [2025-03-13T00:45:15.520Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.podman-tmpfs-context
00:45:22 [2025-03-13T00:45:22.035Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.nic-naming
00:45:22 [2025-03-13T00:45:22.593Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.tmpfs
00:45:24 [2025-03-13T00:45:24.471Z] === RUN   non-exclusive-test-bucket-0/ext.config.kdump.service
00:45:26 [2025-03-13T00:45:26.346Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.root-bash
00:45:26 [2025-03-13T00:45:26.599Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.etc-permissions
00:45:28 [2025-03-13T00:45:28.490Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.initrd.executables
00:45:28 [2025-03-13T00:45:28.490Z] === RUN   podman.workflow/run
00:45:32 [2025-03-13T00:45:32.633Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.remove-manifest-files
00:45:32 [2025-03-13T00:45:32.633Z] === RUN   non-exclusive-test-bucket-0/ext.config.security.passwd
00:45:33 [2025-03-13T00:45:33.989Z] === RUN   basic.nvme/ServicesActive
00:45:34 [2025-03-13T00:45:34.242Z] === RUN   basic.nvme/ReadOnly
00:45:34 [2025-03-13T00:45:34.242Z] === RUN   basic.nvme/Useradd
00:45:34 [2025-03-13T00:45:34.242Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents
00:45:34 [2025-03-13T00:45:34.496Z] === RUN   basic.nvme/MachineID
00:45:34 [2025-03-13T00:45:34.496Z] === RUN   basic.nvme/FCOSGrowpart
00:45:34 [2025-03-13T00:45:34.750Z] === RUN   basic.nvme/PortSSH
00:45:34 [2025-03-13T00:45:34.750Z] === RUN   basic.nvme/DbusPerms
00:45:38 [2025-03-13T00:45:38.002Z] === RUN   non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context
00:45:38 [2025-03-13T00:45:38.558Z] --- [32mPASS[0m: basic.nvme (26.18s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/ServicesActive (0.12s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/ReadOnly (0.12s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/Useradd (0.20s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/MachineID (0.12s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/FCOSGrowpart (0.15s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/PortSSH (0.13s)
00:45:38 [2025-03-13T00:45:38.558Z]     --- [32mPASS[0m: basic.nvme/DbusPerms (0.34s)
00:45:38 [2025-03-13T00:45:38.558Z] === RUN   non-exclusive-test-bucket-0/ext.config.composefs.enabled
00:45:40 [2025-03-13T00:45:40.436Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.setgid
00:45:42 [2025-03-13T00:45:42.312Z] === RUN   non-exclusive-test-bucket-0/ext.config.swap.zram-default
00:45:42 [2025-03-13T00:45:42.575Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.partition-scheme
00:45:44 [2025-03-13T00:45:44.450Z] === RUN   non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps
00:45:46 [2025-03-13T00:45:46.329Z] === RUN   non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch
00:45:46 [2025-03-13T00:45:46.329Z] --- [32mPASS[0m: ext.config.ignition.delete-config (92.15s)
00:45:48 [2025-03-13T00:45:48.584Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir
00:45:49 [2025-03-13T00:45:49.140Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.setuid
00:45:51 [2025-03-13T00:45:51.028Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved
00:45:52 [2025-03-13T00:45:52.384Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.amd-ucode-firmware
00:45:53 [2025-03-13T00:45:53.302Z] === RUN   non-exclusive-test-bucket-0/ext.config.disks.root-boot-ro
00:45:54 [2025-03-13T00:45:54.666Z] === RUN   non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking
00:45:56 [2025-03-13T00:45:56.545Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.system-generators
00:45:58 [2025-03-13T00:45:58.423Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit
00:45:58 [2025-03-13T00:45:58.677Z] === RUN   non-exclusive-test-bucket-0/ext.config.files.logrotate-service
00:46:00 [2025-03-13T00:46:00.556Z] === RUN   non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default
00:46:03 [2025-03-13T00:46:03.821Z] --- [32mPASS[0m: multipath.partition (54.84s)
00:46:05 [2025-03-13T00:46:05.178Z] --- [32mPASS[0m: ext.config.systemd.network-online (26.74s)
00:46:05 [2025-03-13T00:46:05.736Z] --- [32mPASS[0m: non-exclusive-test-bucket-0 (180.76s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.ignition.journald-log (1.66s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2 (1.64s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.no-google-device-links (0.64s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.console-config (1.61s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.network-online-service (1.61s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust (1.61s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.fwupd-refresh-timer (1.64s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.license (0.62s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.check-symlink (1.61s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match (3.65s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.clhm.network-device-info (0.63s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.growfs (0.62s)
00:46:05 [2025-03-13T00:46:05.736Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.boot.bootupd (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nm-start (1.66s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.logging.printk (0.66s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.initrd.compression (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot (1.62s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.tls (4.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.unmodified-policy (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nm-dhcp-client (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.root-prjquota (1.62s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.aleph-version (0.66s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.file-directory-permissions (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.validate-symlinks (12.92s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.firewall.iptables (1.69s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.podman.dns (6.67s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.fcos_users (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.fcos_groups (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.kubernetes.systemd-env-read (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context (1.62s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.kernel-headers (0.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.ntp.chrony.coreos-platform-chrony-config (1.62s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts (1.72s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.systemd-repart-service (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.content-origins (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.sudoers (0.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.podman-tmpfs-context (5.62s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nic-naming (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.tmpfs (1.68s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.kdump.service (1.66s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.root-bash (0.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.etc-permissions (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.initrd.executables (3.69s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.remove-manifest-files (0.69s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.security.passwd (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents (3.67s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context (0.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.composefs.enabled (1.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.setgid (1.75s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.swap.zram-default (0.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.partition-scheme (1.69s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch (2.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir (0.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.setuid (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.amd-ucode-firmware (0.63s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.root-boot-ro (1.64s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking (1.62s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.system-generators (1.65s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit (0.66s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.logrotate-service (1.67s)
00:46:05 [2025-03-13T00:46:05.737Z]     --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default (1.68s)
00:46:10 [2025-03-13T00:46:10.976Z] --- [32mPASS[0m: fcos.network.listeners (24.04s)
00:46:28 [2025-03-13T00:46:28.992Z] === RUN   rootfs.uuid/RandomUUID
00:46:30 [2025-03-13T00:46:30.870Z] --- [32mPASS[0m: rootfs.uuid (24.90s)
00:46:30 [2025-03-13T00:46:30.870Z]     --- [32mPASS[0m: rootfs.uuid/RandomUUID (0.16s)
00:46:32 [2025-03-13T00:46:32.225Z] --- [32mPASS[0m: ext.config.boot.grub2-install (27.10s)
00:46:36 [2025-03-13T00:46:36.372Z] === RUN   rpmostree.install-uninstall/install
00:47:15 [2025-03-13T00:47:15.137Z] --- [32mPASS[0m: coreos.ignition.v2.users (36.65s)
00:47:15 [2025-03-13T00:47:15.137Z] --- [32mPASS[0m: rhcos.selinux.boolean.persist (60.79s)
00:47:16 [2025-03-13T00:47:16.058Z] --- [32mPASS[0m: ext.config.networking.nmstate.state (45.53s)
00:47:25 [2025-03-13T00:47:25.976Z] === RUN   rpmostree.install-uninstall/uninstall
00:47:40 [2025-03-13T00:47:40.800Z] --- [32mPASS[0m: ext.config.networking.no-default-initramfs-net-propagation.bootif (29.31s)
00:47:46 [2025-03-13T00:47:46.027Z] --- [32mPASS[0m: ext.config.networking.nameserver (29.53s)
00:48:12 [2025-03-13T00:48:12.498Z] --- [32mPASS[0m: rpmostree.install-uninstall (124.60s)
00:48:12 [2025-03-13T00:48:12.498Z]     --- [32mPASS[0m: rpmostree.install-uninstall/install (49.59s)
00:48:12 [2025-03-13T00:48:12.498Z]     --- [32mPASS[0m: rpmostree.install-uninstall/uninstall (38.59s)
00:48:19 [2025-03-13T00:48:19.013Z] --- [32mPASS[0m: ext.config.rpm-ostree-countme (38.57s)
00:48:51 [2025-03-13T00:48:51.031Z] --- [32mPASS[0m: ext.config.boot.bootupd-validate (39.60s)
00:48:52 [2025-03-13T00:48:52.910Z] --- [32mPASS[0m: fcos.users.shells (33.80s)
00:49:05 [2025-03-13T00:49:05.058Z] --- [32mPASS[0m: ext.config.kdump.crash (114.23s)
00:49:06 [2025-03-13T00:49:06.416Z] --- [32mPASS[0m: ext.config.var-mount.luks (80.55s)
00:49:32 [2025-03-13T00:49:32.888Z] --- [32mPASS[0m: coreos.ignition.once (42.47s)
00:49:37 [2025-03-13T00:49:37.058Z] --- [32mPASS[0m: coreos.selinux.boolean (44.47s)
00:49:58 [2025-03-13T00:49:58.917Z] --- [32mPASS[0m: coreos.ignition.mount.disks (55.15s)
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/FCOSGrowpart
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/PortSSH
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/DbusPerms
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/ServicesActive
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/ReadOnly
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/Useradd
00:50:05 [2025-03-13T00:50:05.434Z] === RUN   basic.uefi/MachineID
00:50:09 [2025-03-13T00:50:09.594Z] --- [32mPASS[0m: basic.uefi (38.52s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/FCOSGrowpart (0.16s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/PortSSH (0.13s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/DbusPerms (0.34s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/ServicesActive (0.13s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/ReadOnly (0.11s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/Useradd (0.20s)
00:50:09 [2025-03-13T00:50:09.594Z]     --- [32mPASS[0m: basic.uefi/MachineID (0.12s)
00:50:17 [2025-03-13T00:50:17.660Z] --- [32mPASS[0m: ext.config.toolbox (70.89s)
00:50:35 [2025-03-13T00:50:35.688Z] === RUN   podman.workflow/exec
00:50:35 [2025-03-13T00:50:35.942Z] === RUN   podman.workflow/stop
00:50:48 [2025-03-13T00:50:48.104Z] === RUN   podman.workflow/remove
00:50:48 [2025-03-13T00:50:48.104Z] === RUN   podman.workflow/delete
00:50:51 [2025-03-13T00:50:51.357Z] --- [32mPASS[0m: podman.workflow (343.86s)
00:50:51 [2025-03-13T00:50:51.357Z]     --- [32mPASS[0m: podman.workflow/run (307.28s)
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: Getting image source signatures
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: Copying blob sha256:7ef99564a1f419d8fb0b4796571dd34798fbb3c90c4e300954066dfa39301259
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: Copying config sha256:503d859eeaed007eee9dc0af3dac0573be6f5cf32b738d29fd1e9fc3175bb3e6
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: Writing manifest to image destination
00:50:51 [2025-03-13T00:50:51.357Z]     --- [32mPASS[0m: podman.workflow/exec (0.35s)
00:50:51 [2025-03-13T00:50:51.357Z]     --- [32mPASS[0m: podman.workflow/stop (10.65s)
00:50:51 [2025-03-13T00:50:51.357Z]     --- [32mPASS[0m: podman.workflow/remove (0.57s)
00:50:51 [2025-03-13T00:50:51.357Z]     --- [32mPASS[0m: podman.workflow/delete (0.71s)
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: grep: quay.io/fedora/fedora:latest: No such file or directory
00:50:51 [2025-03-13T00:50:51.357Z]             cluster.go:151: bash: line 2: Deleted:: command not found
00:50:51 [2025-03-13T00:50:51.357Z] FAIL, output in /home/jenkins/agent/workspace/test-override/tmp/kola-kPfzB/kola-x86_64
00:50:51 [2025-03-13T00:50:51.357Z] 
00:50:51 [2025-03-13T00:50:51.357Z] 
00:50:51 [2025-03-13T00:50:51.357Z] ======== Re-running failed tests (flake detection) ========
00:50:51 [2025-03-13T00:50:51.357Z] 
00:50:51 [2025-03-13T00:50:51.357Z] === RUN   ext.config.extensions.package
00:51:30 [2025-03-13T00:51:30.442Z] systemctl status kola-runext.service:
00:51:30 [2025-03-13T00:51:30.442Z] �� kola-runext.service
00:51:30 [2025-03-13T00:51:30.442Z]      Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
00:51:30 [2025-03-13T00:51:30.442Z]     Drop-In: /usr/lib/systemd/system/service.d
00:51:30 [2025-03-13T00:51:30.442Z]              ������10-timeout-abort.conf, 50-keep-warm.conf
00:51:30 [2025-03-13T00:51:30.442Z]      Active: failed (Result: exit-code) since Thu 2025-03-13 00:51:29 UTC; 375ms ago
00:51:30 [2025-03-13T00:51:30.442Z]    Duration: 3.800s
00:51:30 [2025-03-13T00:51:30.442Z]  Invocation: cd7a619634764846ad7afb61f0da6fc9
00:51:30 [2025-03-13T00:51:30.442Z]     Process: 2280 ExecStart=/usr/local/bin/kola-runext-package (code=exited, status=1/FAILURE)
00:51:30 [2025-03-13T00:51:30.442Z]    Main PID: 2280 (code=exited, status=1/FAILURE)
00:51:30 [2025-03-13T00:51:30.442Z]    Mem peak: 6.2M
00:51:30 [2025-03-13T00:51:30.442Z]         CPU: 83ms
00:51:30 [2025-03-13T00:51:30.442Z] 
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 systemd[1]: Started kola-runext.service.
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2280]: + . /var/opt/kola/extdata/commonlib.sh
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2280]: ++ IFS=' '
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2280]: ++ read -r -a cmdline
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2280]: + commands=('htop' 'strace' 'tcpdump' 'tree' 'crio')
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2280]: + case "$(get_fcos_stream)" in
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2282]: ++ get_fcos_stream
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2283]: ++ rpm-ostree status -b --json
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2284]: ++ jq -r '.deployments[0]["base-commit-meta"]["fedora-coreos.stream"]'
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2280]: + rpm-ostree install --apply-live htop strace tcpdump tree crio
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:25 qemu0 kola-runext-package[2290]: notice: auto-inferring -y/--assumeyes when not run interactively; this will change in the future
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:29 qemu0 kola-runext-package[2290]: Checking out tree c5a864c...done
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:29 qemu0 kola-runext-package[2290]: Enabled rpm-md repositories: fedora-cisco-openh264 rawhide
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:29 qemu0 kola-runext-package[2290]: Updating metadata for 'fedora-cisco-openh264'...done
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:29 qemu0 kola-runext-package[2290]: error: Updating rpm-md repo 'fedora-cisco-openh264': cannot update repo 'fedora-cisco-openh264': Cannot download repomd.xml: Cannot download repodata/repomd.xml: All mirrors were tried; Last error: Status code: 404 for https://codecs.fedoraproject.org/openh264/43/x86_64/os/repodata/repomd.xml (IP: 10.3.163.76)
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:29 qemu0 systemd[1]: kola-runext.service: Main process exited, code=exited, status=1/FAILURE
00:51:30 [2025-03-13T00:51:30.442Z] Mar 13 00:51:29 qemu0 systemd[1]: kola-runext.service: Failed with result 'exit-code'.
00:51:33 [2025-03-13T00:51:33.693Z] --- [31mFAIL[0m: ext.config.extensions.package (41.68s)
00:51:33 [2025-03-13T00:51:33.693Z]         cluster.go:151: Error: Unit kola-runext.service exited with code 1
00:51:33 [2025-03-13T00:51:33.693Z]         cluster.go:151: 2025-03-13T00:51:29Z cli: Unit kola-runext.service exited with code 1
00:51:33 [2025-03-13T00:51:33.693Z]         harness.go:1265: kolet failed: : kolet run-test-unit failed: Process exited with status 1
00:51:33 [2025-03-13T00:51:33.693Z] FAIL, output in /home/jenkins/agent/workspace/test-override/tmp/kola-kPfzB/kola-x86_64/rerun
00:51:33 [2025-03-13T00:51:33.693Z] Error: harness: test suite failed
00:51:33 [2025-03-13T00:51:33.693Z] 2025-03-13T00:51:32Z cli: harness: test suite failed
00:51:33 [2025-03-13T00:51:33.693Z] failed to execute cmd-kola: exit status 1