Console Output
21:50:22 [2025-01-17T21:50:22.987Z] + set -xeuo pipefail
21:50:22 [2025-01-17T21:50:22.988Z] ++ umask
21:50:22 [2025-01-17T21:50:22.988Z] + '[' 0022 = 0000 ']'
21:50:22 [2025-01-17T21:50:22.988Z] + cd /home/jenkins/agent/workspace/test-override
21:50:22 [2025-01-17T21:50:22.988Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-t6LTA/kola-x86_64 --on-warn-failure-exit-77 --arch=x86_64 '--tag=!reprovision' --parallel=5
21:50:22 [2025-01-17T21:50:22.988Z] 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-t6LTA/kola-x86_64
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.gshadow
21:50:23 [2025-01-17T21:50:23.243Z] === RUN rpmostree.install-uninstall
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.boot.grub2-install
21:50:23 [2025-01-17T21:50:23.243Z] === RUN fcos.users.shells
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.ignition.kargs
21:50:23 [2025-01-17T21:50:23.243Z] === RUN kdump.crash.ssh
21:50:23 [2025-01-17T21:50:23.243Z] === RUN coreos.ignition.groups
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.ntp.timesyncd.dhcp-propagation
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ostree.remote
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.networking.mtu-on-bond-kargs
21:50:23 [2025-01-17T21:50:23.243Z] === RUN rootfs.uuid
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.selinux.enforcing
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.kdump.crash
21:50:23 [2025-01-17T21:50:23.243Z] === RUN podman.workflow
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ext.config.butane.grub-users
21:50:23 [2025-01-17T21:50:23.243Z] === RUN ostree.unlock
21:50:23 [2025-01-17T21:50:23.243Z] === RUN fcos.network.listeners
21:50:23 [2025-01-17T21:50:23.243Z] === RUN coreos.ignition.sethostname
21:50:23 [2025-01-17T21:50:23.243Z] === RUN coreos.selinux.boolean
21:50:23 [2025-01-17T21:50:23.243Z] === RUN podman.network-single
21:50:23 [2025-01-17T21:50:23.244Z] === RUN basic.uefi-secure
21:50:23 [2025-01-17T21:50:23.244Z] === RUN multipath.day2
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.reboot
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.firewall.iptables-legacy
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.nmstate.policy
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.kargs-rd-net
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.prefer-ignition-networking
21:50:23 [2025-01-17T21:50:23.244Z] === RUN basic
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.nameserver
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.docker.basic
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.force-persist-ip
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.containers.quadlet
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ostree.hotfix
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.mount.partitions
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.auth.verify
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.disks.lvmdevices
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.systemd-unmasking
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.toolbox
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.podman.rootless-systemd
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.var-mount.scsi-id
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.hostname.fallback-hostname
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.var-mount.simple
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.swap.zram-generator
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.systemd.condition-needs-update
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.extensions.package
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.no-persist-ip
21:50:23 [2025-01-17T21:50:23.244Z] === RUN basic.uefi
21:50:23 [2025-01-17T21:50:23.244Z] === RUN rpmostree.upgrade-rollback
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.unique.boot.ignition.failure
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.boot.bootupd-validate
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.once
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.ifname-karg.everyboot-systemd-link-file
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.team-dhcp-via-ignition
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.systemd-disable
21:50:23 [2025-01-17T21:50:23.244Z] === RUN rhcos.selinux.boolean.persist
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.instantiated.enable-unit
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.symlink
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.delete-config
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ntp.chrony.dhcp-propagation
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.mount.disks
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.rd-net-timeout-carrier
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.ifname-karg.udev-rule-firstboot-propagation
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.unique.boot.failure
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.no-default-initramfs-net-propagation.bootif
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.rpm-ostree-countme
21:50:23 [2025-01-17T21:50:23.244Z] === RUN podman.base
21:50:23 [2025-01-17T21:50:23.244Z] === RUN rpmostree.status
21:50:23 [2025-01-17T21:50:23.244Z] === RUN fcos.filesystem
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.clhm.ignition-warnings
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.failure
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.systemd-enable-units
21:50:23 [2025-01-17T21:50:23.244Z] === RUN basic.nvme
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.nmstate.state
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.systemd.network-online
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.misc.disk.varlibcontainers
21:50:23 [2025-01-17T21:50:23.244Z] === RUN multipath.day1
21:50:23 [2025-01-17T21:50:23.244Z] === RUN non-exclusive-test-bucket-0
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.stable-boot
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.resource.remote
21:50:23 [2025-01-17T21:50:23.244Z] === RUN coreos.ignition.v2.users
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ssh.custom-host-key-permissions
21:50:23 [2025-01-17T21:50:23.244Z] === RUN multipath.partition
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.mtu-on-bond-ignition
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.networking.bridge-static-via-kargs
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.ignition.remote
21:50:23 [2025-01-17T21:50:23.244Z] === RUN ext.config.var-mount.luks
21:51:01 [2025-01-17T21:51:01.883Z] --- [32mPASS[0m: rpmostree.status (37.20s)
21:51:02 [2025-01-17T21:51:02.458Z] --- [32mPASS[0m: ext.config.gshadow (39.07s)
21:51:14 [2025-01-17T21:51:14.597Z] systemctl status kola-runext.service:
21:51:14 [2025-01-17T21:51:14.597Z] �� kola-runext.service
21:51:14 [2025-01-17T21:51:14.597Z] Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
21:51:14 [2025-01-17T21:51:14.597Z] Drop-In: /usr/lib/systemd/system/service.d
21:51:14 [2025-01-17T21:51:14.597Z] ������10-timeout-abort.conf, 50-keep-warm.conf
21:51:14 [2025-01-17T21:51:14.597Z] Active: failed (Result: exit-code) since Fri 2025-01-17 21:51:11 UTC; 783ms ago
21:51:14 [2025-01-17T21:51:14.597Z] Duration: 13.388s
21:51:14 [2025-01-17T21:51:14.597Z] Invocation: 14cad11dad134fe59416917e452747e2
21:51:14 [2025-01-17T21:51:14.597Z] Process: 2286 ExecStart=/usr/local/bin/kola-runext-package (code=exited, status=1/FAILURE)
21:51:14 [2025-01-17T21:51:14.597Z] Main PID: 2286 (code=exited, status=1/FAILURE)
21:51:14 [2025-01-17T21:51:14.597Z] Mem peak: 6.1M
21:51:14 [2025-01-17T21:51:14.597Z] CPU: 89ms
21:51:14 [2025-01-17T21:51:14.597Z]
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 systemd[1]: Started kola-runext.service.
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2286]: + . /var/opt/kola/extdata/commonlib.sh
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2286]: ++ IFS=' '
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2286]: ++ read -r -a cmdline
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2286]: + commands=('htop' 'strace' 'tcpdump' 'tree' 'crio')
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2286]: + case "$(get_fcos_stream)" in
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2287]: ++ get_fcos_stream
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2288]: ++ rpm-ostree status -b --json
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2289]: ++ jq -r '.deployments[0]["base-commit-meta"]["fedora-coreos.stream"]'
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2286]: + rpm-ostree install --apply-live htop strace tcpdump tree crio
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:50:58 qemu0 kola-runext-package[2296]: notice: auto-inferring -y/--assumeyes when not run interactively; this will change in the future
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:05 qemu0 kola-runext-package[2296]: Checking out tree b3ee7e3...done
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:05 qemu0 kola-runext-package[2296]: Enabled rpm-md repositories: fedora-cisco-openh264 rawhide
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:05 qemu0 kola-runext-package[2296]: Updating metadata for 'fedora-cisco-openh264'...done
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:06 qemu0 kola-runext-package[2296]: Updating metadata for 'rawhide'...done
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: Importing rpm-md...done
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: rpm-md repo 'fedora-cisco-openh264'; generated: 2024-08-21T16:04:02Z solvables: 3
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: rpm-md repo 'rawhide'; generated: 2025-01-17T06:15:00Z solvables: 76897
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: Resolving dependencies...done
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: error: Could not depsolve transaction; 1 problem detected:
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: Problem: cannot install both filesystem-3.18-34.fc42.x86_64 from rawhide and filesystem-3.18-29.fc42.x86_64 from @System
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: - package tcpdump-14:4.99.5-2.fc42.x86_64 from rawhide requires filesystem(unmerged-sbin-symlinks), but none of the providers can be installed
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 kola-runext-package[2296]: - conflicting requests
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 systemd[1]: kola-runext.service: Main process exited, code=exited, status=1/FAILURE
21:51:14 [2025-01-17T21:51:14.597Z] Jan 17 21:51:11 qemu0 systemd[1]: kola-runext.service: Failed with result 'exit-code'.
21:51:17 [2025-01-17T21:51:17.283Z] --- [31mFAIL[0m: ext.config.extensions.package (53.81s)
21:51:17 [2025-01-17T21:51:17.283Z] cluster.go:151: Error: Unit kola-runext.service exited with code 1
21:51:17 [2025-01-17T21:51:17.283Z] cluster.go:151: 2025-01-17T21:51:12Z cli: Unit kola-runext.service exited with code 1
21:51:17 [2025-01-17T21:51:17.283Z] harness.go:1265: kolet failed: : kolet run-test-unit failed: Process exited with status 1
21:51:21 [2025-01-17T21:51:21.450Z] --- [32mPASS[0m: coreos.ignition.mount.partitions (57.93s)
21:51:23 [2025-01-17T21:51:23.326Z] --- [32mPASS[0m: ext.config.reboot (59.99s)
21:51:38 [2025-01-17T21:51:38.191Z] === RUN ostree.hotfix/unlock
21:51:48 [2025-01-17T21:51:48.133Z] --- [32mPASS[0m: ext.config.networking.nameserver (47.05s)
21:51:51 [2025-01-17T21:51:51.420Z] === RUN ostree.hotfix/install
21:51:56 [2025-01-17T21:51:56.643Z] --- [32mPASS[0m: ext.config.containers.quadlet (38.64s)
21:51:56 [2025-01-17T21:51:56.643Z] === RUN ostree.hotfix/uninstall
21:51:56 [2025-01-17T21:51:56.897Z] === RUN ostree.hotfix/persist
21:52:03 [2025-01-17T21:52:03.428Z] --- [32mPASS[0m: ext.config.networking.force-persist-ip (42.02s)
21:52:09 [2025-01-17T21:52:09.957Z] --- [32mPASS[0m: ext.config.docker.basic (46.70s)
21:52:16 [2025-01-17T21:52:16.474Z] === RUN ostree.hotfix/rollback
21:52:38 [2025-01-17T21:52:38.351Z] === RUN basic.uefi-secure/DbusPerms
21:52:38 [2025-01-17T21:52:38.351Z] === RUN basic.uefi-secure/ServicesActive
21:52:38 [2025-01-17T21:52:38.351Z] === RUN basic.uefi-secure/ReadOnly
21:52:38 [2025-01-17T21:52:38.351Z] === RUN basic.uefi-secure/Useradd
21:52:38 [2025-01-17T21:52:38.351Z] === RUN basic.uefi-secure/MachineID
21:52:38 [2025-01-17T21:52:38.604Z] === RUN basic.uefi-secure/FCOSGrowpart
21:52:38 [2025-01-17T21:52:38.604Z] === RUN basic.uefi-secure/PortSSH
21:52:39 [2025-01-17T21:52:39.975Z] --- [32mPASS[0m: ostree.hotfix (97.44s)
21:52:39 [2025-01-17T21:52:39.975Z] --- [32mPASS[0m: ostree.hotfix/unlock (13.80s)
21:52:39 [2025-01-17T21:52:39.975Z] --- [32mPASS[0m: ostree.hotfix/install (5.11s)
21:52:39 [2025-01-17T21:52:39.975Z] --- [32mPASS[0m: ostree.hotfix/uninstall (0.51s)
21:52:39 [2025-01-17T21:52:39.975Z] --- [32mPASS[0m: ostree.hotfix/persist (18.84s)
21:52:39 [2025-01-17T21:52:39.975Z] --- [32mPASS[0m: ostree.hotfix/rollback (20.32s)
21:52:42 [2025-01-17T21:52:42.474Z] --- [32mPASS[0m: basic.uefi-secure (38.95s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/DbusPerms (0.37s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/ServicesActive (0.15s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/ReadOnly (0.12s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/Useradd (0.32s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/MachineID (0.13s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/FCOSGrowpart (0.16s)
21:52:42 [2025-01-17T21:52:42.475Z] --- [32mPASS[0m: basic.uefi-secure/PortSSH (0.16s)
21:52:46 [2025-01-17T21:52:46.637Z] --- [32mPASS[0m: ext.config.selinux.enforcing (58.53s)
21:52:50 [2025-01-17T21:52:50.784Z] --- [32mPASS[0m: ext.config.ignition.stable-boot (40.63s)
21:53:12 [2025-01-17T21:53:12.652Z] --- [32mPASS[0m: multipath.day2 (76.87s)
21:53:15 [2025-01-17T21:53:15.154Z] --- [32mPASS[0m: fcos.network.listeners (24.39s)
21:53:23 [2025-01-17T21:53:23.229Z] --- [32mPASS[0m: coreos.ignition.sethostname (36.25s)
21:53:41 [2025-01-17T21:53:41.250Z] --- [32mPASS[0m: coreos.selinux.boolean (57.34s)
21:53:43 [2025-01-17T21:53:43.754Z] === RUN ostree.unlock/unlock
21:53:44 [2025-01-17T21:53:44.007Z] === RUN ostree.unlock/install
21:53:44 [2025-01-17T21:53:44.563Z] === RUN ostree.unlock/uninstall
21:53:44 [2025-01-17T21:53:44.816Z] === RUN ostree.unlock/discard
21:54:02 [2025-01-17T21:54:02.839Z] === RUN podman.workflow/run
21:54:07 [2025-01-17T21:54:07.000Z] --- [32mPASS[0m: ostree.unlock (54.00s)
21:54:07 [2025-01-17T21:54:07.000Z] --- [32mPASS[0m: ostree.unlock/unlock (0.60s)
21:54:07 [2025-01-17T21:54:07.000Z] --- [32mPASS[0m: ostree.unlock/install (0.49s)
21:54:07 [2025-01-17T21:54:07.000Z] --- [32mPASS[0m: ostree.unlock/uninstall (0.40s)
21:54:07 [2025-01-17T21:54:07.000Z] --- [32mPASS[0m: ostree.unlock/discard (18.44s)
21:54:16 [2025-01-17T21:54:16.925Z] --- [32mPASS[0m: ext.config.butane.grub-users (61.87s)
21:54:48 [2025-01-17T21:54:48.927Z] --- [32mPASS[0m: ext.config.var-mount.luks (83.99s)
21:55:03 [2025-01-17T21:55:03.759Z] --- [32mPASS[0m: ext.config.ignition.remote (55.02s)
21:55:35 [2025-01-17T21:55:35.769Z] --- [32mPASS[0m: ext.config.networking.bridge-static-via-kargs (46.43s)
21:55:39 [2025-01-17T21:55:39.036Z] --- [32mPASS[0m: coreos.ignition.v2.users (37.08s)
21:55:39 [2025-01-17T21:55:39.036Z] --- [32mPASS[0m: podman.network-single (179.20s)
21:56:17 [2025-01-17T21:56:17.672Z] --- [32mPASS[0m: ext.config.ssh.custom-host-key-permissions (38.41s)
21:56:17 [2025-01-17T21:56:17.672Z] --- [32mPASS[0m: ext.config.kdump.crash (118.26s)
21:56:17 [2025-01-17T21:56:17.672Z] --- [32mPASS[0m: ext.config.ignition.resource.remote (38.97s)
21:56:20 [2025-01-17T21:56:20.920Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-ignition (41.33s)
21:56:47 [2025-01-17T21:56:47.397Z] --- [32mPASS[0m: coreos.ignition.instantiated.enable-unit (25.62s)
21:57:02 [2025-01-17T21:57:02.221Z] --- [32mPASS[0m: ext.config.var-mount.scsi-id (49.62s)
21:57:04 [2025-01-17T21:57:04.115Z] === RUN podman.base/info
21:57:04 [2025-01-17T21:57:04.369Z] === RUN podman.base/resources
21:57:10 [2025-01-17T21:57:10.878Z] --- [32mPASS[0m: multipath.partition (55.65s)
21:57:12 [2025-01-17T21:57:12.251Z] --- [32mPASS[0m: podman.base (28.85s)
21:57:12 [2025-01-17T21:57:12.251Z] --- [32mPASS[0m: podman.base/info (0.42s)
21:57:12 [2025-01-17T21:57:12.251Z] --- [32mPASS[0m: podman.base/resources (4.61s)
21:57:30 [2025-01-17T21:57:30.693Z] --- [32mPASS[0m: ext.config.ignition.systemd-unmasking (26.84s)
21:57:40 [2025-01-17T21:57:40.603Z] --- [32mPASS[0m: ext.config.systemd.condition-needs-update (79.74s)
21:57:48 [2025-01-17T21:57:48.684Z] --- [32mPASS[0m: ext.config.swap.zram-generator (37.73s)
21:57:51 [2025-01-17T21:57:51.184Z] --- [32mPASS[0m: ext.config.rpm-ostree-countme (38.98s)
21:58:23 [2025-01-17T21:58:23.197Z] --- [32mPASS[0m: ext.config.networking.no-default-initramfs-net-propagation.bootif (39.57s)
21:58:23 [2025-01-17T21:58:23.197Z] --- [32mPASS[0m: ext.config.podman.rootless-systemd (54.85s)
21:58:23 [2025-01-17T21:58:23.197Z] mke2fs 1.47.1 (20-May-2024)
21:58:35 [2025-01-17T21:58:35.349Z] --- [32mPASS[0m: coreos.unique.boot.failure (11.72s)
21:58:45 [2025-01-17T21:58:45.259Z] --- [32mPASS[0m: ext.config.var-mount.simple (56.57s)
21:58:46 [2025-01-17T21:58:46.195Z] --- [32mPASS[0m: ext.config.networking.hostname.fallback-hostname (26.60s)
21:59:18 [2025-01-17T21:59:18.209Z] --- [32mPASS[0m: ext.config.toolbox (82.17s)
21:59:18 [2025-01-17T21:59:18.209Z] === RUN podman.workflow/exec
21:59:18 [2025-01-17T21:59:18.209Z] === RUN podman.workflow/stop
21:59:28 [2025-01-17T21:59:28.129Z] === RUN podman.workflow/remove
21:59:28 [2025-01-17T21:59:28.129Z] === RUN podman.workflow/delete
21:59:28 [2025-01-17T21:59:28.398Z] --- [32mPASS[0m: coreos.ignition.once (42.01s)
21:59:28 [2025-01-17T21:59:28.954Z] --- [32mPASS[0m: coreos.ignition.mount.disks (54.86s)
21:59:32 [2025-01-17T21:59:32.204Z] --- [32mPASS[0m: podman.workflow (352.32s)
21:59:32 [2025-01-17T21:59:32.204Z] --- [32mPASS[0m: podman.workflow/run (314.72s)
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: Getting image source signatures
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: Copying blob sha256:a52c777f25d4afed9d7958da2f249de731ed6e4479ead4f00621589d0398610c
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: Copying config sha256:a432b057a522737c229d2aac9b029f55bf2a44eb3f423e4e4ece2acb8a304652
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: Writing manifest to image destination
21:59:32 [2025-01-17T21:59:32.204Z] --- [32mPASS[0m: podman.workflow/exec (0.79s)
21:59:32 [2025-01-17T21:59:32.204Z] --- [32mPASS[0m: podman.workflow/stop (10.69s)
21:59:32 [2025-01-17T21:59:32.204Z] --- [32mPASS[0m: podman.workflow/remove (0.58s)
21:59:32 [2025-01-17T21:59:32.204Z] --- [32mPASS[0m: podman.workflow/delete (0.71s)
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: grep: quay.io/fedora/fedora:latest: No such file or directory
21:59:32 [2025-01-17T21:59:32.204Z] cluster.go:151: bash: line 2: Deleted:: command not found
22:00:04 [2025-01-17T22:00:04.219Z] --- [32mPASS[0m: ext.config.ntp.chrony.dhcp-propagation (74.98s)
22:00:12 [2025-01-17T22:00:12.300Z] --- [32mPASS[0m: ext.config.networking.ifname-karg.udev-rule-firstboot-propagation (58.92s)
22:00:17 [2025-01-17T22:00:17.544Z] --- [32mPASS[0m: ext.config.networking.nmstate.state (44.87s)
22:00:24 [2025-01-17T22:00:24.057Z] --- [32mPASS[0m: rhcos.selinux.boolean.persist (54.42s)
22:00:24 [2025-01-17T22:00:24.614Z] --- [32mPASS[0m: coreos.ignition.symlink (24.55s)
22:00:42 [2025-01-17T22:00:42.634Z] --- [32mPASS[0m: coreos.ignition.failure (16.27s)
22:00:50 [2025-01-17T22:00:50.716Z] --- [32mPASS[0m: ext.config.ignition.systemd-disable (38.42s)
22:01:00 [2025-01-17T22:01:00.648Z] --- [32mPASS[0m: ext.config.ignition.delete-config (90.82s)
22:01:10 [2025-01-17T22:01:10.573Z] === RUN non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents
22:01:15 [2025-01-17T22:01:15.794Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.tmpfs
22:01:16 [2025-01-17T22:01:16.729Z] === RUN non-exclusive-test-bucket-0/ext.config.clhm.network-device-info
22:01:18 [2025-01-17T22:01:18.604Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.nm-start
22:01:19 [2025-01-17T22:01:19.957Z] === RUN non-exclusive-test-bucket-0/ext.config.ignition.journald-log
22:01:20 [2025-01-17T22:01:20.876Z] === RUN basic.nvme/ReadOnly
22:01:20 [2025-01-17T22:01:20.876Z] === RUN basic.nvme/Useradd
22:01:21 [2025-01-17T22:01:21.129Z] === RUN basic.nvme/MachineID
22:01:21 [2025-01-17T22:01:21.397Z] === RUN basic.nvme/FCOSGrowpart
22:01:21 [2025-01-17T22:01:21.397Z] --- [32mPASS[0m: ext.config.networking.rd-net-timeout-carrier (57.85s)
22:01:21 [2025-01-17T22:01:21.398Z] === RUN basic.nvme/PortSSH
22:01:21 [2025-01-17T22:01:21.651Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin
22:01:21 [2025-01-17T22:01:21.651Z] === RUN basic.nvme/DbusPerms
22:01:21 [2025-01-17T22:01:21.904Z] === RUN basic.nvme/ServicesActive
22:01:23 [2025-01-17T22:01:23.257Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.partition-scheme
22:01:25 [2025-01-17T22:01:25.131Z] === RUN non-exclusive-test-bucket-0/ext.config.ntp.chrony.coreos-platform-chrony-config
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme (26.22s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/ReadOnly (0.11s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/Useradd (0.24s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/MachineID (0.11s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/FCOSGrowpart (0.15s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/PortSSH (0.11s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/DbusPerms (0.34s)
22:01:25 [2025-01-17T22:01:25.385Z] --- [32mPASS[0m: basic.nvme/ServicesActive (0.13s)
22:01:26 [2025-01-17T22:01:26.324Z] === RUN non-exclusive-test-bucket-0/ext.config.kubernetes.systemd-env-read
22:01:28 [2025-01-17T22:01:28.202Z] === RUN non-exclusive-test-bucket-0/ext.config.files.etc-permissions
22:01:30 [2025-01-17T22:01:30.080Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.network-online-service
22:01:31 [2025-01-17T22:01:31.434Z] === RUN non-exclusive-test-bucket-0/ext.config.files.fcos_users
22:01:33 [2025-01-17T22:01:33.328Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.growfs
22:01:33 [2025-01-17T22:01:33.582Z] --- [32mPASS[0m: ext.config.networking.team-dhcp-via-ignition (42.83s)
22:01:33 [2025-01-17T22:01:33.582Z] === RUN non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust
22:01:35 [2025-01-17T22:01:35.456Z] === RUN non-exclusive-test-bucket-0/ext.config.files.setuid
22:01:36 [2025-01-17T22:01:36.810Z] --- [32mPASS[0m: multipath.day1 (55.98s)
22:01:37 [2025-01-17T22:01:37.081Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.nic-naming
22:01:38 [2025-01-17T22:01:38.957Z] === RUN non-exclusive-test-bucket-0/ext.config.files.aleph-version
22:01:40 [2025-01-17T22:01:40.313Z] === RUN non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts
22:01:42 [2025-01-17T22:01:42.191Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.tls
22:01:44 [2025-01-17T22:01:44.712Z] === RUN non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot
22:01:46 [2025-01-17T22:01:46.066Z] === RUN rpmostree.upgrade-rollback/upgrade
22:01:46 [2025-01-17T22:01:46.066Z] === RUN non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir
22:01:46 [2025-01-17T22:01:46.984Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default
22:01:48 [2025-01-17T22:01:48.875Z] === RUN non-exclusive-test-bucket-0/ext.config.files.check-symlink
22:01:50 [2025-01-17T22:01:50.228Z] === RUN non-exclusive-test-bucket-0/ext.config.files.root-bash
22:01:50 [2025-01-17T22:01:50.783Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.podman-tmpfs-context
22:01:57 [2025-01-17T22:01:57.311Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context
22:01:57 [2025-01-17T22:01:57.311Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.no-google-device-links
22:01:57 [2025-01-17T22:01:57.868Z] === RUN non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite
22:01:59 [2025-01-17T22:01:59.743Z] === RUN non-exclusive-test-bucket-0/ext.config.files.logrotate-service
22:02:01 [2025-01-17T22:02:01.096Z] === RUN non-exclusive-test-bucket-0/ext.config.files.kernel-headers
22:02:02 [2025-01-17T22:02:02.032Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change
22:02:03 [2025-01-17T22:02:03.385Z] === RUN non-exclusive-test-bucket-0/ext.config.logging.printk
22:02:03 [2025-01-17T22:02:03.639Z] --- [32mPASS[0m: ext.config.ignition.systemd-enable-units (26.76s)
22:02:04 [2025-01-17T22:02:04.992Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service
22:02:06 [2025-01-17T22:02:06.884Z] === RUN non-exclusive-test-bucket-0/ext.config.boot.bootupd
22:02:08 [2025-01-17T22:02:08.759Z] === RUN non-exclusive-test-bucket-0/ext.config.files.remove-manifest-files
22:02:09 [2025-01-17T22:02:09.012Z] === RUN non-exclusive-test-bucket-0/ext.config.files.initrd.executables
22:02:17 [2025-01-17T22:02:17.088Z] === RUN non-exclusive-test-bucket-0/ext.config.podman.dns
22:02:18 [2025-01-17T22:02:18.008Z] --- [32mPASS[0m: coreos.misc.disk.varlibcontainers (56.77s)
22:02:18 [2025-01-17T22:02:18.008Z] 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'.
22:02:18 [2025-01-17T22:02:18.008Z] cluster.go:151: Created symlink '/etc/systemd/system/local-fs.target.wants/var-lib-containers.mount' ��� '/etc/systemd/system/var-lib-containers.mount'.
22:02:22 [2025-01-17T22:02:22.156Z] === RUN non-exclusive-test-bucket-0/ext.config.content-origins
22:02:23 [2025-01-17T22:02:23.094Z] === RUN rpmostree.upgrade-rollback/rollback
22:02:23 [2025-01-17T22:02:23.094Z] === RUN non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2
22:02:24 [2025-01-17T22:02:24.013Z] === RUN non-exclusive-test-bucket-0/ext.config.security.passwd
22:02:25 [2025-01-17T22:02:25.890Z] === RUN non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps
22:02:27 [2025-01-17T22:02:27.243Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.nm-dhcp-client
22:02:29 [2025-01-17T22:02:29.137Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context
22:02:29 [2025-01-17T22:02:29.391Z] === RUN non-exclusive-test-bucket-0/ext.config.swap.zram-default
22:02:30 [2025-01-17T22:02:30.309Z] === RUN non-exclusive-test-bucket-0/ext.config.files.license
22:02:30 [2025-01-17T22:02:30.865Z] === RUN non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved
22:02:31 [2025-01-17T22:02:31.422Z] --- [32mPASS[0m: ext.config.systemd.network-online (27.59s)
22:02:32 [2025-01-17T22:02:32.794Z] === RUN non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch
22:02:33 [2025-01-17T22:02:33.048Z] --- [32mPASS[0m: ext.config.networking.ifname-karg.everyboot-systemd-link-file (59.43s)
22:02:35 [2025-01-17T22:02:35.548Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.root-prjquota
22:02:36 [2025-01-17T22:02:36.903Z] === RUN non-exclusive-test-bucket-0/ext.config.files.initrd.compression
22:02:38 [2025-01-17T22:02:38.799Z] === RUN non-exclusive-test-bucket-0/ext.config.files.console-config
22:02:40 [2025-01-17T22:02:40.676Z] === RUN non-exclusive-test-bucket-0/ext.config.files.sudoers
22:02:42 [2025-01-17T22:02:42.034Z] === RUN non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit
22:02:42 [2025-01-17T22:02:42.591Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match
22:02:46 [2025-01-17T22:02:46.755Z] --- [32mPASS[0m: ext.config.boot.bootupd-validate (27.98s)
22:02:46 [2025-01-17T22:02:46.755Z] === RUN non-exclusive-test-bucket-0/ext.config.files.setgid
22:02:48 [2025-01-17T22:02:48.108Z] === RUN non-exclusive-test-bucket-0/ext.config.files.fwupd-refresh-timer
22:02:48 [2025-01-17T22:02:48.665Z] --- [32mPASS[0m: coreos.unique.boot.ignition.failure (15.78s)
22:02:49 [2025-01-17T22:02:49.221Z] --- [32mPASS[0m: rpmostree.upgrade-rollback (83.91s)
22:02:49 [2025-01-17T22:02:49.221Z] --- [32mPASS[0m: rpmostree.upgrade-rollback/upgrade (37.03s)
22:02:49 [2025-01-17T22:02:49.221Z] --- [32mPASS[0m: rpmostree.upgrade-rollback/rollback (22.64s)
22:02:49 [2025-01-17T22:02:49.794Z] === RUN non-exclusive-test-bucket-0/ext.config.files.fcos_groups
22:02:51 [2025-01-17T22:02:51.669Z] === RUN non-exclusive-test-bucket-0/ext.config.files.file-directory-permissions
22:02:53 [2025-01-17T22:02:53.023Z] === RUN non-exclusive-test-bucket-0/ext.config.kdump.service
22:02:54 [2025-01-17T22:02:54.896Z] === RUN non-exclusive-test-bucket-0/ext.config.selinux.unmodified-policy
22:02:56 [2025-01-17T22:02:56.267Z] === RUN non-exclusive-test-bucket-0/ext.config.firewall.iptables
22:02:58 [2025-01-17T22:02:58.140Z] === RUN non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking
22:03:00 [2025-01-17T22:03:00.015Z] === RUN non-exclusive-test-bucket-0/ext.config.files.amd-ucode-firmware
22:03:00 [2025-01-17T22:03:00.269Z] === RUN non-exclusive-test-bucket-0/ext.config.files.validate-symlinks
22:03:15 [2025-01-17T22:03:15.087Z] === RUN non-exclusive-test-bucket-0/ext.config.files.system-generators
22:03:15 [2025-01-17T22:03:15.087Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.systemd-repart-service
22:03:16 [2025-01-17T22:03:16.023Z] --- [32mPASS[0m: ext.config.disks.lvmdevices (44.77s)
22:03:16 [2025-01-17T22:03:16.581Z] === RUN non-exclusive-test-bucket-0/ext.config.disks.root-boot-ro
22:03:20 [2025-01-17T22:03:20.729Z] === RUN basic.uefi/MachineID
22:03:20 [2025-01-17T22:03:20.729Z] === RUN basic.uefi/FCOSGrowpart
22:03:20 [2025-01-17T22:03:20.729Z] === RUN basic.uefi/PortSSH
22:03:20 [2025-01-17T22:03:20.729Z] === RUN basic.uefi/DbusPerms
22:03:20 [2025-01-17T22:03:20.982Z] === RUN basic.uefi/ServicesActive
22:03:21 [2025-01-17T22:03:21.235Z] === RUN basic.uefi/ReadOnly
22:03:21 [2025-01-17T22:03:21.235Z] === RUN basic.uefi/Useradd
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0 (185.07s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents (6.69s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.tmpfs (0.66s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.clhm.network-device-info (1.69s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nm-start (1.62s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.ignition.journald-log (1.63s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nm-ifcfg-rh-plugin (1.62s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.partition-scheme (1.66s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.ntp.chrony.coreos-platform-chrony-config (1.63s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.kubernetes.systemd-env-read (1.70s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.etc-permissions (1.66s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.network-online-service (1.63s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.fcos_users (1.62s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.growfs (0.62s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust (1.62s)
22:03:21 [2025-01-17T22:03:21.807Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.setuid (1.69s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nic-naming (1.64s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.aleph-version (1.62s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.systemd.default-unit-timeouts (1.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.tls (2.67s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.systemd.no-systemd-firstboot (1.64s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.yum-repo-dir (0.64s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.no-default-initramfs-net-propagation.default (1.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.check-symlink (1.63s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.root-bash (0.63s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.podman-tmpfs-context (5.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.stub-resolve-context (0.71s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.no-google-device-links (0.73s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.rpmdb-sqlite (1.67s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.logrotate-service (1.64s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.kernel-headers (0.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.default-network-behavior-change (1.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.logging.printk (1.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.dnsmasq-service (1.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.boot.bootupd (1.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.remove-manifest-files (0.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.initrd.executables (6.70s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.podman.dns (5.72s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.content-origins (1.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.containers.cgroups-v2 (0.64s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.security.passwd (1.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.rpm-ostree.container-deps (1.69s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.nm-dhcp-client (1.63s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.usrlocal-context (0.64s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.swap.zram-default (0.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.license (0.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.networking.resolv.systemd-resolved (1.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.kubernetes.kube-watch (2.73s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.root-prjquota (1.76s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.initrd.compression (1.65s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.console-config (1.67s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.sudoers (1.67s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.root-immutable-bit (0.73s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.file-context-policy-match (3.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.setgid (1.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.fwupd-refresh-timer (1.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.fcos_groups (1.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.file-directory-permissions (1.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.kdump.service (1.67s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.selinux.unmodified-policy (1.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.firewall.iptables (1.71s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.podman.rootless-pasta-networking (1.68s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.amd-ucode-firmware (0.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.validate-symlinks (12.93s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.files.system-generators (1.67s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.systemd-repart-service (1.66s)
22:03:21 [2025-01-17T22:03:21.808Z] --- [32mPASS[0m: non-exclusive-test-bucket-0/ext.config.disks.root-boot-ro (1.64s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi (38.76s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/MachineID (0.11s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/FCOSGrowpart (0.15s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/PortSSH (0.12s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/DbusPerms (0.37s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/ServicesActive (0.13s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/ReadOnly (0.12s)
22:03:25 [2025-01-17T22:03:25.057Z] --- [32mPASS[0m: basic.uefi/Useradd (0.20s)
22:03:27 [2025-01-17T22:03:27.558Z] --- [32mPASS[0m: ext.config.clhm.ignition-warnings (38.46s)
22:03:30 [2025-01-17T22:03:30.073Z] --- [32mPASS[0m: ext.config.networking.no-persist-ip (41.15s)
22:03:38 [2025-01-17T22:03:38.147Z] === RUN fcos.filesystem/writablefiles
22:03:38 [2025-01-17T22:03:38.147Z] === RUN fcos.filesystem/writabledirs
22:03:38 [2025-01-17T22:03:38.147Z] === RUN fcos.filesystem/stickydirs
22:03:38 [2025-01-17T22:03:38.147Z] === RUN fcos.filesystem/denylist
22:03:42 [2025-01-17T22:03:42.290Z] --- [32mPASS[0m: fcos.filesystem (25.81s)
22:03:42 [2025-01-17T22:03:42.290Z] --- [32mPASS[0m: fcos.filesystem/writablefiles (0.85s)
22:03:42 [2025-01-17T22:03:42.290Z] --- [32mPASS[0m: fcos.filesystem/writabledirs (0.26s)
22:03:42 [2025-01-17T22:03:42.290Z] --- [32mPASS[0m: fcos.filesystem/stickydirs (0.29s)
22:03:42 [2025-01-17T22:03:42.290Z] --- [32mPASS[0m: fcos.filesystem/denylist (0.38s)
22:03:46 [2025-01-17T22:03:46.456Z] --- [32mPASS[0m: coreos.ignition.groups (24.55s)
22:04:04 [2025-01-17T22:04:04.478Z] --- [32mPASS[0m: fcos.users.shells (37.04s)
22:04:04 [2025-01-17T22:04:04.478Z] === RUN rootfs.uuid/RandomUUID
22:04:06 [2025-01-17T22:04:06.977Z] --- [32mPASS[0m: ext.config.networking.kargs-rd-net (38.96s)
22:04:06 [2025-01-17T22:04:06.977Z] --- [32mPASS[0m: rootfs.uuid (24.93s)
22:04:06 [2025-01-17T22:04:06.977Z] --- [32mPASS[0m: rootfs.uuid/RandomUUID (0.15s)
22:04:13 [2025-01-17T22:04:13.507Z] --- [32mPASS[0m: ext.config.boot.grub2-install (26.88s)
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/MachineID
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/FCOSGrowpart
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/PortSSH
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/DbusPerms
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/ServicesActive
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/ReadOnly
22:04:35 [2025-01-17T22:04:35.366Z] === RUN basic/Useradd
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic (35.78s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/MachineID (0.11s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/FCOSGrowpart (0.15s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/PortSSH (0.11s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/DbusPerms (0.33s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/ServicesActive (0.13s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/ReadOnly (0.11s)
22:04:37 [2025-01-17T22:04:37.866Z] --- [32mPASS[0m: basic/Useradd (0.20s)
22:04:39 [2025-01-17T22:04:39.742Z] === RUN rpmostree.install-uninstall/install
22:04:46 [2025-01-17T22:04:46.275Z] --- [32mPASS[0m: ext.config.ignition.kargs (39.07s)
22:05:04 [2025-01-17T22:05:04.291Z] --- [32mPASS[0m: coreos.auth.verify (24.04s)
22:05:26 [2025-01-17T22:05:26.145Z] --- [32mPASS[0m: kdump.crash.ssh (113.25s)
22:05:26 [2025-01-17T22:05:26.145Z] cluster.go:151: Running as unit: run-p7215-i7515.service; invocation ID: 5eac8c26565f46d7b7ae88658a23727d
22:05:26 [2025-01-17T22:05:26.145Z] === RUN rpmostree.install-uninstall/uninstall
22:05:27 [2025-01-17T22:05:27.528Z] --- [32mPASS[0m: ext.config.networking.prefer-ignition-networking (41.71s)
22:05:32 [2025-01-17T22:05:32.749Z] === RUN ostree.remote/add
22:05:33 [2025-01-17T22:05:33.002Z] === RUN ostree.remote/list
22:05:33 [2025-01-17T22:05:33.002Z] === RUN ostree.remote/show-url
22:05:33 [2025-01-17T22:05:33.255Z] === RUN ostree.remote/refs
22:05:33 [2025-01-17T22:05:33.255Z] === RUN ostree.remote/summary
22:05:33 [2025-01-17T22:05:33.509Z] === RUN ostree.remote/delete
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote (35.67s)
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote/add (0.24s)
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote/list (0.11s)
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote/show-url (0.22s)
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote/refs (0.15s)
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote/summary (0.26s)
22:05:37 [2025-01-17T22:05:37.674Z] --- [32mPASS[0m: ostree.remote/delete (0.45s)
22:05:55 [2025-01-17T22:05:55.698Z] --- [32mPASS[0m: ext.config.firewall.iptables-legacy (26.80s)
22:06:07 [2025-01-17T22:06:07.848Z] --- [32mPASS[0m: rpmostree.install-uninstall (120.77s)
22:06:07 [2025-01-17T22:06:07.848Z] --- [32mPASS[0m: rpmostree.install-uninstall/install (46.29s)
22:06:07 [2025-01-17T22:06:07.848Z] --- [32mPASS[0m: rpmostree.install-uninstall/uninstall (38.02s)
22:06:10 [2025-01-17T22:06:10.344Z] --- [32mPASS[0m: ext.config.networking.nmstate.policy (116.75s)
22:06:18 [2025-01-17T22:06:18.408Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-kargs (41.02s)
22:06:40 [2025-01-17T22:06:40.261Z] --- [32mPASS[0m: ext.config.ntp.timesyncd.dhcp-propagation (73.67s)
22:06:40 [2025-01-17T22:06:40.261Z] FAIL, output in /home/jenkins/agent/workspace/test-override/tmp/kola-t6LTA/kola-x86_64
22:06:40 [2025-01-17T22:06:40.261Z]
22:06:40 [2025-01-17T22:06:40.261Z]
22:06:40 [2025-01-17T22:06:40.261Z] ======== Re-running failed tests (flake detection) ========
22:06:40 [2025-01-17T22:06:40.261Z]
22:06:40 [2025-01-17T22:06:40.261Z] === RUN ext.config.extensions.package
22:07:12 [2025-01-17T22:07:12.261Z] systemctl status kola-runext.service:
22:07:12 [2025-01-17T22:07:12.261Z] �� kola-runext.service
22:07:12 [2025-01-17T22:07:12.261Z] Loaded: loaded (/etc/systemd/system/kola-runext.service; static)
22:07:12 [2025-01-17T22:07:12.261Z] Drop-In: /usr/lib/systemd/system/service.d
22:07:12 [2025-01-17T22:07:12.261Z] ������10-timeout-abort.conf, 50-keep-warm.conf
22:07:12 [2025-01-17T22:07:12.261Z] Active: failed (Result: exit-code) since Fri 2025-01-17 22:07:09 UTC; 368ms ago
22:07:12 [2025-01-17T22:07:12.261Z] Duration: 10.835s
22:07:12 [2025-01-17T22:07:12.261Z] Invocation: 6781277411304278836ceff4f2b6f6a2
22:07:12 [2025-01-17T22:07:12.261Z] Process: 2285 ExecStart=/usr/local/bin/kola-runext-package (code=exited, status=1/FAILURE)
22:07:12 [2025-01-17T22:07:12.261Z] Main PID: 2285 (code=exited, status=1/FAILURE)
22:07:12 [2025-01-17T22:07:12.261Z] Mem peak: 6.1M
22:07:12 [2025-01-17T22:07:12.261Z] CPU: 89ms
22:07:12 [2025-01-17T22:07:12.261Z]
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 systemd[1]: Started kola-runext.service.
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2285]: + . /var/opt/kola/extdata/commonlib.sh
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2285]: ++ IFS=' '
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2285]: ++ read -r -a cmdline
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2285]: + commands=('htop' 'strace' 'tcpdump' 'tree' 'crio')
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2285]: + case "$(get_fcos_stream)" in
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2286]: ++ get_fcos_stream
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2287]: ++ rpm-ostree status -b --json
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2288]: ++ jq -r '.deployments[0]["base-commit-meta"]["fedora-coreos.stream"]'
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2285]: + rpm-ostree install --apply-live htop strace tcpdump tree crio
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:06:58 qemu0 kola-runext-package[2294]: notice: auto-inferring -y/--assumeyes when not run interactively; this will change in the future
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:02 qemu0 kola-runext-package[2294]: Checking out tree b3ee7e3...done
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:02 qemu0 kola-runext-package[2294]: Enabled rpm-md repositories: fedora-cisco-openh264 rawhide
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:02 qemu0 kola-runext-package[2294]: Updating metadata for 'fedora-cisco-openh264'...done
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:03 qemu0 kola-runext-package[2294]: Updating metadata for 'rawhide'...done
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: Importing rpm-md...done
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: rpm-md repo 'fedora-cisco-openh264'; generated: 2024-08-21T16:04:02Z solvables: 3
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: rpm-md repo 'rawhide'; generated: 2025-01-17T06:15:00Z solvables: 76897
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: Resolving dependencies...done
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: error: Could not depsolve transaction; 1 problem detected:
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: Problem: cannot install both filesystem-3.18-34.fc42.x86_64 from rawhide and filesystem-3.18-29.fc42.x86_64 from @System
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: - package tcpdump-14:4.99.5-2.fc42.x86_64 from rawhide requires filesystem(unmerged-sbin-symlinks), but none of the providers can be installed
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 kola-runext-package[2294]: - conflicting requests
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 systemd[1]: kola-runext.service: Main process exited, code=exited, status=1/FAILURE
22:07:12 [2025-01-17T22:07:12.261Z] Jan 17 22:07:09 qemu0 systemd[1]: kola-runext.service: Failed with result 'exit-code'.
22:07:13 [2025-01-17T22:07:13.616Z] --- [31mFAIL[0m: ext.config.extensions.package (36.35s)
22:07:13 [2025-01-17T22:07:13.616Z] cluster.go:151: Error: Unit kola-runext.service exited with code 1
22:07:13 [2025-01-17T22:07:13.616Z] cluster.go:151: 2025-01-17T22:07:09Z cli: Unit kola-runext.service exited with code 1
22:07:13 [2025-01-17T22:07:13.616Z] harness.go:1265: kolet failed: : kolet run-test-unit failed: Process exited with status 1
22:07:13 [2025-01-17T22:07:13.616Z] FAIL, output in /home/jenkins/agent/workspace/test-override/tmp/kola-t6LTA/kola-x86_64/rerun
22:07:13 [2025-01-17T22:07:13.616Z] Error: harness: test suite failed
22:07:13 [2025-01-17T22:07:13.616Z] 2025-01-17T22:07:13Z cli: harness: test suite failed
22:07:13 [2025-01-17T22:07:13.616Z] failed to execute cmd-kola: exit status 1