Console Output

Skipping 287 KB.. Full Log

17:40:18 [2025-02-05T17:40:18.823Z] === RUN   podman.workflow/delete
17:40:26 [2025-02-05T17:40:26.882Z] --- PASS: podman.workflow (359.13s)
17:40:26 [2025-02-05T17:40:26.882Z]     --- PASS: podman.workflow/run (307.15s)
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: Getting image source signatures
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: Copying blob sha256:a52c777f25d4afed9d7958da2f249de731ed6e4479ead4f00621589d0398610c
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: Copying config sha256:a432b057a522737c229d2aac9b029f55bf2a44eb3f423e4e4ece2acb8a304652
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: Writing manifest to image destination
17:40:26 [2025-02-05T17:40:26.882Z]     --- PASS: podman.workflow/exec (0.37s)
17:40:26 [2025-02-05T17:40:26.882Z]     --- PASS: podman.workflow/stop (10.82s)
17:40:26 [2025-02-05T17:40:26.882Z]     --- PASS: podman.workflow/remove (0.77s)
17:40:26 [2025-02-05T17:40:26.882Z]     --- PASS: podman.workflow/delete (3.89s)
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: grep: quay.io/fedora/fedora:latest: No such file or directory
17:40:26 [2025-02-05T17:40:26.882Z]             cluster.go:151: bash: line 2: Deleted:: command not found
17:40:31 [2025-02-05T17:40:31.037Z] --- PASS: coreos.selinux.boolean (54.23s)
17:40:43 [2025-02-05T17:40:43.171Z] --- PASS: ext.config.ignition.stable-boot (39.02s)
17:40:43 [2025-02-05T17:40:43.171Z] --- PASS: ext.config.networking.mtu-on-bond-ignition (41.96s)
17:40:47 [2025-02-05T17:40:47.315Z] --- PASS: ext.config.networking.team-dhcp-via-ignition (43.24s)
17:41:05 [2025-02-05T17:41:05.318Z] --- PASS: ext.config.ignition.systemd-unmasking (38.90s)
17:41:05 [2025-02-05T17:41:05.318Z] === RUN   basic.nvme/DbusPerms
17:41:05 [2025-02-05T17:41:05.571Z] === RUN   basic.nvme/ServicesActive
17:41:05 [2025-02-05T17:41:05.823Z] === RUN   basic.nvme/ReadOnly
17:41:05 [2025-02-05T17:41:05.823Z] === RUN   basic.nvme/Useradd
17:41:06 [2025-02-05T17:41:06.077Z] === RUN   basic.nvme/MachineID
17:41:06 [2025-02-05T17:41:06.330Z] === RUN   basic.nvme/FCOSGrowpart
17:41:06 [2025-02-05T17:41:06.330Z] === RUN   basic.nvme/PortSSH
17:41:10 [2025-02-05T17:41:10.485Z] --- PASS: basic.nvme (26.70s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/DbusPerms (0.56s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/ServicesActive (0.14s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/ReadOnly (0.12s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/Useradd (0.28s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/MachineID (0.12s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/FCOSGrowpart (0.15s)
17:41:10 [2025-02-05T17:41:10.485Z]     --- PASS: basic.nvme/PortSSH (0.14s)
17:41:15 [2025-02-05T17:41:15.703Z] --- PASS: ext.config.networking.no-default-initramfs-net-propagation.bootif (43.97s)
17:41:25 [2025-02-05T17:41:25.618Z] --- PASS: coreos.auth.verify (37.90s)
17:41:37 [2025-02-05T17:41:37.754Z] === RUN   fcos.filesystem/writablefiles
17:41:37 [2025-02-05T17:41:37.754Z] === RUN   fcos.filesystem/writabledirs
17:41:37 [2025-02-05T17:41:37.754Z] === RUN   fcos.filesystem/stickydirs
17:41:37 [2025-02-05T17:41:37.754Z] === RUN   fcos.filesystem/denylist
17:41:41 [2025-02-05T17:41:41.008Z] --- PASS: fcos.filesystem (26.10s)
17:41:41 [2025-02-05T17:41:41.008Z]     --- PASS: fcos.filesystem/writablefiles (0.95s)
17:41:41 [2025-02-05T17:41:41.008Z]     --- PASS: fcos.filesystem/writabledirs (0.28s)
17:41:41 [2025-02-05T17:41:41.008Z]     --- PASS: fcos.filesystem/stickydirs (0.31s)
17:41:41 [2025-02-05T17:41:41.008Z]     --- PASS: fcos.filesystem/denylist (0.39s)
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/DbusPerms
17:41:47 [2025-02-05T17:41:47.532Z] --- PASS: ext.config.boot.grub2-install (42.24s)
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/ServicesActive
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/ReadOnly
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/Useradd
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/MachineID
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/FCOSGrowpart
17:41:47 [2025-02-05T17:41:47.532Z] === RUN   basic/PortSSH
17:41:51 [2025-02-05T17:41:51.697Z] --- PASS: basic (26.08s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/DbusPerms (0.38s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/ServicesActive (0.13s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/ReadOnly (0.12s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/Useradd (0.21s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/MachineID (0.12s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/FCOSGrowpart (0.15s)
17:41:51 [2025-02-05T17:41:51.697Z]     --- PASS: basic/PortSSH (0.12s)
17:42:23 [2025-02-05T17:42:23.683Z] === RUN   ostree.unlock/unlock
17:42:23 [2025-02-05T17:42:23.683Z] === RUN   ostree.unlock/install
17:42:23 [2025-02-05T17:42:23.683Z] === RUN   ostree.unlock/uninstall
17:42:23 [2025-02-05T17:42:23.683Z] === RUN   ostree.unlock/discard
17:42:31 [2025-02-05T17:42:31.756Z] --- PASS: ext.config.var-mount.luks (80.50s)
17:42:43 [2025-02-05T17:42:43.917Z] --- PASS: ostree.unlock (55.76s)
17:42:43 [2025-02-05T17:42:43.917Z]     --- PASS: ostree.unlock/unlock (0.60s)
17:42:43 [2025-02-05T17:42:43.917Z]     --- PASS: ostree.unlock/install (0.51s)
17:42:43 [2025-02-05T17:42:43.917Z]     --- PASS: ostree.unlock/uninstall (0.40s)
17:42:43 [2025-02-05T17:42:43.917Z]     --- PASS: ostree.unlock/discard (18.24s)
17:43:10 [2025-02-05T17:43:10.371Z] --- PASS: ext.config.clhm.ignition-warnings (37.60s)
17:43:11 [2025-02-05T17:43:11.727Z] --- PASS: ext.config.toolbox (80.49s)
17:43:21 [2025-02-05T17:43:21.639Z] --- PASS: ext.config.swap.zram-generator (37.58s)
17:43:36 [2025-02-05T17:43:36.459Z] --- PASS: podman.network-single (172.21s)
17:43:51 [2025-02-05T17:43:51.278Z] --- PASS: ext.config.networking.nmstate.policy (128.50s)
17:43:56 [2025-02-05T17:43:56.508Z] --- PASS: fcos.users.shells (36.61s)
17:44:04 [2025-02-05T17:44:04.561Z] --- PASS: ext.config.selinux.enforcing (55.51s)
17:44:17 [2025-02-05T17:44:17.067Z] --- PASS: multipath.day1 (65.47s)
17:44:35 [2025-02-05T17:44:35.075Z] --- PASS: ext.config.networking.ifname-karg.udev-rule-firstboot-propagation (60.08s)
17:44:44 [2025-02-05T17:44:44.985Z] --- PASS: ext.config.networking.mtu-on-bond-kargs (41.02s)
17:44:44 [2025-02-05T17:44:44.985Z] mke2fs 1.47.1 (20-May-2024)
17:44:54 [2025-02-05T17:44:54.908Z] --- PASS: ext.config.ignition.resource.remote (37.72s)
17:44:56 [2025-02-05T17:44:56.261Z] --- PASS: coreos.unique.boot.failure (11.42s)
17:44:58 [2025-02-05T17:44:58.759Z] --- PASS: ext.config.ntp.chrony.dhcp-propagation (61.83s)
17:45:02 [2025-02-05T17:45:02.006Z] --- PASS: multipath.day2 (72.18s)
17:45:20 [2025-02-05T17:45:20.325Z] --- PASS: ext.config.var-mount.scsi-id (44.11s)
17:45:38 [2025-02-05T17:45:38.341Z] --- PASS: ext.config.gshadow (39.31s)
17:45:38 [2025-02-05T17:45:38.341Z] --- PASS: ext.config.networking.force-persist-ip (41.99s)
17:45:38 [2025-02-05T17:45:38.341Z] --- PASS: ext.config.networking.hostname.fallback-hostname (38.69s)
17:45:43 [2025-02-05T17:45:43.561Z] --- PASS: ext.config.networking.prefer-ignition-networking (41.02s)
17:46:05 [2025-02-05T17:46:05.433Z] --- PASS: ext.config.networking.kargs-rd-net (29.56s)
17:46:07 [2025-02-05T17:46:07.320Z] --- PASS: fcos.network.listeners (24.45s)
17:46:13 [2025-02-05T17:46:13.852Z] --- PASS: coreos.ignition.v2.users (36.60s)
17:46:15 [2025-02-05T17:46:15.207Z] --- PASS: ext.config.firewall.iptables-legacy (38.52s)
17:46:15 [2025-02-05T17:46:15.765Z] --- PASS: coreos.misc.disk.varlibcontainers (57.22s)
17:46:15 [2025-02-05T17:46:15.765Z]         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'.
17:46:15 [2025-02-05T17:46:15.765Z]         cluster.go:151: Created symlink '/etc/systemd/system/local-fs.target.wants/var-lib-containers.mount' ��� '/etc/systemd/system/var-lib-containers.mount'.
17:46:47 [2025-02-05T17:46:47.765Z] --- PASS: ext.config.ignition.systemd-enable-units (38.86s)
17:46:52 [2025-02-05T17:46:52.997Z] --- PASS: ext.config.containers.quadlet (38.95s)
17:47:02 [2025-02-05T17:47:02.911Z] --- PASS: coreos.ignition.mount.partitions (54.78s)
17:48:39 [2025-02-05T17:48:39.275Z] --- PASS: kdump.crash.ssh (138.06s)
17:48:39 [2025-02-05T17:48:39.275Z]         cluster.go:151: Running as unit: run-rac8779c115c5466293d4a3c8108b96dc.service; invocation ID: a8f18ca0323942c08568ea42cc980f09
17:48:39 [2025-02-05T17:48:39.275Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-x86_64
17:48:39 [2025-02-05T17:48:39.278Z] [Pipeline] }
17:48:39 [2025-02-05T17:48:39.280Z] [Pipeline] // withEnv
17:48:39 [2025-02-05T17:48:39.296Z] [Pipeline] withEnv
17:48:39 [2025-02-05T17:48:39.297Z] [Pipeline] {
17:48:39 [2025-02-05T17:48:39.320Z] [Pipeline] sh
17:48:39 [2025-02-05T17:48:39.855Z] + set -xeuo pipefail
17:48:39 [2025-02-05T17:48:39.855Z] ++ umask
17:48:39 [2025-02-05T17:48:39.855Z] + '[' 0022 = 0000 ']'
17:48:39 [2025-02-05T17:48:39.855Z] + cd /home/jenkins/agent/workspace/test-override
17:48:39 [2025-02-05T17:48:39.855Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-reprovision-x86_64 --on-warn-failure-exit-77 --arch=x86_64 --tag=reprovision
17:48:39 [2025-02-05T17:48:39.855Z] kola -p qemu --build latest run --rerun --allow-rerun-success=tags=needs-internet --on-warn-failure-exit-77 --arch=x86_64 --tag=reprovision --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-reprovision-x86_64
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.autosave-xfs
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   coreos.boot-mirror
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   coreos.boot-mirror.luks
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.luks
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.swap-before-root
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.luks.autosave-xfs
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.luks.512e
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.rpm-ostree.kernel-replace
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.filesystem-only
17:48:40 [2025-02-05T17:48:40.110Z] === RUN   ext.config.root-reprovision.raid1
17:49:47 [2025-02-05T17:49:47.704Z] --- PASS: ext.config.root-reprovision.autosave-xfs (64.32s)
17:51:54 [2025-02-05T17:51:54.086Z] --- PASS: ext.config.root-reprovision.luks.512e (123.03s)
17:54:00 [2025-02-05T17:54:00.480Z] --- PASS: ext.config.root-reprovision.raid1 (127.33s)
17:55:21 [2025-02-05T17:55:21.814Z] --- PASS: ext.config.root-reprovision.filesystem-only (82.81s)
18:04:28 [2025-02-05T18:04:28.378Z] --- PASS: ext.config.rpm-ostree.kernel-replace (539.49s)
18:06:20 [2025-02-05T18:06:20.641Z] --- PASS: ext.config.root-reprovision.luks (112.44s)
18:08:11 [2025-02-05T18:08:11.982Z] --- PASS: ext.config.root-reprovision.luks.autosave-xfs (112.62s)
18:09:33 [2025-02-05T18:09:33.318Z] --- PASS: ext.config.root-reprovision.swap-before-root (82.21s)
18:11:54 [2025-02-05T18:11:54.683Z] === RUN   coreos.boot-mirror/sanity-check
18:11:54 [2025-02-05T18:11:54.683Z] === RUN   coreos.boot-mirror/detach-primary
18:12:50 [2025-02-05T18:12:50.797Z] === RUN   coreos.boot-mirror/verify-fallback
18:12:54 [2025-02-05T18:12:54.942Z] --- PASS: coreos.boot-mirror (210.24s)
18:12:54 [2025-02-05T18:12:54.942Z]     --- PASS: coreos.boot-mirror/sanity-check (2.21s)
18:12:54 [2025-02-05T18:12:54.942Z]     --- PASS: coreos.boot-mirror/detach-primary (54.07s)
18:12:54 [2025-02-05T18:12:54.942Z]     --- PASS: coreos.boot-mirror/verify-fallback (0.89s)
18:14:46 [2025-02-05T18:14:46.276Z] === RUN   coreos.boot-mirror.luks/sanity-check
18:15:12 [2025-02-05T18:15:12.747Z] === RUN   coreos.boot-mirror.luks/detach-primary
18:15:44 [2025-02-05T18:15:44.722Z] === RUN   coreos.boot-mirror.luks/verify-fallback
18:16:23 [2025-02-05T18:16:23.341Z] --- PASS: coreos.boot-mirror.luks (203.73s)
18:16:23 [2025-02-05T18:16:23.341Z]     --- PASS: coreos.boot-mirror.luks/sanity-check (1.70s)
18:16:23 [2025-02-05T18:16:23.341Z]     --- PASS: coreos.boot-mirror.luks/detach-primary (29.56s)
18:16:23 [2025-02-05T18:16:23.341Z]     --- PASS: coreos.boot-mirror.luks/verify-fallback (0.84s)
18:16:23 [2025-02-05T18:16:23.341Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-reprovision-x86_64
18:16:23 [2025-02-05T18:16:23.344Z] [Pipeline] }
18:16:23 [2025-02-05T18:16:23.357Z] [Pipeline] // withEnv
18:16:23 [2025-02-05T18:16:23.392Z] [Pipeline] }
18:16:23 [2025-02-05T18:16:23.396Z] [Pipeline] // parallel
18:16:23 [2025-02-05T18:16:23.435Z] [Pipeline] withEnv
18:16:23 [2025-02-05T18:16:23.435Z] [Pipeline] {
18:16:23 [2025-02-05T18:16:23.456Z] [Pipeline] sh
18:16:24 [2025-02-05T18:16:24.047Z] + set -xeuo pipefail
18:16:24 [2025-02-05T18:16:24.047Z] ++ umask
18:16:24 [2025-02-05T18:16:24.047Z] + '[' 0022 = 0000 ']'
18:16:24 [2025-02-05T18:16:24.047Z] + cd /home/jenkins/agent/workspace/test-override
18:16:24 [2025-02-05T18:16:24.047Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-upgrade-x86_64
18:16:24 [2025-02-05T18:16:24.050Z] [Pipeline] }
18:16:24 [2025-02-05T18:16:24.053Z] [Pipeline] // withEnv
18:16:24 [2025-02-05T18:16:24.068Z] [Pipeline] withEnv
18:16:24 [2025-02-05T18:16:24.068Z] [Pipeline] {
18:16:24 [2025-02-05T18:16:24.119Z] [Pipeline] sh
18:16:24 [2025-02-05T18:16:24.643Z] + set -xeuo pipefail
18:16:24 [2025-02-05T18:16:24.643Z] ++ umask
18:16:24 [2025-02-05T18:16:24.643Z] + '[' 0022 = 0000 ']'
18:16:24 [2025-02-05T18:16:24.643Z] + cd /home/jenkins/agent/workspace/test-override
18:16:24 [2025-02-05T18:16:24.643Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb -c --xz kola-upgrade-x86_64
18:16:24 [2025-02-05T18:16:24.899Z] [Pipeline] }
18:16:24 [2025-02-05T18:16:24.910Z] [Pipeline] // withEnv
18:16:24 [2025-02-05T18:16:24.966Z] [Pipeline] archiveArtifacts
18:16:24 [2025-02-05T18:16:24.969Z] Archiving artifacts
18:16:25 [2025-02-05T18:16:25.481Z] [Pipeline] withEnv
18:16:25 [2025-02-05T18:16:25.482Z] [Pipeline] {
18:16:25 [2025-02-05T18:16:25.486Z] [Pipeline] sh
18:16:26 [2025-02-05T18:16:26.014Z] + set -xeuo pipefail
18:16:26 [2025-02-05T18:16:26.014Z] ++ umask
18:16:26 [2025-02-05T18:16:26.014Z] + '[' 0022 = 0000 ']'
18:16:26 [2025-02-05T18:16:26.014Z] + cd /home/jenkins/agent/workspace/test-override
18:16:26 [2025-02-05T18:16:26.014Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-upgrade-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-upgrade-x86_64 --output -
18:16:26 [2025-02-05T18:16:26.016Z] [Pipeline] }
18:16:26 [2025-02-05T18:16:26.018Z] [Pipeline] // withEnv
18:16:26 [2025-02-05T18:16:26.073Z] [Pipeline] junit
18:16:26 [2025-02-05T18:16:26.075Z] Recording test results
18:16:26 [2025-02-05T18:16:26.589Z] None of the test reports contained any result
18:16:26 [2025-02-05T18:16:26.590Z] [Pipeline] withEnv
18:16:26 [2025-02-05T18:16:26.590Z] [Pipeline] {
18:16:26 [2025-02-05T18:16:26.593Z] [Pipeline] sh
18:16:27 [2025-02-05T18:16:27.120Z] + set -xeuo pipefail
18:16:27 [2025-02-05T18:16:27.120Z] ++ umask
18:16:27 [2025-02-05T18:16:27.120Z] + '[' 0022 = 0000 ']'
18:16:27 [2025-02-05T18:16:27.120Z] + cd /home/jenkins/agent/workspace/test-override
18:16:27 [2025-02-05T18:16:27.120Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-x86_64
18:16:27 [2025-02-05T18:16:27.122Z] [Pipeline] }
18:16:27 [2025-02-05T18:16:27.125Z] [Pipeline] // withEnv
18:16:27 [2025-02-05T18:16:27.163Z] [Pipeline] withEnv
18:16:27 [2025-02-05T18:16:27.163Z] [Pipeline] {
18:16:27 [2025-02-05T18:16:27.199Z] [Pipeline] sh
18:16:27 [2025-02-05T18:16:27.722Z] + set -xeuo pipefail
18:16:27 [2025-02-05T18:16:27.722Z] ++ umask
18:16:27 [2025-02-05T18:16:27.722Z] + '[' 0022 = 0000 ']'
18:16:27 [2025-02-05T18:16:27.722Z] + cd /home/jenkins/agent/workspace/test-override
18:16:27 [2025-02-05T18:16:27.722Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb -c --xz kola-x86_64
18:16:34 [2025-02-05T18:16:34.233Z] [Pipeline] }
18:16:34 [2025-02-05T18:16:34.236Z] [Pipeline] // withEnv
18:16:34 [2025-02-05T18:16:34.242Z] [Pipeline] archiveArtifacts
18:16:34 [2025-02-05T18:16:34.245Z] Archiving artifacts
18:16:36 [2025-02-05T18:16:36.832Z] [Pipeline] withEnv
18:16:36 [2025-02-05T18:16:36.833Z] [Pipeline] {
18:16:36 [2025-02-05T18:16:36.836Z] [Pipeline] sh
18:16:37 [2025-02-05T18:16:37.369Z] + set -xeuo pipefail
18:16:37 [2025-02-05T18:16:37.369Z] ++ umask
18:16:37 [2025-02-05T18:16:37.369Z] + '[' 0022 = 0000 ']'
18:16:37 [2025-02-05T18:16:37.369Z] + cd /home/jenkins/agent/workspace/test-override
18:16:37 [2025-02-05T18:16:37.369Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-x86_64 --output -
18:16:37 [2025-02-05T18:16:37.372Z] [Pipeline] }
18:16:37 [2025-02-05T18:16:37.375Z] [Pipeline] // withEnv
18:16:37 [2025-02-05T18:16:37.390Z] [Pipeline] junit
18:16:37 [2025-02-05T18:16:37.392Z] Recording test results
18:16:37 [2025-02-05T18:16:37.415Z] None of the test reports contained any result
18:16:37 [2025-02-05T18:16:37.417Z] [Pipeline] withEnv
18:16:37 [2025-02-05T18:16:37.417Z] [Pipeline] {
18:16:37 [2025-02-05T18:16:37.420Z] [Pipeline] sh
18:16:37 [2025-02-05T18:16:37.946Z] + set -xeuo pipefail
18:16:37 [2025-02-05T18:16:37.946Z] ++ umask
18:16:37 [2025-02-05T18:16:37.946Z] + '[' 0022 = 0000 ']'
18:16:37 [2025-02-05T18:16:37.946Z] + cd /home/jenkins/agent/workspace/test-override
18:16:37 [2025-02-05T18:16:37.946Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-reprovision-x86_64
18:16:37 [2025-02-05T18:16:37.948Z] [Pipeline] }
18:16:37 [2025-02-05T18:16:37.951Z] [Pipeline] // withEnv
18:16:38 [2025-02-05T18:16:38.027Z] [Pipeline] withEnv
18:16:38 [2025-02-05T18:16:38.027Z] [Pipeline] {
18:16:38 [2025-02-05T18:16:38.088Z] [Pipeline] sh
18:16:38 [2025-02-05T18:16:38.612Z] + set -xeuo pipefail
18:16:38 [2025-02-05T18:16:38.612Z] ++ umask
18:16:38 [2025-02-05T18:16:38.612Z] + '[' 0022 = 0000 ']'
18:16:38 [2025-02-05T18:16:38.612Z] + cd /home/jenkins/agent/workspace/test-override
18:16:38 [2025-02-05T18:16:38.612Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb -c --xz kola-reprovision-x86_64
18:16:42 [2025-02-05T18:16:42.837Z] [Pipeline] }
18:16:42 [2025-02-05T18:16:42.842Z] [Pipeline] // withEnv
18:16:42 [2025-02-05T18:16:42.860Z] [Pipeline] archiveArtifacts
18:16:42 [2025-02-05T18:16:42.861Z] Archiving artifacts
18:16:43 [2025-02-05T18:16:43.179Z] [Pipeline] withEnv
18:16:43 [2025-02-05T18:16:43.181Z] [Pipeline] {
18:16:43 [2025-02-05T18:16:43.184Z] [Pipeline] sh
18:16:45 [2025-02-05T18:16:45.954Z] + set -xeuo pipefail
18:16:45 [2025-02-05T18:16:45.954Z] ++ umask
18:16:45 [2025-02-05T18:16:45.954Z] + '[' 0022 = 0000 ']'
18:16:45 [2025-02-05T18:16:45.954Z] + cd /home/jenkins/agent/workspace/test-override
18:16:45 [2025-02-05T18:16:45.954Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-reprovision-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-jsdGb/kola-reprovision-x86_64 --output -
18:16:45 [2025-02-05T18:16:45.955Z] [Pipeline] }
18:16:45 [2025-02-05T18:16:45.958Z] [Pipeline] // withEnv
18:16:46 [2025-02-05T18:16:46.016Z] [Pipeline] junit
18:16:46 [2025-02-05T18:16:46.018Z] Recording test results
18:16:46 [2025-02-05T18:16:46.091Z] None of the test reports contained any result
18:16:46 [2025-02-05T18:16:46.093Z] [Pipeline] stage
18:16:46 [2025-02-05T18:16:46.094Z] [Pipeline] { (x86_64:Build Metal)
18:16:46 [2025-02-05T18:16:46.100Z] [Pipeline] withEnv
18:16:46 [2025-02-05T18:16:46.100Z] [Pipeline] {
18:16:46 [2025-02-05T18:16:46.103Z] [Pipeline] sh
18:16:46 [2025-02-05T18:16:46.625Z] + set -xeuo pipefail
18:16:46 [2025-02-05T18:16:46.625Z] ++ umask
18:16:46 [2025-02-05T18:16:46.625Z] + '[' 0022 = 0000 ']'
18:16:46 [2025-02-05T18:16:46.625Z] + cosa buildextend-metal
18:16:46 [2025-02-05T18:16:46.625Z] info: Missing CAP_SYS_ADMIN; using virt
18:16:47 [2025-02-05T18:16:47.182Z] Config commit: 8cea2e1fbe1d61a3a40906093457b59358420721
18:16:47 [2025-02-05T18:16:47.182Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
18:16:48 [2025-02-05T18:16:48.111Z] Will build metal
18:17:06 [2025-02-05T18:17:06.112Z] ++ arch
18:17:06 [2025-02-05T18:17:06.112Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-41.20250205.dev.0"' -D 'ostree_ref="fedora/x86_64/coreos/testing-devel"' -D 'ostree_repo="file:///home/jenkins/agent/workspace/test-override/tmp/repo"' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-41.20250205.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2651 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2138 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-i8GT.json
18:17:10 [2025-02-05T18:17:10.254Z] ostree init --mode=archive --repo=/tmp/tmpkh8u_4pk
18:17:10 [2025-02-05T18:17:10.507Z] ostree remote add tmpremote file:///home/jenkins/agent/workspace/test-override/tmp/repo --no-gpg-verify --repo=/tmp/tmpkh8u_4pk
18:17:10 [2025-02-05T18:17:10.507Z] ostree pull --commit-metadata-only --mirror tmpremote fedora/x86_64/coreos/testing-devel --repo=/tmp/tmpkh8u_4pk
18:17:10 [2025-02-05T18:17:10.507Z] + set +x
18:17:10 [2025-02-05T18:17:10.507Z] + osbuild --out cache/osbuild/out --store cache/osbuild/store --cache-max-size 20GiB --checkpoint deployed-tree --checkpoint tree --checkpoint raw-image --checkpoint metal --checkpoint metal4k --export=metal /tmp/osbuild-i8GT.json
18:17:10 [2025-02-05T18:17:10.507Z] 
18:17:10 [2025-02-05T18:17:10.507Z] Filesystem      Size  Used Avail Use% Mounted on
18:17:10 [2025-02-05T18:17:10.507Z] /dev/vdb1        30G  9.1G   21G  31% /home/jenkins/agent/workspace/test-override/cache
18:17:10 [2025-02-05T18:17:10.508Z] 
18:17:10 [2025-02-05T18:17:10.760Z] starting /tmp/osbuild-i8GT.jsonPipeline source org.osbuild.curl: a6d68db45fb1645987d49f866eff49b3ed21522d803c3a9fbb22c2f779942437
18:17:10 [2025-02-05T18:17:10.760Z] Build
18:17:10 [2025-02-05T18:17:10.760Z]   root: <host>
18:17:11 [2025-02-05T18:17:11.014Z] 
18:17:11 [2025-02-05T18:17:11.014Z] ���  Duration: 1738779429s
18:17:11 [2025-02-05T18:17:11.014Z] Pipeline source org.osbuild.ostree: 08bb42da88bf9a7f5c11603d40080a771d6f8c3f04c94f0852c72482fd97304c
18:17:11 [2025-02-05T18:17:11.014Z] Build
18:17:11 [2025-02-05T18:17:11.014Z]   root: <host>
18:17:11 [2025-02-05T18:17:11.014Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree init --mode=archive --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
18:17:11 [2025-02-05T18:17:11.014Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree config set repo.locking true --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
18:17:11 [2025-02-05T18:17:11.267Z] 
18:17:11 [2025-02-05T18:17:11.267Z] ���  Duration: 1738779430s
18:17:11 [2025-02-05T18:17:11.267Z] Pipeline raw-metal-image: af98ac75ef7715ebe418730a8ec325e96a4f246fb02b46f9679e80ca04c6532e
18:17:11 [2025-02-05T18:17:11.267Z] Build
18:17:11 [2025-02-05T18:17:11.267Z]   root: <host>
18:17:11 [2025-02-05T18:17:11.267Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:17:11 [2025-02-05T18:17:11.519Z] org.osbuild.copy: 2929e477d855a1de25b245d1d24e632719efb78792b66abf82a621fbfb926daa {
18:17:11 [2025-02-05T18:17:11.519Z]   "paths": [
18:17:11 [2025-02-05T18:17:11.519Z]     {
18:17:11 [2025-02-05T18:17:11.519Z]       "from": "input://tree/disk.img",
18:17:11 [2025-02-05T18:17:11.519Z]       "to": "tree:///disk.img"
18:17:11 [2025-02-05T18:17:11.519Z]     }
18:17:11 [2025-02-05T18:17:11.519Z]   ]
18:17:11 [2025-02-05T18:17:11.519Z] }
18:17:11 [2025-02-05T18:17:11.773Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:11 [2025-02-05T18:17:11.773Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
18:17:12 [2025-02-05T18:17:12.026Z] 
18:17:12 [2025-02-05T18:17:12.026Z] ���  Duration: 0s
18:17:12 [2025-02-05T18:17:12.026Z] org.osbuild.coreos.platform: af98ac75ef7715ebe418730a8ec325e96a4f246fb02b46f9679e80ca04c6532e {
18:17:12 [2025-02-05T18:17:12.026Z]   "platform": "metal"
18:17:12 [2025-02-05T18:17:12.026Z] }
18:17:12 [2025-02-05T18:17:12.289Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:17:12 [2025-02-05T18:17:12.289Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/
18:17:12 [2025-02-05T18:17:12.845Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0'
18:17:12 [2025-02-05T18:17:12.845Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/boot
18:17:13 [2025-02-05T18:17:13.098Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:13 [2025-02-05T18:17:13.098Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/boot unmounted
18:17:13 [2025-02-05T18:17:13.098Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts
18:17:13 [2025-02-05T18:17:13.098Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/boot unmounted
18:17:13 [2025-02-05T18:17:13.098Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/var unmounted
18:17:13 [2025-02-05T18:17:13.098Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/sysroot unmounted
18:17:13 [2025-02-05T18:17:13.098Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts unmounted
18:17:13 [2025-02-05T18:17:13.098Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts unmounted
18:17:13 [2025-02-05T18:17:13.351Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts unmounted
18:17:13 [2025-02-05T18:17:13.351Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-odynfjnx/mounts/
18:17:13 [2025-02-05T18:17:13.351Z] 
18:17:13 [2025-02-05T18:17:13.351Z] ���  Duration: 1s
18:17:13 [2025-02-05T18:17:13.351Z] Pipeline metal: 015c927cdcbe6cf7739c025c01d99aaa77b1c1432698bf104d2c72489fb9f98e
18:17:13 [2025-02-05T18:17:13.351Z] Build
18:17:13 [2025-02-05T18:17:13.351Z]   root: <host>
18:17:13 [2025-02-05T18:17:13.351Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:17:13 [2025-02-05T18:17:13.351Z] org.osbuild.copy: 015c927cdcbe6cf7739c025c01d99aaa77b1c1432698bf104d2c72489fb9f98e {
18:17:13 [2025-02-05T18:17:13.351Z]   "paths": [
18:17:13 [2025-02-05T18:17:13.351Z]     {
18:17:13 [2025-02-05T18:17:13.351Z]       "from": "input://tree/disk.img",
18:17:13 [2025-02-05T18:17:13.351Z]       "to": "tree:///fedora-coreos-41.20250205.dev.0-metal.x86_64.raw"
18:17:13 [2025-02-05T18:17:13.351Z]     }
18:17:13 [2025-02-05T18:17:13.351Z]   ]
18:17:13 [2025-02-05T18:17:13.351Z] }
18:17:13 [2025-02-05T18:17:13.604Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:13 [2025-02-05T18:17:13.604Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw'
18:17:13 [2025-02-05T18:17:13.856Z] 
18:17:13 [2025-02-05T18:17:13.856Z] ���  Duration: 0s
18:17:13 [2025-02-05T18:17:13.856Z] manifest /tmp/osbuild-i8GT.json finished successfully
18:17:13 [2025-02-05T18:17:13.856Z] oci-archive:	d195cd483555dfd59fb8536404a2065cf6953bb3cbee34dc6d4d253cda2efd61
18:17:13 [2025-02-05T18:17:13.856Z] deployed-tree:	844a0336c1b1da16530b80cfffba1f735d92812084777a4f8a57041a2a1833d9
18:17:13 [2025-02-05T18:17:13.856Z] tree:     	92f5cdc466df39e715833b7a647ce7c798dc3b9c6131e2d149187035bf56bb3e
18:17:13 [2025-02-05T18:17:13.856Z] raw-image:	a0f124b657a22166713b33c6b3f0bec79df5924c1f473f2558ea8e8815fb8868
18:17:13 [2025-02-05T18:17:13.856Z] raw-4k-image:	b7ef27450a4c62de9de67c1afab7749676d0ad3239b4b6fee23ed2ac5dbcdabf
18:17:13 [2025-02-05T18:17:13.856Z] raw-applehv-image:	300416bded216cf7cba22c800a9a18c7576f0ea499c40c2bbd7a1844f1bfb070
18:17:13 [2025-02-05T18:17:13.856Z] applehv:  	640fcb42e1107936da81a098c1746ca5aa408a65361527d38414552a355f2d88
18:17:13 [2025-02-05T18:17:13.856Z] raw-gcp-image:	e2bb527d0656a5be120e8864bf1e7acf4fe25130ae459bf7f572debd63d6bce0
18:17:13 [2025-02-05T18:17:13.856Z] raw-gcp-image-tar:	e75d775d4acdf73ba5c9fab2a38e954f4ac5f3fa93ac60ebd3c7db2ad642fddd
18:17:13 [2025-02-05T18:17:13.856Z] gcp:      	92d055e703ad6a2e4259fde91478a74f8cfbeeadb4800f7e4a8b7f37b1a55a77
18:17:13 [2025-02-05T18:17:13.856Z] raw-hyperv-image:	6833d84f97002f02c5d9b223ac9865b52bf7b43a43c2bd3a8022fa1a56de0472
18:17:13 [2025-02-05T18:17:13.856Z] hyperv:   	7d7ee577e7b00138cc47f36c01af049324c28081435ec17640fbf9f3032a0676
18:17:13 [2025-02-05T18:17:13.856Z] raw-metal-image:	af98ac75ef7715ebe418730a8ec325e96a4f246fb02b46f9679e80ca04c6532e
18:17:13 [2025-02-05T18:17:13.856Z] metal:    	015c927cdcbe6cf7739c025c01d99aaa77b1c1432698bf104d2c72489fb9f98e
18:17:13 [2025-02-05T18:17:13.856Z] raw-metal4k-image:	c4dfb54f05c080ca68dda2c18be130f8ffb2fd347265ce94862df15480da2234
18:17:13 [2025-02-05T18:17:13.856Z] metal4k:  	34cfea228e25e215b77d69af32db92c56249f3f16b582ad9d860fe14b1f02c7e
18:17:13 [2025-02-05T18:17:13.856Z] raw-qemu-image:	9eb84f27db72b66e31ad3c1eeca7f66da559b5d61ef0067c4bfeed18657cce26
18:17:13 [2025-02-05T18:17:13.856Z] qemu:     	86fa682763f4c4cea67872d35fe593130e3b1414167bcf82fa9364fe974e7d79
18:17:13 [2025-02-05T18:17:13.856Z] live:     	de4d98bf855d54156884ec599a095dc286e7962e99a1958ac59be234fa8e5032
18:17:13 [2025-02-05T18:17:13.856Z] + set +x
18:17:21 [2025-02-05T18:17:21.909Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.nMwUQjzzEU/metal/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw': Operation not permitted
18:17:21 [2025-02-05T18:17:21.909Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.nMwUQjzzEU/metal': Operation not permitted
18:17:26 [2025-02-05T18:17:26.048Z] /home/jenkins/agent/workspace/test-override/builds/41.20250205.dev.0/x86_64/meta.json wrote with version stamp 1738779445866247854
18:17:26 [2025-02-05T18:17:26.048Z] Successfully generated: fedora-coreos-41.20250205.dev.0-metal.x86_64.raw
18:17:26 [2025-02-05T18:17:26.050Z] [Pipeline] }
18:17:26 [2025-02-05T18:17:26.053Z] [Pipeline] // withEnv
18:17:26 [2025-02-05T18:17:26.058Z] [Pipeline] withEnv
18:17:26 [2025-02-05T18:17:26.058Z] [Pipeline] {
18:17:26 [2025-02-05T18:17:26.070Z] [Pipeline] sh
18:17:26 [2025-02-05T18:17:26.594Z] + set -xeuo pipefail
18:17:26 [2025-02-05T18:17:26.594Z] ++ umask
18:17:26 [2025-02-05T18:17:26.594Z] + '[' 0022 = 0000 ']'
18:17:26 [2025-02-05T18:17:26.594Z] + cosa buildextend-metal4k
18:17:26 [2025-02-05T18:17:26.594Z] info: Missing CAP_SYS_ADMIN; using virt
18:17:26 [2025-02-05T18:17:26.848Z] Config commit: 8cea2e1fbe1d61a3a40906093457b59358420721
18:17:26 [2025-02-05T18:17:26.852Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
18:17:27 [2025-02-05T18:17:27.769Z] Will build metal4k
18:17:49 [2025-02-05T18:17:49.612Z] ++ arch
18:17:49 [2025-02-05T18:17:49.613Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-41.20250205.dev.0"' -D 'ostree_ref="fedora/x86_64/coreos/testing-devel"' -D 'ostree_repo="file:///home/jenkins/agent/workspace/test-override/tmp/repo"' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-41.20250205.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2651 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2138 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-B2pC.json
18:17:49 [2025-02-05T18:17:49.613Z] ostree init --mode=archive --repo=/tmp/tmp5tddf5p5
18:17:49 [2025-02-05T18:17:49.613Z] ostree remote add tmpremote file:///home/jenkins/agent/workspace/test-override/tmp/repo --no-gpg-verify --repo=/tmp/tmp5tddf5p5
18:17:49 [2025-02-05T18:17:49.613Z] ostree pull --commit-metadata-only --mirror tmpremote fedora/x86_64/coreos/testing-devel --repo=/tmp/tmp5tddf5p5
18:17:49 [2025-02-05T18:17:49.613Z] + set +x
18:17:49 [2025-02-05T18:17:49.613Z] + osbuild --out cache/osbuild/out --store cache/osbuild/store --cache-max-size 20GiB --checkpoint deployed-tree --checkpoint tree --checkpoint raw-image --checkpoint metal --checkpoint metal4k --export=metal4k /tmp/osbuild-B2pC.json
18:17:49 [2025-02-05T18:17:49.613Z] 
18:17:49 [2025-02-05T18:17:49.613Z] Filesystem      Size  Used Avail Use% Mounted on
18:17:49 [2025-02-05T18:17:49.613Z] /dev/vdb1        30G  9.1G   21G  31% /home/jenkins/agent/workspace/test-override/cache
18:17:49 [2025-02-05T18:17:49.613Z] 
18:17:49 [2025-02-05T18:17:49.866Z] starting /tmp/osbuild-B2pC.jsonPipeline source org.osbuild.curl: a6d68db45fb1645987d49f866eff49b3ed21522d803c3a9fbb22c2f779942437
18:17:50 [2025-02-05T18:17:50.119Z] Build
18:17:50 [2025-02-05T18:17:50.119Z]   root: <host>
18:17:50 [2025-02-05T18:17:50.119Z] 
18:17:50 [2025-02-05T18:17:50.119Z] ���  Duration: 1738779469s
18:17:50 [2025-02-05T18:17:50.119Z] Pipeline source org.osbuild.ostree: 08bb42da88bf9a7f5c11603d40080a771d6f8c3f04c94f0852c72482fd97304c
18:17:50 [2025-02-05T18:17:50.119Z] Build
18:17:50 [2025-02-05T18:17:50.119Z]   root: <host>
18:17:50 [2025-02-05T18:17:50.119Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree init --mode=archive --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
18:17:50 [2025-02-05T18:17:50.119Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree config set repo.locking true --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
18:17:50 [2025-02-05T18:17:50.371Z] 
18:17:50 [2025-02-05T18:17:50.371Z] ���  Duration: 1738779469s
18:17:50 [2025-02-05T18:17:50.371Z] Pipeline raw-4k-image: b7ef27450a4c62de9de67c1afab7749676d0ad3239b4b6fee23ed2ac5dbcdabf
18:17:50 [2025-02-05T18:17:50.371Z] Build
18:17:50 [2025-02-05T18:17:50.371Z]   root: <host>
18:17:50 [2025-02-05T18:17:50.371Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:17:50 [2025-02-05T18:17:50.371Z] org.osbuild.truncate: bea24f5e70641a79b806a056cb0e128e84a0406a6d6508d0cf0aa6395bfe6aea {
18:17:50 [2025-02-05T18:17:50.371Z]   "filename": "disk.img",
18:17:50 [2025-02-05T18:17:50.371Z]   "size": "2779774976"
18:17:50 [2025-02-05T18:17:50.371Z] }
18:17:50 [2025-02-05T18:17:50.624Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:50 [2025-02-05T18:17:50.624Z] 
18:17:50 [2025-02-05T18:17:50.624Z] ���  Duration: 0s
18:17:50 [2025-02-05T18:17:50.624Z] org.osbuild.sfdisk: 77ee5604435ebc0f158ac7dcd88765327ceb1821c103ff7f51c7c0f7316539af {
18:17:50 [2025-02-05T18:17:50.624Z]   "uuid": "00000000-0000-4000-a000-000000000001",
18:17:50 [2025-02-05T18:17:50.624Z]   "label": "gpt",
18:17:50 [2025-02-05T18:17:50.624Z]   "partitions": [
18:17:50 [2025-02-05T18:17:50.624Z]     {
18:17:50 [2025-02-05T18:17:50.624Z]       "start": 256,
18:17:50 [2025-02-05T18:17:50.624Z]       "partnum": 1,
18:17:50 [2025-02-05T18:17:50.624Z]       "size": 256,
18:17:50 [2025-02-05T18:17:50.624Z]       "type": "21686148-6449-6E6F-744E-656564454649",
18:17:50 [2025-02-05T18:17:50.624Z]       "bootable": true,
18:17:50 [2025-02-05T18:17:50.624Z]       "name": "BIOS-BOOT"
18:17:50 [2025-02-05T18:17:50.624Z]     },
18:17:50 [2025-02-05T18:17:50.624Z]     {
18:17:50 [2025-02-05T18:17:50.624Z]       "start": 512,
18:17:50 [2025-02-05T18:17:50.624Z]       "partnum": 2,
18:17:50 [2025-02-05T18:17:50.624Z]       "size": 32512,
18:17:50 [2025-02-05T18:17:50.624Z]       "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
18:17:50 [2025-02-05T18:17:50.624Z]       "name": "EFI-SYSTEM"
18:17:50 [2025-02-05T18:17:50.624Z]     },
18:17:50 [2025-02-05T18:17:50.624Z]     {
18:17:50 [2025-02-05T18:17:50.624Z]       "start": 33024,
18:17:50 [2025-02-05T18:17:50.624Z]       "partnum": 3,
18:17:50 [2025-02-05T18:17:50.624Z]       "size": 98304,
18:17:50 [2025-02-05T18:17:50.624Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:17:50 [2025-02-05T18:17:50.624Z]       "name": "boot"
18:17:50 [2025-02-05T18:17:50.624Z]     },
18:17:50 [2025-02-05T18:17:50.624Z]     {
18:17:50 [2025-02-05T18:17:50.624Z]       "start": 131328,
18:17:50 [2025-02-05T18:17:50.624Z]       "partnum": 4,
18:17:50 [2025-02-05T18:17:50.624Z]       "size": 547072,
18:17:50 [2025-02-05T18:17:50.624Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:17:50 [2025-02-05T18:17:50.624Z]       "name": "root"
18:17:50 [2025-02-05T18:17:50.624Z]     }
18:17:50 [2025-02-05T18:17:50.624Z]   ]
18:17:50 [2025-02-05T18:17:50.624Z] }
18:17:50 [2025-02-05T18:17:50.877Z] device/device (org.osbuild.loopback): loop0 acquired (locked: False)
18:17:50 [2025-02-05T18:17:50.877Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:51 [2025-02-05T18:17:51.130Z] label: gpt
18:17:51 [2025-02-05T18:17:51.130Z] label-id: 00000000-0000-4000-a000-000000000001
18:17:51 [2025-02-05T18:17:51.130Z] /dev/loop0p1: start="256", size="256", type="21686148-6449-6E6F-744E-656564454649", name="BIOS-BOOT", bootable
18:17:51 [2025-02-05T18:17:51.130Z] /dev/loop0p2: start="512", size="32512", type="C12A7328-F81F-11D2-BA4B-00A0C93EC93B", name="EFI-SYSTEM"
18:17:51 [2025-02-05T18:17:51.130Z] /dev/loop0p3: start="33024", size="98304", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="boot"
18:17:51 [2025-02-05T18:17:51.130Z] /dev/loop0p4: start="131328", size="547072", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="root"
18:17:52 [2025-02-05T18:17:52.047Z] {
18:17:52 [2025-02-05T18:17:52.047Z]    "partitiontable": {
18:17:52 [2025-02-05T18:17:52.047Z]       "label": "gpt",
18:17:52 [2025-02-05T18:17:52.047Z]       "id": "00000000-0000-4000-A000-000000000001",
18:17:52 [2025-02-05T18:17:52.047Z]       "device": "/dev/loop0",
18:17:52 [2025-02-05T18:17:52.047Z]       "unit": "sectors",
18:17:52 [2025-02-05T18:17:52.047Z]       "firstlba": 256,
18:17:52 [2025-02-05T18:17:52.047Z]       "lastlba": 678650,
18:17:52 [2025-02-05T18:17:52.047Z]       "sectorsize": 4096,
18:17:52 [2025-02-05T18:17:52.047Z]       "partitions": [
18:17:52 [2025-02-05T18:17:52.047Z]          {
18:17:52 [2025-02-05T18:17:52.047Z]             "node": "/dev/loop0p1",
18:17:52 [2025-02-05T18:17:52.047Z]             "start": 256,
18:17:52 [2025-02-05T18:17:52.047Z]             "size": 256,
18:17:52 [2025-02-05T18:17:52.047Z]             "type": "21686148-6449-6E6F-744E-656564454649",
18:17:52 [2025-02-05T18:17:52.047Z]             "uuid": "AB9C5FEF-16A2-4AA1-B984-178343849639",
18:17:52 [2025-02-05T18:17:52.047Z]             "name": "BIOS-BOOT"
18:17:52 [2025-02-05T18:17:52.047Z]          },{
18:17:52 [2025-02-05T18:17:52.047Z]             "node": "/dev/loop0p2",
18:17:52 [2025-02-05T18:17:52.047Z]             "start": 512,
18:17:52 [2025-02-05T18:17:52.047Z]             "size": 32512,
18:17:52 [2025-02-05T18:17:52.047Z]             "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
18:17:52 [2025-02-05T18:17:52.047Z]             "uuid": "DBFBCCFD-3349-4B2E-9AB6-2B1FAEA3D600",
18:17:52 [2025-02-05T18:17:52.047Z]             "name": "EFI-SYSTEM"
18:17:52 [2025-02-05T18:17:52.047Z]          },{
18:17:52 [2025-02-05T18:17:52.047Z]             "node": "/dev/loop0p3",
18:17:52 [2025-02-05T18:17:52.047Z]             "start": 33024,
18:17:52 [2025-02-05T18:17:52.047Z]             "size": 98304,
18:17:52 [2025-02-05T18:17:52.047Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:17:52 [2025-02-05T18:17:52.047Z]             "uuid": "ACD9B7A9-E9A6-46C1-9AD2-4E537F2AD3A3",
18:17:52 [2025-02-05T18:17:52.047Z]             "name": "boot"
18:17:52 [2025-02-05T18:17:52.047Z]          },{
18:17:52 [2025-02-05T18:17:52.047Z]             "node": "/dev/loop0p4",
18:17:52 [2025-02-05T18:17:52.047Z]             "start": 131328,
18:17:52 [2025-02-05T18:17:52.047Z]             "size": 547072,
18:17:52 [2025-02-05T18:17:52.047Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
18:17:52 [2025-02-05T18:17:52.047Z]             "uuid": "733A73FD-C22F-4E37-8B7D-FD40EC42F429",
18:17:52 [2025-02-05T18:17:52.047Z]             "name": "root"
18:17:52 [2025-02-05T18:17:52.047Z]          }
18:17:52 [2025-02-05T18:17:52.047Z]       ]
18:17:52 [2025-02-05T18:17:52.047Z]    }
18:17:52 [2025-02-05T18:17:52.047Z] }
18:17:52 [2025-02-05T18:17:52.047Z] 
18:17:52 [2025-02-05T18:17:52.047Z] ���  Duration: 1s
18:17:52 [2025-02-05T18:17:52.047Z] org.osbuild.mkfs.fat: 156887d1e8e17cfe12ceb3dd8023f46156ba839c06b71330fdf0168a4060ff3e {
18:17:52 [2025-02-05T18:17:52.047Z]   "label": "EFI-SYSTEM",
18:17:52 [2025-02-05T18:17:52.047Z]   "volid": "7B7795E7"
18:17:52 [2025-02-05T18:17:52.047Z] }
18:17:52 [2025-02-05T18:17:52.047Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
18:17:52 [2025-02-05T18:17:52.047Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:52 [2025-02-05T18:17:52.603Z] mkfs.fat 4.2 (2021-01-31)
18:17:52 [2025-02-05T18:17:52.603Z] 
18:17:52 [2025-02-05T18:17:52.603Z] ���  Duration: 0s
18:17:52 [2025-02-05T18:17:52.603Z] org.osbuild.mkfs.ext4: a4158d48b6a130f0546e6b87af4354a87883797f528d6fdd1cd7f6eff253a967 {
18:17:52 [2025-02-05T18:17:52.603Z]   "uuid": "96d15588-3596-4b3c-adca-a2ff7279ea63",
18:17:52 [2025-02-05T18:17:52.603Z]   "label": "boot",
18:17:52 [2025-02-05T18:17:52.603Z]   "metadata_csum_seed": true
18:17:52 [2025-02-05T18:17:52.603Z] }
18:17:52 [2025-02-05T18:17:52.603Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
18:17:52 [2025-02-05T18:17:52.855Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:52 [2025-02-05T18:17:52.855Z] mke2fs 1.47.1 (20-May-2024)
18:17:52 [2025-02-05T18:17:52.855Z] Discarding device blocks:     0/98304           done                            
18:17:52 [2025-02-05T18:17:52.855Z] Creating filesystem with 98304 4k blocks and 98304 inodes
18:17:52 [2025-02-05T18:17:52.855Z] Filesystem UUID: 96d15588-3596-4b3c-adca-a2ff7279ea63
18:17:52 [2025-02-05T18:17:52.855Z] Superblock backups stored on blocks: 
18:17:52 [2025-02-05T18:17:52.855Z] 	32768
18:17:52 [2025-02-05T18:17:52.855Z] 
18:17:52 [2025-02-05T18:17:52.855Z] Allocating group tables: 0/3   done                            
18:17:52 [2025-02-05T18:17:52.855Z] Writing inode tables: 0/3   done                            
18:17:52 [2025-02-05T18:17:52.855Z] Creating journal (4096 blocks): done
18:17:53 [2025-02-05T18:17:53.107Z] Writing superblocks and filesystem accounting information: 0/3   done
18:17:53 [2025-02-05T18:17:53.107Z] 
18:17:53 [2025-02-05T18:17:53.107Z] 
18:17:53 [2025-02-05T18:17:53.107Z] ���  Duration: 0s
18:17:53 [2025-02-05T18:17:53.107Z] org.osbuild.mkfs.xfs: 8455639c5775e7c29abe7a1ab4734cfa586c5298f9ca8b5a0f47587c94842bde {
18:17:53 [2025-02-05T18:17:53.107Z]   "uuid": "910678ff-f77e-4a7d-8d53-86f2ac47a823",
18:17:53 [2025-02-05T18:17:53.107Z]   "label": "root"
18:17:53 [2025-02-05T18:17:53.107Z] }
18:17:53 [2025-02-05T18:17:53.359Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
18:17:53 [2025-02-05T18:17:53.359Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:53 [2025-02-05T18:17:53.613Z] meta-data=/dev/loop0             isize=512    agcount=4, agsize=136768 blks
18:17:53 [2025-02-05T18:17:53.613Z]          =                       sectsz=4096  attr=2, projid32bit=1
18:17:53 [2025-02-05T18:17:53.613Z]          =                       crc=1        finobt=1, sparse=1, rmapbt=1
18:17:53 [2025-02-05T18:17:53.613Z]          =                       reflink=1    bigtime=1 inobtcount=1 nrext64=1
18:17:53 [2025-02-05T18:17:53.613Z] data     =                       bsize=4096   blocks=547072, imaxpct=25
18:17:53 [2025-02-05T18:17:53.613Z]          =                       sunit=0      swidth=0 blks
18:17:53 [2025-02-05T18:17:53.613Z] naming   =version 2              bsize=4096   ascii-ci=0, ftype=1
18:17:53 [2025-02-05T18:17:53.613Z] log      =internal log           bsize=4096   blocks=16384, version=2
18:17:53 [2025-02-05T18:17:53.613Z]          =                       sectsz=4096  sunit=1 blks, lazy-count=1
18:17:53 [2025-02-05T18:17:53.613Z] realtime =none                   extsz=4096   blocks=0, rtextents=0
18:17:53 [2025-02-05T18:17:53.613Z] Discarding blocks...Done.
18:17:53 [2025-02-05T18:17:53.866Z] 
18:17:53 [2025-02-05T18:17:53.866Z] ���  Duration: 0s
18:17:53 [2025-02-05T18:17:53.866Z] org.osbuild.mkdir: d6fe2eb0c6a5cb33497fb5adadb3bc3fd1b959320b3f357c86164cc295400a70 {
18:17:53 [2025-02-05T18:17:53.866Z]   "paths": [
18:17:53 [2025-02-05T18:17:53.866Z]     {
18:17:53 [2025-02-05T18:17:53.866Z]       "path": "mount://root/boot",
18:17:53 [2025-02-05T18:17:53.866Z]       "mode": 493
18:17:53 [2025-02-05T18:17:53.866Z]     },
18:17:53 [2025-02-05T18:17:53.866Z]     {
18:17:53 [2025-02-05T18:17:53.866Z]       "path": "mount://boot/efi",
18:17:53 [2025-02-05T18:17:53.866Z]       "mode": 493
18:17:53 [2025-02-05T18:17:53.866Z]     }
18:17:53 [2025-02-05T18:17:53.866Z]   ]
18:17:53 [2025-02-05T18:17:53.866Z] }
18:17:53 [2025-02-05T18:17:53.866Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:17:53 [2025-02-05T18:17:53.866Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-6qf3r2h1/mounts/root-mount-point
18:17:54 [2025-02-05T18:17:54.118Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-6qf3r2h1/mounts/boot-mount-point
18:17:54 [2025-02-05T18:17:54.371Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:55 [2025-02-05T18:17:55.724Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-6qf3r2h1/mounts/boot-mount-point unmounted
18:17:55 [2025-02-05T18:17:55.724Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-6qf3r2h1/mounts/root-mount-point unmounted
18:17:55 [2025-02-05T18:17:55.977Z] 
18:17:55 [2025-02-05T18:17:55.977Z] ���  Duration: 2s
18:17:55 [2025-02-05T18:17:55.977Z] org.osbuild.selinux: aa8e4951c8ec47ee44ee2c6ad21dc71b84372af7ebb3a56d26927b296aaecf2f {
18:17:55 [2025-02-05T18:17:55.977Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
18:17:55 [2025-02-05T18:17:55.977Z]   "target": "mount://root/"
18:17:55 [2025-02-05T18:17:55.977Z] }
18:17:56 [2025-02-05T18:17:56.230Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:17:56 [2025-02-05T18:17:56.230Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-6fwz61k1/mounts/
18:17:56 [2025-02-05T18:17:56.482Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:17:59 [2025-02-05T18:17:59.726Z] 
18:17:59 [2025-02-05T18:17:59.726Z] Filesystem      Size  Used Avail Use% Mounted on
18:17:59 [2025-02-05T18:17:59.726Z] /dev/vdb1        30G  9.2G   21G  31% /home/jenkins/agent/workspace/test-override/cache
18:17:59 [2025-02-05T18:17:59.726Z] 
18:17:59 [2025-02-05T18:17:59.726Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-6fwz61k1/mounts/ unmounted
18:17:59 [2025-02-05T18:17:59.978Z] 
18:17:59 [2025-02-05T18:17:59.978Z] ���  Duration: 3s
18:17:59 [2025-02-05T18:17:59.978Z] org.osbuild.selinux: 0bb2ec1238492fd727a51c2d35b595b192d50442c044294104071965219fd0be {
18:17:59 [2025-02-05T18:17:59.978Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
18:17:59 [2025-02-05T18:17:59.978Z]   "target": "mount://root/boot/"
18:17:59 [2025-02-05T18:17:59.978Z] }
18:17:59 [2025-02-05T18:17:59.978Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:18:00 [2025-02-05T18:18:00.230Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-81n3827s/mounts/
18:18:00 [2025-02-05T18:18:00.230Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-81n3827s/mounts/boot
18:18:00 [2025-02-05T18:18:00.483Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:00 [2025-02-05T18:18:00.736Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-81n3827s/mounts/boot unmounted
18:18:00 [2025-02-05T18:18:00.736Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-81n3827s/mounts/ unmounted
18:18:00 [2025-02-05T18:18:00.736Z] 
18:18:00 [2025-02-05T18:18:00.736Z] ���  Duration: 0s
18:18:00 [2025-02-05T18:18:00.736Z] org.osbuild.copy: c4cbc111e9dbc1493ffd9786f5085bd218023f8d01172a52626fbc4678a09e57 {
18:18:00 [2025-02-05T18:18:00.736Z]   "paths": [
18:18:00 [2025-02-05T18:18:00.736Z]     {
18:18:00 [2025-02-05T18:18:00.736Z]       "from": "input://tree/",
18:18:00 [2025-02-05T18:18:00.736Z]       "to": "mount://root/"
18:18:00 [2025-02-05T18:18:00.736Z]     }
18:18:00 [2025-02-05T18:18:00.736Z]   ]
18:18:00 [2025-02-05T18:18:00.736Z] }
18:18:00 [2025-02-05T18:18:00.989Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:18:00 [2025-02-05T18:18:00.989Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0xo9rlul/mounts/
18:18:00 [2025-02-05T18:18:00.989Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0xo9rlul/mounts/boot
18:18:01 [2025-02-05T18:18:01.242Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0xo9rlul/mounts/boot/efi
18:18:01 [2025-02-05T18:18:01.494Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:01 [2025-02-05T18:18:01.494Z] copying '/run/osbuild/inputs/tree/.' -> '/run/osbuild/mounts/.'
18:18:09 [2025-02-05T18:18:09.547Z] 
18:18:09 [2025-02-05T18:18:09.547Z] Filesystem      Size  Used Avail Use% Mounted on
18:18:09 [2025-02-05T18:18:09.547Z] /dev/vdb1        30G  9.3G   21G  31% /home/jenkins/agent/workspace/test-override/cache
18:18:09 [2025-02-05T18:18:09.547Z] 
18:18:21 [2025-02-05T18:18:21.676Z] 
18:18:21 [2025-02-05T18:18:21.676Z] Filesystem      Size  Used Avail Use% Mounted on
18:18:21 [2025-02-05T18:18:21.676Z] /dev/vdb1        30G  9.7G   21G  33% /home/jenkins/agent/workspace/test-override/cache
18:18:21 [2025-02-05T18:18:21.676Z] 
18:18:29 [2025-02-05T18:18:29.740Z] 
18:18:29 [2025-02-05T18:18:29.740Z] Filesystem      Size  Used Avail Use% Mounted on
18:18:29 [2025-02-05T18:18:29.740Z] /dev/vdb1        30G   11G   20G  35% /home/jenkins/agent/workspace/test-override/cache
18:18:29 [2025-02-05T18:18:29.740Z] 
18:18:39 [2025-02-05T18:18:39.657Z] 
18:18:39 [2025-02-05T18:18:39.657Z] Filesystem      Size  Used Avail Use% Mounted on
18:18:39 [2025-02-05T18:18:39.657Z] /dev/vdb1        30G   11G   20G  36% /home/jenkins/agent/workspace/test-override/cache
18:18:39 [2025-02-05T18:18:39.657Z] 
18:18:39 [2025-02-05T18:18:39.910Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0xo9rlul/mounts/boot/efi unmounted
18:18:40 [2025-02-05T18:18:40.829Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0xo9rlul/mounts/boot unmounted
18:18:41 [2025-02-05T18:18:41.081Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0xo9rlul/mounts/ unmounted
18:18:41 [2025-02-05T18:18:41.081Z] 
18:18:41 [2025-02-05T18:18:41.081Z] ���  Duration: 40s
18:18:41 [2025-02-05T18:18:41.081Z] org.osbuild.bootupd: 35953385eddfcb26227cd6601981bfa031dc6f32feef4c6362d3c44636e7f77a {
18:18:41 [2025-02-05T18:18:41.081Z]   "static-configs": true,
18:18:41 [2025-02-05T18:18:41.081Z]   "deployment": {
18:18:41 [2025-02-05T18:18:41.081Z]     "default": true
18:18:41 [2025-02-05T18:18:41.081Z]   }
18:18:41 [2025-02-05T18:18:41.081Z] }
18:18:41 [2025-02-05T18:18:41.333Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:18:41 [2025-02-05T18:18:41.333Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qspbzl7m/mounts/
18:18:41 [2025-02-05T18:18:41.333Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qspbzl7m/mounts/boot
18:18:41 [2025-02-05T18:18:41.586Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qspbzl7m/mounts/boot/efi
18:18:41 [2025-02-05T18:18:41.586Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:41 [2025-02-05T18:18:41.838Z] Skip installing component BIOS without target device
18:18:41 [2025-02-05T18:18:41.838Z] Installed 40_coreos-ignition.cfg
18:18:41 [2025-02-05T18:18:41.838Z] Installed 70_coreos-user.cfg
18:18:41 [2025-02-05T18:18:41.838Z] Installed: grub.cfg
18:18:41 [2025-02-05T18:18:41.838Z] Installed: "fedora/grub.cfg"
18:18:41 [2025-02-05T18:18:41.838Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qspbzl7m/mounts/boot/efi unmounted
18:18:42 [2025-02-05T18:18:42.090Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qspbzl7m/mounts/boot unmounted
18:18:42 [2025-02-05T18:18:42.090Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qspbzl7m/mounts/ unmounted
18:18:42 [2025-02-05T18:18:42.090Z] 
18:18:42 [2025-02-05T18:18:42.090Z] ���  Duration: 0s
18:18:42 [2025-02-05T18:18:42.090Z] org.osbuild.chattr: b7ef27450a4c62de9de67c1afab7749676d0ad3239b4b6fee23ed2ac5dbcdabf {
18:18:42 [2025-02-05T18:18:42.090Z]   "items": {
18:18:42 [2025-02-05T18:18:42.090Z]     "mount://root/": {
18:18:42 [2025-02-05T18:18:42.090Z]       "immutable": true
18:18:42 [2025-02-05T18:18:42.090Z]     }
18:18:42 [2025-02-05T18:18:42.090Z]   }
18:18:42 [2025-02-05T18:18:42.090Z] }
18:18:42 [2025-02-05T18:18:42.090Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:18:42 [2025-02-05T18:18:42.352Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts/
18:18:42 [2025-02-05T18:18:42.352Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0'
18:18:42 [2025-02-05T18:18:42.606Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts/boot unmounted
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts/var unmounted
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts/sysroot unmounted
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts unmounted
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts unmounted
18:18:42 [2025-02-05T18:18:42.606Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts unmounted
18:18:42 [2025-02-05T18:18:42.606Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-36zsqxsq/mounts/
18:18:42 [2025-02-05T18:18:42.858Z] 
18:18:42 [2025-02-05T18:18:42.858Z] ���  Duration: 0s
18:18:42 [2025-02-05T18:18:42.858Z] Pipeline raw-metal4k-image: c4dfb54f05c080ca68dda2c18be130f8ffb2fd347265ce94862df15480da2234
18:18:42 [2025-02-05T18:18:42.858Z] Build
18:18:42 [2025-02-05T18:18:42.858Z]   root: <host>
18:18:42 [2025-02-05T18:18:42.858Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:18:42 [2025-02-05T18:18:42.858Z] org.osbuild.copy: d5e36dd49f4cbdcf41a0794ad5e58ad15e7157c875c24f2a2d492c397f0e8733 {
18:18:42 [2025-02-05T18:18:42.858Z]   "paths": [
18:18:42 [2025-02-05T18:18:42.858Z]     {
18:18:42 [2025-02-05T18:18:42.858Z]       "from": "input://tree/disk.img",
18:18:42 [2025-02-05T18:18:42.858Z]       "to": "tree:///disk.img"
18:18:42 [2025-02-05T18:18:42.858Z]     }
18:18:42 [2025-02-05T18:18:42.858Z]   ]
18:18:42 [2025-02-05T18:18:42.858Z] }
18:18:42 [2025-02-05T18:18:42.858Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:43 [2025-02-05T18:18:43.111Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
18:18:43 [2025-02-05T18:18:43.111Z] 
18:18:43 [2025-02-05T18:18:43.111Z] ���  Duration: 0s
18:18:43 [2025-02-05T18:18:43.111Z] org.osbuild.coreos.platform: c4dfb54f05c080ca68dda2c18be130f8ffb2fd347265ce94862df15480da2234 {
18:18:43 [2025-02-05T18:18:43.111Z]   "platform": "metal"
18:18:43 [2025-02-05T18:18:43.111Z] }
18:18:43 [2025-02-05T18:18:43.667Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
18:18:43 [2025-02-05T18:18:43.667Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/
18:18:43 [2025-02-05T18:18:43.920Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0'
18:18:43 [2025-02-05T18:18:43.920Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/boot
18:18:44 [2025-02-05T18:18:44.173Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:44 [2025-02-05T18:18:44.173Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/boot unmounted
18:18:44 [2025-02-05T18:18:44.173Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts
18:18:44 [2025-02-05T18:18:44.173Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/boot unmounted
18:18:44 [2025-02-05T18:18:44.173Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/var unmounted
18:18:44 [2025-02-05T18:18:44.173Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/sysroot unmounted
18:18:44 [2025-02-05T18:18:44.173Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts unmounted
18:18:44 [2025-02-05T18:18:44.173Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts unmounted
18:18:44 [2025-02-05T18:18:44.426Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts unmounted
18:18:44 [2025-02-05T18:18:44.426Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-wicwn_07/mounts/
18:18:44 [2025-02-05T18:18:44.426Z] 
18:18:44 [2025-02-05T18:18:44.426Z] ���  Duration: 1s
18:18:44 [2025-02-05T18:18:44.426Z] Pipeline metal4k: 34cfea228e25e215b77d69af32db92c56249f3f16b582ad9d860fe14b1f02c7e
18:18:44 [2025-02-05T18:18:44.426Z] Build
18:18:44 [2025-02-05T18:18:44.426Z]   root: <host>
18:18:44 [2025-02-05T18:18:44.426Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
18:18:44 [2025-02-05T18:18:44.426Z] org.osbuild.copy: 34cfea228e25e215b77d69af32db92c56249f3f16b582ad9d860fe14b1f02c7e {
18:18:44 [2025-02-05T18:18:44.426Z]   "paths": [
18:18:44 [2025-02-05T18:18:44.426Z]     {
18:18:44 [2025-02-05T18:18:44.426Z]       "from": "input://tree/disk.img",
18:18:44 [2025-02-05T18:18:44.426Z]       "to": "tree:///fedora-coreos-41.20250205.dev.0-metal4k.x86_64.raw"
18:18:44 [2025-02-05T18:18:44.426Z]     }
18:18:44 [2025-02-05T18:18:44.426Z]   ]
18:18:44 [2025-02-05T18:18:44.426Z] }
18:18:44 [2025-02-05T18:18:44.679Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
18:18:44 [2025-02-05T18:18:44.679Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-41.20250205.dev.0-metal4k.x86_64.raw'
18:18:45 [2025-02-05T18:18:45.609Z] 
18:18:45 [2025-02-05T18:18:45.609Z] ���  Duration: 0s
18:18:45 [2025-02-05T18:18:45.609Z] manifest /tmp/osbuild-B2pC.json finished successfully
18:18:46 [2025-02-05T18:18:46.168Z] oci-archive:	d195cd483555dfd59fb8536404a2065cf6953bb3cbee34dc6d4d253cda2efd61
18:18:46 [2025-02-05T18:18:46.168Z] deployed-tree:	844a0336c1b1da16530b80cfffba1f735d92812084777a4f8a57041a2a1833d9
18:18:46 [2025-02-05T18:18:46.168Z] tree:     	92f5cdc466df39e715833b7a647ce7c798dc3b9c6131e2d149187035bf56bb3e
18:18:46 [2025-02-05T18:18:46.168Z] raw-image:	a0f124b657a22166713b33c6b3f0bec79df5924c1f473f2558ea8e8815fb8868
18:18:46 [2025-02-05T18:18:46.168Z] raw-4k-image:	b7ef27450a4c62de9de67c1afab7749676d0ad3239b4b6fee23ed2ac5dbcdabf
18:18:46 [2025-02-05T18:18:46.168Z] raw-applehv-image:	300416bded216cf7cba22c800a9a18c7576f0ea499c40c2bbd7a1844f1bfb070
18:18:46 [2025-02-05T18:18:46.168Z] applehv:  	640fcb42e1107936da81a098c1746ca5aa408a65361527d38414552a355f2d88
18:18:46 [2025-02-05T18:18:46.168Z] raw-gcp-image:	e2bb527d0656a5be120e8864bf1e7acf4fe25130ae459bf7f572debd63d6bce0
18:18:46 [2025-02-05T18:18:46.168Z] raw-gcp-image-tar:	e75d775d4acdf73ba5c9fab2a38e954f4ac5f3fa93ac60ebd3c7db2ad642fddd
18:18:46 [2025-02-05T18:18:46.168Z] gcp:      	92d055e703ad6a2e4259fde91478a74f8cfbeeadb4800f7e4a8b7f37b1a55a77
18:18:46 [2025-02-05T18:18:46.168Z] raw-hyperv-image:	6833d84f97002f02c5d9b223ac9865b52bf7b43a43c2bd3a8022fa1a56de0472
18:18:46 [2025-02-05T18:18:46.168Z] hyperv:   	7d7ee577e7b00138cc47f36c01af049324c28081435ec17640fbf9f3032a0676
18:18:46 [2025-02-05T18:18:46.168Z] raw-metal-image:	af98ac75ef7715ebe418730a8ec325e96a4f246fb02b46f9679e80ca04c6532e
18:18:46 [2025-02-05T18:18:46.168Z] metal:    	015c927cdcbe6cf7739c025c01d99aaa77b1c1432698bf104d2c72489fb9f98e
18:18:46 [2025-02-05T18:18:46.168Z] raw-metal4k-image:	c4dfb54f05c080ca68dda2c18be130f8ffb2fd347265ce94862df15480da2234
18:18:46 [2025-02-05T18:18:46.168Z] metal4k:  	34cfea228e25e215b77d69af32db92c56249f3f16b582ad9d860fe14b1f02c7e
18:18:46 [2025-02-05T18:18:46.168Z] raw-qemu-image:	9eb84f27db72b66e31ad3c1eeca7f66da559b5d61ef0067c4bfeed18657cce26
18:18:46 [2025-02-05T18:18:46.168Z] qemu:     	86fa682763f4c4cea67872d35fe593130e3b1414167bcf82fa9364fe974e7d79
18:18:46 [2025-02-05T18:18:46.168Z] live:     	de4d98bf855d54156884ec599a095dc286e7962e99a1958ac59be234fa8e5032
18:18:46 [2025-02-05T18:18:46.422Z] + set +x
18:18:51 [2025-02-05T18:18:51.650Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.EYbDDgwPYi/metal4k/fedora-coreos-41.20250205.dev.0-metal4k.x86_64.raw': Operation not permitted
18:18:51 [2025-02-05T18:18:51.650Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.EYbDDgwPYi/metal4k': Operation not permitted
18:18:56 [2025-02-05T18:18:56.867Z] /home/jenkins/agent/workspace/test-override/builds/41.20250205.dev.0/x86_64/meta.json wrote with version stamp 1738779536727560989
18:18:56 [2025-02-05T18:18:56.867Z] Successfully generated: fedora-coreos-41.20250205.dev.0-metal4k.x86_64.raw
18:18:56 [2025-02-05T18:18:56.868Z] [Pipeline] }
18:18:56 [2025-02-05T18:18:56.871Z] [Pipeline] // withEnv
18:18:56 [2025-02-05T18:18:56.875Z] [Pipeline] }
18:18:56 [2025-02-05T18:18:56.930Z] [Pipeline] // stage
18:18:56 [2025-02-05T18:18:56.957Z] [Pipeline] stage
18:18:56 [2025-02-05T18:18:56.957Z] [Pipeline] { (x86_64:Build Live)
18:18:57 [2025-02-05T18:18:57.001Z] [Pipeline] withEnv
18:18:57 [2025-02-05T18:18:57.001Z] [Pipeline] {
18:18:57 [2025-02-05T18:18:57.004Z] [Pipeline] sh
18:18:57 [2025-02-05T18:18:57.585Z] + set -xeuo pipefail
18:18:57 [2025-02-05T18:18:57.585Z] ++ umask
18:18:57 [2025-02-05T18:18:57.585Z] + '[' 0022 = 0000 ']'
18:18:57 [2025-02-05T18:18:57.585Z] + cosa buildextend-live --fast
18:18:57 [2025-02-05T18:18:57.839Z] Targeting build: 41.20250205.dev.0
18:18:57 [2025-02-05T18:18:57.840Z] 2025-02-05 18:18:57,688 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854', '/usr/lib/modules']
18:18:57 [2025-02-05T18:18:57.840Z] 2025-02-05 18:18:57,702 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.12.11-200.fc41.x86_64/vmlinuz', '34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
18:18:57 [2025-02-05T18:18:57.840Z] 2025-02-05 18:18:57,750 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.12.11-200.fc41.x86_64/initramfs.img', '34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
18:18:58 [2025-02-05T18:18:58.092Z] 2025-02-05 18:18:57,955 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854', '/usr/share/coreos-installer/example-config.yaml']
18:18:58 [2025-02-05T18:18:58.092Z] 2025-02-05 18:18:57,973 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854', '/tmp/tmpjbug15ax']
18:18:58 [2025-02-05T18:18:58.092Z] Generating osmet file for 512b metal image
18:18:58 [2025-02-05T18:18:58.092Z] 2025-02-05 18:18:57,991 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 41.20250205.dev.0', '--checksum', '948ec77bce3b9a50b22ddef64be5f72b868a88c458146bb378826e0a4f2e06ee', '--output', '/var/tmp/coreos-installer-output', '--fast']
18:19:16 [2025-02-05T18:19:16.101Z] + RUST_BACKTRACE=full
18:19:16 [2025-02-05T18:19:16.102Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 41.20250205.dev.0' --checksum 948ec77bce3b9a50b22ddef64be5f72b868a88c458146bb378826e0a4f2e06ee --output /var/tmp/coreos-installer-output --fast
18:19:16 [2025-02-05T18:19:16.102Z] Total OSTree objects scanned from /root: 17756 (17750 mapped, 6 empty)
18:19:16 [2025-02-05T18:19:16.102Z] Total OSTree objects found in /boot: 317
18:19:16 [2025-02-05T18:19:16.102Z] Duplicate extents dropped: 0
18:19:16 [2025-02-05T18:19:16.102Z] Overlapping extents clamped: 0
18:19:16 [2025-02-05T18:19:16.102Z] Total /root extents: 17751
18:19:16 [2025-02-05T18:19:16.102Z] Duplicate extents dropped: 0
18:19:16 [2025-02-05T18:19:16.102Z] Overlapping extents clamped: 0
18:19:16 [2025-02-05T18:19:16.102Z] Total /boot extents: 322
18:19:16 [2025-02-05T18:19:16.102Z] Packing image
18:19:54 [2025-02-05T18:19:54.720Z] Total bytes skipped: 1680800768
18:19:54 [2025-02-05T18:19:54.720Z] Total bytes written: 1098974208
18:19:54 [2025-02-05T18:19:54.720Z] Total bytes written (compressed): 23661600
18:19:54 [2025-02-05T18:19:54.720Z] Verifying that repacked image matches digest
18:20:02 [2025-02-05T18:20:02.774Z] Packing successful!
18:20:02 [2025-02-05T18:20:02.774Z] + '[' -f /var/tmp/coreos-installer-output ']'
18:20:02 [2025-02-05T18:20:02.774Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
18:20:06 [2025-02-05T18:20:06.021Z] Generating osmet file for 4k metal image
18:20:06 [2025-02-05T18:20:06.021Z] 2025-02-05 18:20:05,728 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-41.20250205.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 41.20250205.dev.0', '--checksum', 'f13fa7942f364828a5139d4174e41cd43cc1c2d4e67a0f5771cf91ce2f53874e', '--output', '/var/tmp/coreos-installer-output', '--fast']
18:20:24 [2025-02-05T18:20:24.021Z] + RUST_BACKTRACE=full
18:20:24 [2025-02-05T18:20:24.021Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 41.20250205.dev.0' --checksum f13fa7942f364828a5139d4174e41cd43cc1c2d4e67a0f5771cf91ce2f53874e --output /var/tmp/coreos-installer-output --fast
18:20:24 [2025-02-05T18:20:24.021Z] Total OSTree objects scanned from /root: 17756 (17750 mapped, 6 empty)
18:20:24 [2025-02-05T18:20:24.021Z] Total OSTree objects found in /boot: 3
18:20:24 [2025-02-05T18:20:24.021Z] Duplicate extents dropped: 0
18:20:24 [2025-02-05T18:20:24.021Z] Overlapping extents clamped: 0
18:20:24 [2025-02-05T18:20:24.021Z] Total /root extents: 17751
18:20:24 [2025-02-05T18:20:24.021Z] Duplicate extents dropped: 0
18:20:24 [2025-02-05T18:20:24.021Z] Overlapping extents clamped: 0
18:20:24 [2025-02-05T18:20:24.021Z] Total /boot extents: 4
18:20:24 [2025-02-05T18:20:24.021Z] Packing image
18:20:38 [2025-02-05T18:20:38.836Z] Total bytes skipped: 1669926912
18:20:38 [2025-02-05T18:20:38.836Z] Total bytes written: 1109848064
18:20:38 [2025-02-05T18:20:38.836Z] Total bytes written (compressed): 24144924
18:20:38 [2025-02-05T18:20:38.836Z] Verifying that repacked image matches digest
18:20:45 [2025-02-05T18:20:45.355Z] Packing successful!
18:20:45 [2025-02-05T18:20:45.355Z] + '[' -f /var/tmp/coreos-installer-output ']'
18:20:45 [2025-02-05T18:20:45.355Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
18:20:47 [2025-02-05T18:20:47.236Z] Compressing squashfs with lz4
18:20:47 [2025-02-05T18:20:47.236Z] 2025-02-05 18:20:47,203 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
18:20:47 [2025-02-05T18:20:47.489Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
18:20:47 [2025-02-05T18:20:47.489Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
18:20:47 [2025-02-05T18:20:47.489Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw
18:20:47 [2025-02-05T18:20:47.489Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/image.squashfs
18:20:47 [2025-02-05T18:20:47.489Z] + coreos_gf_run_mount builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:20:47 [2025-02-05T18:20:47.489Z] + local mntarg=mount
18:20:47 [2025-02-05T18:20:47.489Z] + '[' builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw = ro ']'
18:20:47 [2025-02-05T18:20:47.489Z] + coreos_gf_run builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:20:47 [2025-02-05T18:20:47.489Z] + '[' -n '' ']'
18:20:47 [2025-02-05T18:20:47.489Z] + coreos_gf_launch builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:20:47 [2025-02-05T18:20:47.489Z] + '[' -n '' ']'
18:20:47 [2025-02-05T18:20:47.489Z] ++ guestfish --listen -a builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:20:47 [2025-02-05T18:20:47.489Z] + eval 'GUESTFISH_PID=12753; export GUESTFISH_PID'
18:20:47 [2025-02-05T18:20:47.489Z] ++ GUESTFISH_PID=12753
18:20:47 [2025-02-05T18:20:47.489Z] ++ export GUESTFISH_PID
18:20:47 [2025-02-05T18:20:47.489Z] + '[' -z 12753 ']'
18:20:47 [2025-02-05T18:20:47.489Z] ++ kola ncpu
18:20:47 [2025-02-05T18:20:47.489Z] + coreos_gf set-smp 6
18:20:47 [2025-02-05T18:20:47.489Z] + guestfish --remote -- set-smp 6
18:20:47 [2025-02-05T18:20:47.489Z] + coreos_gf run
18:20:47 [2025-02-05T18:20:47.489Z] + guestfish --remote -- run
18:20:49 [2025-02-05T18:20:49.362Z] + GUESTFISH_RUNNING=1
18:20:49 [2025-02-05T18:20:49.362Z] ++ coreos_gf findfs-label root
18:20:49 [2025-02-05T18:20:49.362Z] ++ guestfish --remote -- findfs-label root
18:20:49 [2025-02-05T18:20:49.362Z] + root=/dev/sda4
18:20:49 [2025-02-05T18:20:49.362Z] + coreos_gf mount /dev/sda4 /
18:20:49 [2025-02-05T18:20:49.362Z] + guestfish --remote -- mount /dev/sda4 /
18:20:49 [2025-02-05T18:20:49.917Z] + local boot
18:20:49 [2025-02-05T18:20:49.917Z] ++ coreos_gf findfs-label boot
18:20:49 [2025-02-05T18:20:49.917Z] ++ guestfish --remote -- findfs-label boot
18:20:49 [2025-02-05T18:20:49.917Z] + boot=/dev/sda3
18:20:49 [2025-02-05T18:20:49.917Z] + coreos_gf mount /dev/sda3 /boot
18:20:49 [2025-02-05T18:20:49.917Z] + guestfish --remote -- mount /dev/sda3 /boot
18:20:49 [2025-02-05T18:20:49.917Z] + local partitions
18:20:49 [2025-02-05T18:20:49.917Z] + local label
18:20:49 [2025-02-05T18:20:49.917Z] ++ coreos_gf list-partitions
18:20:49 [2025-02-05T18:20:49.917Z] ++ guestfish --remote -- list-partitions
18:20:49 [2025-02-05T18:20:49.917Z] + partitions='/dev/sda1
18:20:49 [2025-02-05T18:20:49.917Z] /dev/sda2
18:20:49 [2025-02-05T18:20:49.917Z] /dev/sda3
18:20:49 [2025-02-05T18:20:49.917Z] /dev/sda4'
18:20:49 [2025-02-05T18:20:49.917Z] + for pt in $partitions
18:20:50 [2025-02-05T18:20:50.180Z] ++ coreos_gf vfs-label /dev/sda1
18:20:50 [2025-02-05T18:20:50.180Z] ++ guestfish --remote -- vfs-label /dev/sda1
18:20:50 [2025-02-05T18:20:50.180Z] + label=
18:20:50 [2025-02-05T18:20:50.180Z] + '[' '' == EFI-SYSTEM ']'
18:20:50 [2025-02-05T18:20:50.180Z] + for pt in $partitions
18:20:50 [2025-02-05T18:20:50.180Z] ++ coreos_gf vfs-label /dev/sda2
18:20:50 [2025-02-05T18:20:50.180Z] ++ guestfish --remote -- vfs-label /dev/sda2
18:20:50 [2025-02-05T18:20:50.180Z] + label=EFI-SYSTEM
18:20:50 [2025-02-05T18:20:50.180Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
18:20:50 [2025-02-05T18:20:50.180Z] + coreos_gf mount /dev/sda2 /boot/efi
18:20:50 [2025-02-05T18:20:50.180Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
18:20:50 [2025-02-05T18:20:50.180Z] + for pt in $partitions
18:20:50 [2025-02-05T18:20:50.180Z] ++ coreos_gf vfs-label /dev/sda3
18:20:50 [2025-02-05T18:20:50.180Z] ++ guestfish --remote -- vfs-label /dev/sda3
18:20:50 [2025-02-05T18:20:50.180Z] + label=boot
18:20:50 [2025-02-05T18:20:50.180Z] + '[' boot == EFI-SYSTEM ']'
18:20:50 [2025-02-05T18:20:50.180Z] + for pt in $partitions
18:20:50 [2025-02-05T18:20:50.180Z] ++ coreos_gf vfs-label /dev/sda4
18:20:50 [2025-02-05T18:20:50.180Z] ++ guestfish --remote -- vfs-label /dev/sda4
18:20:50 [2025-02-05T18:20:50.180Z] + label=root
18:20:50 [2025-02-05T18:20:50.180Z] + '[' root == EFI-SYSTEM ']'
18:20:50 [2025-02-05T18:20:50.180Z] ++ coreos_gf ls /ostree/deploy
18:20:50 [2025-02-05T18:20:50.180Z] ++ guestfish --remote -- ls /ostree/deploy
18:20:50 [2025-02-05T18:20:50.180Z] + stateroot=/ostree/deploy/fedora-coreos
18:20:50 [2025-02-05T18:20:50.180Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
18:20:50 [2025-02-05T18:20:50.180Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
18:20:50 [2025-02-05T18:20:50.180Z] ++ grep -v .origin
18:20:50 [2025-02-05T18:20:50.180Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0
18:20:50 [2025-02-05T18:20:50.180Z] + export stateroot deploydir
18:20:50 [2025-02-05T18:20:50.180Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/config
18:20:50 [2025-02-05T18:20:50.180Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/config
18:20:50 [2025-02-05T18:20:50.433Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/config
18:20:50 [2025-02-05T18:20:50.433Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/config.new /ostree/repo/config
18:20:50 [2025-02-05T18:20:50.433Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/config.new /ostree/repo/config
18:20:50 [2025-02-05T18:20:50.433Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
18:20:50 [2025-02-05T18:20:50.433Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
18:20:50 [2025-02-05T18:20:50.433Z] + kernel_binary=/boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/vmlinuz-6.12.11-200.fc41.x86_64
18:20:50 [2025-02-05T18:20:50.433Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
18:20:50 [2025-02-05T18:20:50.433Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
18:20:50 [2025-02-05T18:20:50.433Z] + kernel_hmac=/boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/.vmlinuz-6.12.11-200.fc41.x86_64.hmac
18:20:50 [2025-02-05T18:20:50.433Z] ++ basename /boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/.vmlinuz-6.12.11-200.fc41.x86_64.hmac
18:20:50 [2025-02-05T18:20:50.433Z] + coreos_gf ln /boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/.vmlinuz-6.12.11-200.fc41.x86_64.hmac /boot/.vmlinuz-6.12.11-200.fc41.x86_64.hmac
18:20:50 [2025-02-05T18:20:50.433Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/.vmlinuz-6.12.11-200.fc41.x86_64.hmac /boot/.vmlinuz-6.12.11-200.fc41.x86_64.hmac
18:20:50 [2025-02-05T18:20:50.433Z] ++ basename /boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/vmlinuz-6.12.11-200.fc41.x86_64
18:20:50 [2025-02-05T18:20:50.433Z] + coreos_gf ln /boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/vmlinuz-6.12.11-200.fc41.x86_64 /boot/vmlinuz-6.12.11-200.fc41.x86_64
18:20:50 [2025-02-05T18:20:50.433Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-3f19238754ba6d25a364fb07db6d49cf987d657418f21b299fae4e2a3dd4d3af/vmlinuz-6.12.11-200.fc41.x86_64 /boot/vmlinuz-6.12.11-200.fc41.x86_64
18:20:50 [2025-02-05T18:20:50.433Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/image.squashfs compress:lz4
18:20:50 [2025-02-05T18:20:50.433Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/image.squashfs compress:lz4
18:20:58 [2025-02-05T18:20:58.487Z] + coreos_gf_shutdown
18:20:58 [2025-02-05T18:20:58.487Z] + coreos_gf umount-all
18:20:58 [2025-02-05T18:20:58.487Z] + guestfish --remote -- umount-all
18:20:59 [2025-02-05T18:20:59.043Z] + coreos_gf exit
18:20:59 [2025-02-05T18:20:59.043Z] + guestfish --remote -- exit
18:20:59 [2025-02-05T18:20:59.296Z] + GUESTFISH_RUNNING=
18:20:59 [2025-02-05T18:20:59.296Z] + GUESTFISH_PID=
18:20:59 [2025-02-05T18:20:59.296Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
18:20:59 [2025-02-05T18:20:59.296Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2uRVaw -rf
18:20:59 [2025-02-05T18:20:59.296Z] + _coreos_gf_cleanup
18:20:59 [2025-02-05T18:20:59.296Z] + guestfish --remote -- exit
18:20:59 [2025-02-05T18:20:59.296Z] + :
18:21:05 [2025-02-05T18:21:05.808Z] 2025-02-05 18:21:04,978 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw']
18:21:05 [2025-02-05T18:21:05.808Z] + coreos_gf_run_mount builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:21:05 [2025-02-05T18:21:05.808Z] + local mntarg=mount
18:21:05 [2025-02-05T18:21:05.808Z] + '[' builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw = ro ']'
18:21:05 [2025-02-05T18:21:05.808Z] + coreos_gf_run builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:21:05 [2025-02-05T18:21:05.808Z] + '[' -n '' ']'
18:21:05 [2025-02-05T18:21:05.808Z] + coreos_gf_launch builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:21:05 [2025-02-05T18:21:05.808Z] + '[' -n '' ']'
18:21:05 [2025-02-05T18:21:05.808Z] ++ guestfish --listen -a builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw --ro
18:21:05 [2025-02-05T18:21:05.808Z] + eval 'GUESTFISH_PID=12897; export GUESTFISH_PID'
18:21:05 [2025-02-05T18:21:05.808Z] ++ GUESTFISH_PID=12897
18:21:05 [2025-02-05T18:21:05.808Z] ++ export GUESTFISH_PID
18:21:05 [2025-02-05T18:21:05.808Z] + '[' -z 12897 ']'
18:21:05 [2025-02-05T18:21:05.808Z] ++ kola ncpu
18:21:05 [2025-02-05T18:21:05.808Z] + coreos_gf set-smp 6
18:21:05 [2025-02-05T18:21:05.808Z] + guestfish --remote -- set-smp 6
18:21:05 [2025-02-05T18:21:05.808Z] + coreos_gf run
18:21:05 [2025-02-05T18:21:05.808Z] + guestfish --remote -- run
18:21:07 [2025-02-05T18:21:07.161Z] + GUESTFISH_RUNNING=1
18:21:07 [2025-02-05T18:21:07.161Z] ++ coreos_gf findfs-label root
18:21:07 [2025-02-05T18:21:07.161Z] ++ guestfish --remote -- findfs-label root
18:21:07 [2025-02-05T18:21:07.161Z] + root=/dev/sda4
18:21:07 [2025-02-05T18:21:07.161Z] + coreos_gf mount /dev/sda4 /
18:21:07 [2025-02-05T18:21:07.161Z] + guestfish --remote -- mount /dev/sda4 /
18:21:07 [2025-02-05T18:21:07.717Z] + local boot
18:21:07 [2025-02-05T18:21:07.717Z] ++ coreos_gf findfs-label boot
18:21:07 [2025-02-05T18:21:07.717Z] ++ guestfish --remote -- findfs-label boot
18:21:08 [2025-02-05T18:21:08.273Z] + boot=/dev/sda3
18:21:08 [2025-02-05T18:21:08.273Z] + coreos_gf mount /dev/sda3 /boot
18:21:08 [2025-02-05T18:21:08.273Z] + guestfish --remote -- mount /dev/sda3 /boot
18:21:08 [2025-02-05T18:21:08.273Z] + local partitions
18:21:08 [2025-02-05T18:21:08.273Z] + local label
18:21:08 [2025-02-05T18:21:08.273Z] ++ coreos_gf list-partitions
18:21:08 [2025-02-05T18:21:08.273Z] ++ guestfish --remote -- list-partitions
18:21:08 [2025-02-05T18:21:08.273Z] + partitions='/dev/sda1
18:21:08 [2025-02-05T18:21:08.273Z] /dev/sda2
18:21:08 [2025-02-05T18:21:08.273Z] /dev/sda3
18:21:08 [2025-02-05T18:21:08.273Z] /dev/sda4'
18:21:08 [2025-02-05T18:21:08.273Z] + for pt in $partitions
18:21:08 [2025-02-05T18:21:08.273Z] ++ coreos_gf vfs-label /dev/sda1
18:21:08 [2025-02-05T18:21:08.273Z] ++ guestfish --remote -- vfs-label /dev/sda1
18:21:08 [2025-02-05T18:21:08.527Z] + label=
18:21:08 [2025-02-05T18:21:08.527Z] + '[' '' == EFI-SYSTEM ']'
18:21:08 [2025-02-05T18:21:08.527Z] + for pt in $partitions
18:21:08 [2025-02-05T18:21:08.527Z] ++ coreos_gf vfs-label /dev/sda2
18:21:08 [2025-02-05T18:21:08.527Z] ++ guestfish --remote -- vfs-label /dev/sda2
18:21:08 [2025-02-05T18:21:08.527Z] + label=EFI-SYSTEM
18:21:08 [2025-02-05T18:21:08.527Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
18:21:08 [2025-02-05T18:21:08.527Z] + coreos_gf mount /dev/sda2 /boot/efi
18:21:08 [2025-02-05T18:21:08.527Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
18:21:08 [2025-02-05T18:21:08.527Z] + for pt in $partitions
18:21:08 [2025-02-05T18:21:08.527Z] ++ coreos_gf vfs-label /dev/sda3
18:21:08 [2025-02-05T18:21:08.527Z] ++ guestfish --remote -- vfs-label /dev/sda3
18:21:08 [2025-02-05T18:21:08.527Z] + label=boot
18:21:08 [2025-02-05T18:21:08.527Z] + '[' boot == EFI-SYSTEM ']'
18:21:08 [2025-02-05T18:21:08.527Z] + for pt in $partitions
18:21:08 [2025-02-05T18:21:08.527Z] ++ coreos_gf vfs-label /dev/sda4
18:21:08 [2025-02-05T18:21:08.527Z] ++ guestfish --remote -- vfs-label /dev/sda4
18:21:08 [2025-02-05T18:21:08.527Z] + label=root
18:21:08 [2025-02-05T18:21:08.527Z] + '[' root == EFI-SYSTEM ']'
18:21:08 [2025-02-05T18:21:08.527Z] ++ coreos_gf ls /ostree/deploy
18:21:08 [2025-02-05T18:21:08.527Z] ++ guestfish --remote -- ls /ostree/deploy
18:21:08 [2025-02-05T18:21:08.527Z] + stateroot=/ostree/deploy/fedora-coreos
18:21:08 [2025-02-05T18:21:08.527Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
18:21:08 [2025-02-05T18:21:08.527Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
18:21:08 [2025-02-05T18:21:08.527Z] ++ grep -v .origin
18:21:08 [2025-02-05T18:21:08.527Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0
18:21:08 [2025-02-05T18:21:08.527Z] + export stateroot deploydir
18:21:08 [2025-02-05T18:21:08.527Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
18:21:08 [2025-02-05T18:21:08.527Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
18:21:08 [2025-02-05T18:21:08.527Z] + sed -e '/^options/!d' -e 's/^options\s*//'
18:21:08 [2025-02-05T18:21:08.790Z] + coreos_gf_shutdown
18:21:08 [2025-02-05T18:21:08.790Z] + coreos_gf umount-all
18:21:08 [2025-02-05T18:21:08.791Z] + guestfish --remote -- umount-all
18:21:08 [2025-02-05T18:21:08.791Z] + coreos_gf exit
18:21:08 [2025-02-05T18:21:08.791Z] + guestfish --remote -- exit
18:21:08 [2025-02-05T18:21:08.791Z] + GUESTFISH_RUNNING=
18:21:08 [2025-02-05T18:21:08.791Z] + GUESTFISH_PID=
18:21:08 [2025-02-05T18:21:08.791Z] + _coreos_gf_cleanup
18:21:08 [2025-02-05T18:21:08.791Z] + guestfish --remote -- exit
18:21:08 [2025-02-05T18:21:08.791Z] + :
18:21:08 [2025-02-05T18:21:08.791Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-41.20250205.dev.0
18:21:08 [2025-02-05T18:21:08.791Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
18:21:08 [2025-02-05T18:21:08.791Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
18:21:08 [2025-02-05T18:21:08.791Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
18:21:08 [2025-02-05T18:21:08.791Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
18:21:08 [2025-02-05T18:21:08.791Z] 2025-02-05 18:21:08,715 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
18:21:09 [2025-02-05T18:21:09.043Z] 2025-02-05 18:21:08,842 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmp5wj4bl56.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
18:21:10 [2025-02-05T18:21:10.917Z] 2025-02-05 18:21:10,688 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-41.20250205.dev.0', '-volset', 'fedora-coreos-41.20250205.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
18:21:10 [2025-02-05T18:21:10.917Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
18:21:10 [2025-02-05T18:21:10.917Z] genisoimage 1.1.11 (Linux)
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
18:21:10 [2025-02-05T18:21:10.917Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Initial Padblock                        Start Block 0
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Initial Padblock                        Block(s)    16
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Primary Volume Descriptor               Start Block 16
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Primary Volume Descriptor               Block(s)    1
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Eltorito Volume Descriptor              Start Block 17
18:21:10 [2025-02-05T18:21:10.917Z] Size of boot image is 4 sectors -> No emulation
18:21:10 [2025-02-05T18:21:10.917Z] Size of boot image is 13192 sectors -> No emulation
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Eltorito Volume Descriptor              Block(s)    1
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Joliet Volume Descriptor                Start Block 18
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Joliet Volume Descriptor                Block(s)    1
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   End Volume Descriptor                   Start Block 19
18:21:10 [2025-02-05T18:21:10.917Z] Done with: End Volume Descriptor                   Block(s)    1
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Version block                           Start Block 20
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Version block                           Block(s)    1
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Path table                              Start Block 21
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Path table                              Block(s)    4
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Joliet path table                       Start Block 25
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Joliet path table                       Block(s)    4
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Directory tree                          Start Block 29
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Directory tree                          Block(s)    7
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Joliet directory tree                   Start Block 36
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Joliet directory tree                   Block(s)    7
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Directory tree cleanup                  Start Block 43
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Directory tree cleanup                  Block(s)    0
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   Extension record                        Start Block 43
18:21:10 [2025-02-05T18:21:10.917Z] Done with: Extension record                        Block(s)    1
18:21:10 [2025-02-05T18:21:10.917Z] Writing:   The File(s)                             Start Block 44
18:21:10 [2025-02-05T18:21:10.917Z]   0.92% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   1.83% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   2.75% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   3.67% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   4.58% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   5.50% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   6.41% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   7.33% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   8.24% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]   9.16% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  10.08% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  10.99% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  11.91% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  12.82% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  13.74% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  14.66% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  15.57% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  16.49% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  17.40% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  18.32% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  19.23% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  20.15% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  21.06% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  21.98% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:10 [2025-02-05T18:21:10.917Z]  22.90% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  23.81% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  24.73% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  25.65% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  26.56% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  27.48% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  28.39% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  29.31% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  30.22% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  31.14% done, estimate finish Wed Feb  5 18:21:10 2025
18:21:11 [2025-02-05T18:21:11.171Z]  32.05% done, estimate finish Wed Feb  5 18:21:13 2025
18:21:11 [2025-02-05T18:21:11.171Z]  32.97% done, estimate finish Wed Feb  5 18:21:13 2025
18:21:11 [2025-02-05T18:21:11.171Z]  33.89% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  34.80% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  35.72% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  36.63% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  37.55% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  38.47% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  39.38% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  40.30% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  41.21% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  42.13% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  43.04% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  43.96% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  44.88% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.171Z]  45.79% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.423Z]  46.71% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.423Z]  47.62% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.423Z]  48.54% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.423Z]  49.46% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:11 [2025-02-05T18:21:11.423Z]  50.37% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  51.29% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  52.20% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  53.12% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  54.03% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  54.95% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  55.87% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  56.78% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  57.70% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  58.61% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  59.53% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  60.45% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  61.36% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  62.28% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  63.19% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  64.11% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  65.02% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  65.94% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  66.85% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.423Z]  67.77% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  68.69% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  69.60% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  70.52% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  71.44% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  72.35% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  73.27% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  74.18% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  75.10% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  76.01% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  76.93% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  77.84% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  78.76% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  79.68% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  80.59% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  81.51% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  82.42% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  83.34% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  84.26% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  85.17% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  86.09% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  87.00% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  87.92% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.675Z]  88.83% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  89.75% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  90.67% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  91.58% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  92.50% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  93.41% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  94.33% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  95.25% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  96.16% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  97.08% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  97.99% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  98.91% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z]  99.82% done, estimate finish Wed Feb  5 18:21:11 2025
18:21:11 [2025-02-05T18:21:11.928Z] Total translation table size: 2048
18:21:11 [2025-02-05T18:21:11.928Z] Total rockridge attributes bytes: 3006
18:21:11 [2025-02-05T18:21:11.928Z] Total directory bytes: 12288
18:21:11 [2025-02-05T18:21:11.928Z] Path table size(bytes): 96
18:21:11 [2025-02-05T18:21:11.928Z] Done with: The File(s)                             Block(s)    545777
18:21:11 [2025-02-05T18:21:11.928Z] Writing:   Ending Padblock                         Start Block 545821
18:21:11 [2025-02-05T18:21:11.928Z] Done with: Ending Padblock                         Block(s)    150
18:21:11 [2025-02-05T18:21:11.928Z] Max brk space used 1c000
18:21:11 [2025-02-05T18:21:11.928Z] 545971 extents written (1066 MB)
18:21:11 [2025-02-05T18:21:11.928Z] 2025-02-05 18:21:11,800 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso']
18:21:11 [2025-02-05T18:21:11.928Z] isohybrid: Warning: more than 1024 cylinders: 1067
18:21:11 [2025-02-05T18:21:11.928Z] isohybrid: Not all BIOSes will be able to boot this device
18:21:12 [2025-02-05T18:21:12.483Z] 2025-02-05 18:21:12,212 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-41.20250205.dev.0', '-volset', 'fedora-coreos-41.20250205.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
18:21:12 [2025-02-05T18:21:12.483Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
18:21:12 [2025-02-05T18:21:12.483Z] genisoimage 1.1.11 (Linux)
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
18:21:12 [2025-02-05T18:21:12.483Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Initial Padblock                        Start Block 0
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Initial Padblock                        Block(s)    16
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Primary Volume Descriptor               Start Block 16
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Primary Volume Descriptor               Block(s)    1
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Eltorito Volume Descriptor              Start Block 17
18:21:12 [2025-02-05T18:21:12.483Z] Size of boot image is 4 sectors -> No emulation
18:21:12 [2025-02-05T18:21:12.483Z] Size of boot image is 13192 sectors -> No emulation
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Eltorito Volume Descriptor              Block(s)    1
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Joliet Volume Descriptor                Start Block 18
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Joliet Volume Descriptor                Block(s)    1
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   End Volume Descriptor                   Start Block 19
18:21:12 [2025-02-05T18:21:12.483Z] Done with: End Volume Descriptor                   Block(s)    1
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Version block                           Start Block 20
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Version block                           Block(s)    1
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Path table                              Start Block 21
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Path table                              Block(s)    4
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Joliet path table                       Start Block 25
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Joliet path table                       Block(s)    4
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Directory tree                          Start Block 29
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Directory tree                          Block(s)    7
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Joliet directory tree                   Start Block 36
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Joliet directory tree                   Block(s)    7
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Directory tree cleanup                  Start Block 43
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Directory tree cleanup                  Block(s)    0
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Extension record                        Start Block 43
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Extension record                        Block(s)    1
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   The File(s)                             Start Block 44
18:21:12 [2025-02-05T18:21:12.483Z]   8.60% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  17.17% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  25.76% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  34.33% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  42.92% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  51.49% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  60.08% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  68.65% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  77.24% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  85.81% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z]  94.40% done, estimate finish Wed Feb  5 18:21:12 2025
18:21:12 [2025-02-05T18:21:12.483Z] Total translation table size: 2048
18:21:12 [2025-02-05T18:21:12.483Z] Total rockridge attributes bytes: 2842
18:21:12 [2025-02-05T18:21:12.483Z] Total directory bytes: 12288
18:21:12 [2025-02-05T18:21:12.483Z] Path table size(bytes): 96
18:21:12 [2025-02-05T18:21:12.483Z] Done with: The File(s)                             Block(s)    58084
18:21:12 [2025-02-05T18:21:12.483Z] Writing:   Ending Padblock                         Start Block 58128
18:21:12 [2025-02-05T18:21:12.483Z] Done with: Ending Padblock                         Block(s)    150
18:21:12 [2025-02-05T18:21:12.483Z] Max brk space used 1b000
18:21:12 [2025-02-05T18:21:12.483Z] 58278 extents written (113 MB)
18:21:12 [2025-02-05T18:21:12.483Z] 2025-02-05 18:21:12,333 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso.minimal']
18:21:12 [2025-02-05T18:21:12.483Z] 2025-02-05 18:21:12,440 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso.minimal', '--consume']
18:21:30 [2025-02-05T18:21:30.492Z] + RUST_BACKTRACE=full
18:21:30 [2025-02-05T18:21:30.492Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/34a7c234862facfdbd6ba8a10d29f09fa02bbcc8a10a59ec225d6aabbc8e4854.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack minimal-iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250205.dev.0-live.x86_64.iso.minimal --consume
18:21:30 [2025-02-05T18:21:30.492Z] Packing minimal ISO
18:21:30 [2025-02-05T18:21:30.492Z] Matched 17 files of 17
18:21:30 [2025-02-05T18:21:30.492Z] Total bytes skipped: 118934471
18:21:30 [2025-02-05T18:21:30.492Z] Total bytes written: 603193
18:21:30 [2025-02-05T18:21:30.492Z] Total bytes written (compressed): 2792
18:21:30 [2025-02-05T18:21:30.492Z] Verifying that packed image matches digest
18:21:30 [2025-02-05T18:21:30.492Z] Packing successful!
18:21:30 [2025-02-05T18:21:30.492Z] + '[' -f /var/tmp/coreos-installer-output ']'
18:21:35 [2025-02-05T18:21:35.708Z] Updated: builds/41.20250205.dev.0/x86_64/meta.json
18:21:35 [2025-02-05T18:21:35.720Z] [Pipeline] }
18:21:35 [2025-02-05T18:21:35.723Z] [Pipeline] // withEnv
18:21:35 [2025-02-05T18:21:35.764Z] [Pipeline] withEnv
18:21:35 [2025-02-05T18:21:35.764Z] [Pipeline] {
18:21:35 [2025-02-05T18:21:35.768Z] [Pipeline] sh
18:21:36 [2025-02-05T18:21:36.345Z] + set -xeuo pipefail
18:21:36 [2025-02-05T18:21:36.345Z] ++ umask
18:21:36 [2025-02-05T18:21:36.345Z] + '[' 0022 = 0000 ']'
18:21:36 [2025-02-05T18:21:36.345Z] + cosa shell -- env XZ_DEFAULTS=--memlimit=4G cosa compress --artifact=metal
18:21:36 [2025-02-05T18:21:36.345Z] Targeting build: 41.20250205.dev.0
18:21:36 [2025-02-05T18:21:36.599Z] Compressing: builds/41.20250205.dev.0/x86_64
18:21:36 [2025-02-05T18:21:36.599Z] 2025-02-05 18:21:36,381 INFO - Running command: ['xz', '-c9', '-T6', 'builds/41.20250205.dev.0/x86_64/fedora-coreos-41.20250205.dev.0-metal.x86_64.raw']
18:26:43 [2025-02-05T18:26:43.524Z] Compressed: fedora-coreos-41.20250205.dev.0-metal.x86_64.raw.xz
18:26:43 [2025-02-05T18:26:43.525Z] Skipped compressing artifacts: ostree oci-manifest live-iso live-kernel live-initramfs live-rootfs
18:26:43 [2025-02-05T18:26:43.525Z] Updated: builds/41.20250205.dev.0/x86_64/meta.json
18:26:43 [2025-02-05T18:26:43.527Z] [Pipeline] }
18:26:43 [2025-02-05T18:26:43.530Z] [Pipeline] // withEnv
18:26:43 [2025-02-05T18:26:43.535Z] [Pipeline] }
18:26:43 [2025-02-05T18:26:43.589Z] [Pipeline] // stage
18:26:43 [2025-02-05T18:26:43.593Z] [Pipeline] stage
18:26:43 [2025-02-05T18:26:43.594Z] [Pipeline] { (x86_64:kola:testiso)
18:26:43 [2025-02-05T18:26:43.729Z] [Pipeline] withEnv
18:26:43 [2025-02-05T18:26:43.730Z] [Pipeline] {
18:26:43 [2025-02-05T18:26:43.756Z] [Pipeline] sh
18:26:44 [2025-02-05T18:26:44.352Z] + set -euo pipefail
18:26:44 [2025-02-05T18:26:44.352Z] ++ umask
18:26:44 [2025-02-05T18:26:44.352Z] + '[' 0022 = 0000 ']'
18:26:44 [2025-02-05T18:26:44.352Z] + uuidgen
18:26:44 [2025-02-05T18:26:44.352Z] + cut -f1 -d-
18:26:44 [2025-02-05T18:26:44.356Z] [Pipeline] }
18:26:44 [2025-02-05T18:26:44.369Z] [Pipeline] // withEnv
18:26:44 [2025-02-05T18:26:44.376Z] [Pipeline] withEnv
18:26:44 [2025-02-05T18:26:44.376Z] [Pipeline] {
18:26:44 [2025-02-05T18:26:44.441Z] [Pipeline] sh
18:26:44 [2025-02-05T18:26:44.970Z] + set -euo pipefail
18:26:44 [2025-02-05T18:26:44.970Z] ++ umask
18:26:44 [2025-02-05T18:26:44.970Z] + '[' 0022 = 0000 ']'
18:26:44 [2025-02-05T18:26:44.970Z] + cd /home/jenkins/agent/workspace/test-override
18:26:44 [2025-02-05T18:26:44.970Z] + cosa shell -- mktemp -d /home/jenkins/agent/workspace/test-override/tmp/kola-XXXXX
18:26:44 [2025-02-05T18:26:44.972Z] [Pipeline] }
18:26:44 [2025-02-05T18:26:44.975Z] [Pipeline] // withEnv
18:26:45 [2025-02-05T18:26:45.050Z] [Pipeline] withEnv
18:26:45 [2025-02-05T18:26:45.051Z] [Pipeline] {
18:26:45 [2025-02-05T18:26:45.067Z] [Pipeline] sh
18:26:45 [2025-02-05T18:26:45.594Z] + set -xeuo pipefail
18:26:45 [2025-02-05T18:26:45.594Z] ++ umask
18:26:45 [2025-02-05T18:26:45.594Z] + '[' 0022 = 0000 ']'
18:26:45 [2025-02-05T18:26:45.594Z] + cd /home/jenkins/agent/workspace/test-override
18:26:45 [2025-02-05T18:26:45.594Z] + cosa kola testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-LbVns/kola-testiso-x86_64
18:26:45 [2025-02-05T18:26:45.594Z] kola -p qemu testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-LbVns/kola-testiso-x86_64
18:26:45 [2025-02-05T18:26:45.847Z] Ignoring verification of signature on metal image
18:26:45 [2025-02-05T18:26:45.847Z] Running test: iso-as-disk.bios
18:27:12 [2025-02-05T18:27:12.299Z] PASS: iso-as-disk.bios (18.103s)
18:27:12 [2025-02-05T18:27:12.299Z] Running test: iso-as-disk.uefi
18:27:38 [2025-02-05T18:27:38.750Z] PASS: iso-as-disk.uefi (22.254s)
18:27:38 [2025-02-05T18:27:38.750Z] Running test: iso-as-disk.uefi-secure
18:28:05 [2025-02-05T18:28:05.199Z] PASS: iso-as-disk.uefi-secure (23.039s)
18:28:05 [2025-02-05T18:28:05.199Z] Running test: iso-as-disk.4k.uefi
18:28:31 [2025-02-05T18:28:31.673Z] PASS: iso-as-disk.4k.uefi (22.922s)
18:28:31 [2025-02-05T18:28:31.673Z] Running test: iso-install.bios
18:32:53 [2025-02-05T18:32:53.056Z] PASS: iso-install.bios (4m8.788s)
18:32:53 [2025-02-05T18:32:53.056Z] Running test: iso-live-login.bios
18:33:25 [2025-02-05T18:33:25.588Z] The file: journal.txt does not exist
18:33:25 [2025-02-05T18:33:25.588Z] PASS: iso-live-login.bios (29.651s)
18:33:25 [2025-02-05T18:33:25.588Z] Running test: iso-live-login.uefi
18:33:52 [2025-02-05T18:33:52.052Z] The file: journal.txt does not exist
18:33:53 [2025-02-05T18:33:53.925Z] PASS: iso-live-login.uefi (26.51s)
18:33:53 [2025-02-05T18:33:53.925Z] Running test: iso-live-login.uefi-secure
18:34:25 [2025-02-05T18:34:25.899Z] The file: journal.txt does not exist
18:34:25 [2025-02-05T18:34:25.899Z] PASS: iso-live-login.uefi-secure (26.879s)
18:34:25 [2025-02-05T18:34:25.899Z] Running test: iso-live-login.4k.uefi
18:34:57 [2025-02-05T18:34:57.879Z] The file: journal.txt does not exist
18:34:57 [2025-02-05T18:34:57.879Z] PASS: iso-live-login.4k.uefi (26.164s)
18:34:57 [2025-02-05T18:34:57.879Z] Running test: iso-offline-install.bios
18:39:19 [2025-02-05T18:39:19.332Z] PASS: iso-offline-install.bios (4m10.342s)
18:39:19 [2025-02-05T18:39:19.332Z] Running test: iso-offline-install.mpath.bios
18:43:40 [2025-02-05T18:43:40.731Z] PASS: iso-offline-install.mpath.bios (4m12.234s)
18:43:40 [2025-02-05T18:43:40.731Z] Running test: iso-offline-install-fromram.4k.uefi
18:48:02 [2025-02-05T18:48:02.121Z] PASS: iso-offline-install-fromram.4k.uefi (4m7.607s)
18:48:02 [2025-02-05T18:48:02.121Z] Running test: iso-offline-install-iscsi.ibft.uefi
18:48:02 [2025-02-05T18:48:02.121Z] Warning: Cannot announce submounts, client does not support it
18:50:38 [2025-02-05T18:50:38.478Z] PASS: iso-offline-install-iscsi.ibft.uefi (2m21.097s)
18:50:38 [2025-02-05T18:50:38.478Z] Running test: iso-offline-install-iscsi.ibft-with-mpath.bios
18:52:59 [2025-02-05T18:52:59.814Z] PASS: iso-offline-install-iscsi.ibft-with-mpath.bios (2m24.46s)
18:52:59 [2025-02-05T18:52:59.815Z] Running test: iso-offline-install-iscsi.manual.bios
18:55:36 [2025-02-05T18:55:36.160Z] PASS: iso-offline-install-iscsi.manual.bios (2m28.558s)
18:55:36 [2025-02-05T18:55:36.160Z] Running test: miniso-install.bios
19:00:12 [2025-02-05T19:00:12.550Z] PASS: miniso-install.bios (4m16.385s)
19:00:12 [2025-02-05T19:00:12.550Z] Running test: miniso-install.nm.bios
19:04:48 [2025-02-05T19:04:48.941Z] PASS: miniso-install.nm.bios (4m30.618s)
19:04:48 [2025-02-05T19:04:48.941Z] Running test: miniso-install.4k.uefi
19:09:25 [2025-02-05T19:09:25.364Z] PASS: miniso-install.4k.uefi (4m22.471s)
19:09:25 [2025-02-05T19:09:25.364Z] Running test: miniso-install.4k.nm.uefi
19:14:16 [2025-02-05T19:14:16.802Z] PASS: miniso-install.4k.nm.uefi (4m29.858s)
19:14:16 [2025-02-05T19:14:16.802Z] Running test: pxe-offline-install.bios
19:18:38 [2025-02-05T19:18:38.204Z] PASS: pxe-offline-install.bios (4m23.684s)
19:18:38 [2025-02-05T19:18:38.204Z] Running test: pxe-offline-install.4k.uefi
19:23:14 [2025-02-05T19:23:14.606Z] PASS: pxe-offline-install.4k.uefi (4m22.657s)
19:23:14 [2025-02-05T19:23:14.606Z] Running test: pxe-online-install.bios
19:27:35 [2025-02-05T19:27:35.998Z] PASS: pxe-online-install.bios (4m15.061s)
19:27:35 [2025-02-05T19:27:35.998Z] Running test: pxe-online-install.4k.uefi
19:32:27 [2025-02-05T19:32:27.461Z] PASS: pxe-online-install.4k.uefi (4m33.681s)
19:32:27 [2025-02-05T19:32:27.464Z] [Pipeline] }
19:32:27 [2025-02-05T19:32:27.467Z] [Pipeline] // withEnv
19:32:27 [2025-02-05T19:32:27.548Z] [Pipeline] withEnv
19:32:27 [2025-02-05T19:32:27.549Z] [Pipeline] {
19:32:27 [2025-02-05T19:32:27.579Z] [Pipeline] sh
19:32:28 [2025-02-05T19:32:28.111Z] + set -xeuo pipefail
19:32:28 [2025-02-05T19:32:28.111Z] ++ umask
19:32:28 [2025-02-05T19:32:28.111Z] + '[' 0022 = 0000 ']'
19:32:28 [2025-02-05T19:32:28.111Z] + cd /home/jenkins/agent/workspace/test-override
19:32:28 [2025-02-05T19:32:28.111Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-LbVns -c --xz kola-testiso-x86_64
19:32:38 [2025-02-05T19:32:38.023Z] [Pipeline] }
19:32:38 [2025-02-05T19:32:38.028Z] [Pipeline] // withEnv
19:32:38 [2025-02-05T19:32:38.100Z] [Pipeline] archiveArtifacts
19:32:38 [2025-02-05T19:32:38.102Z] Archiving artifacts
19:32:39 [2025-02-05T19:32:39.278Z] [Pipeline] withEnv
19:32:39 [2025-02-05T19:32:39.280Z] [Pipeline] {
19:32:39 [2025-02-05T19:32:39.283Z] [Pipeline] sh
19:32:39 [2025-02-05T19:32:39.821Z] + set -xeuo pipefail
19:32:39 [2025-02-05T19:32:39.821Z] ++ umask
19:32:39 [2025-02-05T19:32:39.821Z] + '[' 0022 = 0000 ']'
19:32:39 [2025-02-05T19:32:39.821Z] + cd /home/jenkins/agent/workspace/test-override
19:32:39 [2025-02-05T19:32:39.821Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-testiso-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-LbVns/kola-testiso-x86_64 --output -
19:32:39 [2025-02-05T19:32:39.823Z] [Pipeline] }
19:32:39 [2025-02-05T19:32:39.825Z] [Pipeline] // withEnv
19:32:39 [2025-02-05T19:32:39.831Z] [Pipeline] junit
19:32:39 [2025-02-05T19:32:39.832Z] Recording test results
19:32:39 [2025-02-05T19:32:39.897Z] None of the test reports contained any result
19:32:39 [2025-02-05T19:32:39.897Z] [Pipeline] }
19:32:39 [2025-02-05T19:32:39.911Z] [Pipeline] // stage
19:32:39 [2025-02-05T19:32:39.956Z] [Pipeline] stage
19:32:39 [2025-02-05T19:32:39.956Z] [Pipeline] { (x86_64:Destroy Remote)
19:32:39 [2025-02-05T19:32:39.976Z] [Pipeline] }
19:32:39 [2025-02-05T19:32:39.979Z] [Pipeline] // stage
19:32:39 [2025-02-05T19:32:39.998Z] [Pipeline] }
19:32:40 [2025-02-05T19:32:40.016Z] [Pipeline] // parallel
19:32:40 [2025-02-05T19:32:40.057Z] [Pipeline] }
19:32:40 [2025-02-05T19:32:40.083Z] [Pipeline] // timeout
19:32:40 [2025-02-05T19:32:40.107Z] [Pipeline] }
19:32:40 [2025-02-05T19:32:40.144Z] [Pipeline] // container
19:32:40 [2025-02-05T19:32:40.148Z] [Pipeline] }
19:32:40 [2025-02-05T19:32:40.179Z] [Pipeline] // node
19:32:40 [2025-02-05T19:32:40.215Z] [Pipeline] }
19:32:40 [2025-02-05T19:32:40.266Z] [Pipeline] // podTemplate
19:32:40 [2025-02-05T19:32:40.289Z] [Pipeline] End of Pipeline
19:32:40 [2025-02-05T19:32:40.390Z] Finished: SUCCESS