Console Output

Skipping 349 KB.. Full Log
18:52:24 [2025-02-25T18:52:24.284Z]     --- [32mPASS[0m: basic/ReadOnly (0.11s)
18:52:24 [2025-02-25T18:52:24.284Z]     --- [32mPASS[0m: basic/Useradd (0.20s)
18:52:24 [2025-02-25T18:52:24.284Z]     --- [32mPASS[0m: basic/MachineID (0.12s)
18:52:24 [2025-02-25T18:52:24.284Z]     --- [32mPASS[0m: basic/FCOSGrowpart (0.14s)
18:52:24 [2025-02-25T18:52:24.284Z]     --- [32mPASS[0m: basic/PortSSH (0.12s)
18:52:24 [2025-02-25T18:52:24.284Z]     --- [32mPASS[0m: basic/DbusPerms (0.35s)
18:52:36 [2025-02-25T18:52:36.425Z] --- [32mPASS[0m: coreos.ignition.once (42.33s)
18:52:58 [2025-02-25T18:52:58.289Z] --- [32mPASS[0m: ext.config.toolbox (68.84s)
18:53:13 [2025-02-25T18:53:13.124Z] --- [32mPASS[0m: coreos.ignition.sethostname (36.08s)
18:53:21 [2025-02-25T18:53:21.177Z] --- [32mPASS[0m: ext.config.podman.rootless-systemd (56.43s)
18:53:25 [2025-02-25T18:53:25.329Z] --- [32mPASS[0m: ext.config.networking.no-persist-ip (29.12s)
18:53:47 [2025-02-25T18:53:47.171Z] --- [32mPASS[0m: ext.config.networking.nmstate.policy (114.58s)
18:54:09 [2025-02-25T18:54:09.009Z] --- [32mPASS[0m: ext.config.networking.mtu-on-bond-ignition (41.05s)
18:54:40 [2025-02-25T18:54:40.991Z] --- [32mPASS[0m: ext.config.var-mount.simple (56.36s)
18:54:42 [2025-02-25T18:54:42.346Z] --- [32mPASS[0m: ext.config.docker.basic (35.68s)
18:54:42 [2025-02-25T18:54:42.346Z] --- [32mPASS[0m: ext.config.systemd.condition-needs-update (91.23s)
18:55:00 [2025-02-25T18:55:00.358Z] --- [32mPASS[0m: coreos.ignition.failure (15.44s)
18:55:08 [2025-02-25T18:55:08.408Z] === RUN   podman.workflow/exec
18:55:08 [2025-02-25T18:55:08.661Z] === RUN   podman.workflow/stop
18:55:09 [2025-02-25T18:55:09.585Z] --- [32mPASS[0m: ext.config.networking.no-default-initramfs-net-propagation.bootif (28.99s)
18:55:19 [2025-02-25T18:55:19.502Z] === RUN   podman.workflow/remove
18:55:20 [2025-02-25T18:55:20.057Z] === RUN   podman.workflow/delete
18:55:24 [2025-02-25T18:55:24.200Z] --- [32mPASS[0m: coreos.unique.boot.ignition.failure (14.50s)
18:55:24 [2025-02-25T18:55:24.200Z] --- [32mPASS[0m: podman.workflow (357.18s)
18:55:24 [2025-02-25T18:55:24.200Z]     --- [32mPASS[0m: podman.workflow/run (310.60s)
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: Getting image source signatures
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: Copying blob sha256:414996200a113ee98b3f12ebfbb1778efad68e4e5767192f1928df7bfb875b3d
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: Copying config sha256:0954472fae24a5cb03525ed4f98bcad7a7f6c3a400b840a880b33117977bdedd
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: Writing manifest to image destination
18:55:24 [2025-02-25T18:55:24.200Z]     --- [32mPASS[0m: podman.workflow/exec (0.38s)
18:55:24 [2025-02-25T18:55:24.200Z]     --- [32mPASS[0m: podman.workflow/stop (10.69s)
18:55:24 [2025-02-25T18:55:24.200Z]     --- [32mPASS[0m: podman.workflow/remove (0.58s)
18:55:24 [2025-02-25T18:55:24.200Z]     --- [32mPASS[0m: podman.workflow/delete (0.69s)
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: grep: quay.io/fedora/fedora:latest: No such file or directory
18:55:24 [2025-02-25T18:55:24.200Z]             cluster.go:151: bash: line 2: Deleted:: command not found
18:55:24 [2025-02-25T18:55:24.453Z] --- [32mPASS[0m: ext.config.swap.zram-generator (26.63s)
18:55:50 [2025-02-25T18:55:50.909Z] --- [32mPASS[0m: coreos.ignition.groups (24.48s)
18:56:05 [2025-02-25T18:56:05.719Z] --- [32mPASS[0m: ext.config.boot.bootupd-validate (39.47s)
18:56:05 [2025-02-25T18:56:05.719Z] --- [32mPASS[0m: podman.network-single (165.55s)
18:56:13 [2025-02-25T18:56:13.765Z] --- [32mPASS[0m: ext.config.ignition.delete-config (90.37s)
18:56:13 [2025-02-25T18:56:13.765Z] --- [32mPASS[0m: fcos.users.shells (24.14s)
18:56:20 [2025-02-25T18:56:20.275Z] --- [32mPASS[0m: multipath.partition (55.47s)
18:56:32 [2025-02-25T18:56:32.406Z] --- [32mPASS[0m: ext.config.ssh.custom-host-key-permissions (26.97s)
18:56:38 [2025-02-25T18:56:38.918Z] --- [32mPASS[0m: ext.config.clhm.ignition-warnings (25.80s)
18:56:43 [2025-02-25T18:56:43.063Z] --- [32mPASS[0m: ext.config.networking.prefer-ignition-networking (30.09s)
18:56:44 [2025-02-25T18:56:44.414Z] --- [32mPASS[0m: coreos.ignition.v2.users (24.82s)
18:56:48 [2025-02-25T18:56:48.555Z] --- [32mPASS[0m: coreos.selinux.boolean (42.49s)
18:56:58 [2025-02-25T18:56:58.467Z] --- [32mPASS[0m: ext.config.boot.grub2-install (26.90s)
18:57:06 [2025-02-25T18:57:06.515Z] === RUN   rootfs.uuid/RandomUUID
18:57:09 [2025-02-25T18:57:09.756Z] --- [32mPASS[0m: rootfs.uuid (25.08s)
18:57:09 [2025-02-25T18:57:09.756Z]     --- [32mPASS[0m: rootfs.uuid/RandomUUID (0.20s)
18:57:14 [2025-02-25T18:57:14.979Z] --- [32mPASS[0m: ext.config.rpm-ostree-countme (26.77s)
18:57:29 [2025-02-25T18:57:29.773Z] --- [32mPASS[0m: ext.config.networking.nmstate.state (45.15s)
18:57:30 [2025-02-25T18:57:30.328Z] === RUN   podman.base/info
18:57:30 [2025-02-25T18:57:30.580Z] === RUN   podman.base/resources
18:57:32 [2025-02-25T18:57:32.452Z] --- [32mPASS[0m: ext.config.extensions.package (53.89s)
18:57:38 [2025-02-25T18:57:38.967Z] --- [32mPASS[0m: podman.base (28.67s)
18:57:38 [2025-02-25T18:57:38.967Z]     --- [32mPASS[0m: podman.base/info (0.42s)
18:57:38 [2025-02-25T18:57:38.967Z]     --- [32mPASS[0m: podman.base/resources (4.37s)
18:58:10 [2025-02-25T18:58:10.936Z] --- [32mPASS[0m: ext.config.ignition.stable-boot (38.86s)
18:58:13 [2025-02-25T18:58:13.444Z] --- [32mPASS[0m: ext.config.networking.force-persist-ip (41.04s)
18:58:14 [2025-02-25T18:58:14.001Z] --- [32mPASS[0m: ext.config.networking.ifname-karg.everyboot-systemd-link-file (59.07s)
18:58:20 [2025-02-25T18:58:20.507Z] --- [32mPASS[0m: ext.config.networking.bridge-static-via-kargs (41.35s)
18:58:52 [2025-02-25T18:58:52.499Z] --- [32mPASS[0m: kdump.crash.ssh (113.64s)
18:58:52 [2025-02-25T18:58:52.499Z]         cluster.go:151: Running as unit: run-p7134-i7135.service; invocation ID: b93b9a99c49c4833bddeab61f4ca1dd7
19:00:00 [2025-02-25T19:00:00.074Z] --- [32mPASS[0m: ext.config.kdump.crash (112.48s)
19:00:00 [2025-02-25T19:00:00.074Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-x86_64
19:00:00 [2025-02-25T19:00:00.076Z] [Pipeline] }
19:00:00 [2025-02-25T19:00:00.079Z] [Pipeline] // withEnv
19:00:00 [2025-02-25T19:00:00.093Z] [Pipeline] withEnv
19:00:00 [2025-02-25T19:00:00.093Z] [Pipeline] {
19:00:00 [2025-02-25T19:00:00.138Z] [Pipeline] sh
19:00:00 [2025-02-25T19:00:00.723Z] + set -xeuo pipefail
19:00:00 [2025-02-25T19:00:00.723Z] ++ umask
19:00:00 [2025-02-25T19:00:00.723Z] + '[' 0022 = 0000 ']'
19:00:00 [2025-02-25T19:00:00.723Z] + cd /home/jenkins/agent/workspace/test-override
19:00:00 [2025-02-25T19:00:00.723Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-reprovision-x86_64 --on-warn-failure-exit-77 --arch=x86_64 --tag=reprovision
19:00:00 [2025-02-25T19:00:00.723Z] 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-MMcnF/kola-reprovision-x86_64
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.raid1
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.luks.autosave-xfs
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.rpm-ostree.kernel-replace
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.swap-before-root
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.autosave-xfs
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.luks.512e
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   coreos.boot-mirror.luks
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.luks
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   coreos.boot-mirror
19:00:00 [2025-02-25T19:00:00.976Z] === RUN   ext.config.root-reprovision.filesystem-only
19:01:52 [2025-02-25T19:01:52.300Z] --- [32mPASS[0m: ext.config.root-reprovision.raid1 (106.81s)
19:03:28 [2025-02-25T19:03:28.629Z] === RUN   coreos.boot-mirror.luks/sanity-check
19:03:55 [2025-02-25T19:03:55.086Z] === RUN   coreos.boot-mirror.luks/detach-primary
19:04:27 [2025-02-25T19:04:27.066Z] === RUN   coreos.boot-mirror.luks/verify-fallback
19:05:05 [2025-02-25T19:05:05.689Z] --- [32mPASS[0m: coreos.boot-mirror.luks (192.74s)
19:05:05 [2025-02-25T19:05:05.689Z]     --- [32mPASS[0m: coreos.boot-mirror.luks/sanity-check (1.67s)
19:05:05 [2025-02-25T19:05:05.689Z]     --- [32mPASS[0m: coreos.boot-mirror.luks/detach-primary (30.21s)
19:05:05 [2025-02-25T19:05:05.689Z]     --- [32mPASS[0m: coreos.boot-mirror.luks/verify-fallback (0.85s)
19:06:57 [2025-02-25T19:06:57.051Z] --- [32mPASS[0m: ext.config.root-reprovision.filesystem-only (112.96s)
19:09:03 [2025-02-25T19:09:03.390Z] === RUN   coreos.boot-mirror/sanity-check
19:09:03 [2025-02-25T19:09:03.390Z] === RUN   coreos.boot-mirror/detach-primary
19:09:29 [2025-02-25T19:09:29.844Z] === RUN   coreos.boot-mirror/verify-fallback
19:09:36 [2025-02-25T19:09:36.350Z] --- [32mPASS[0m: coreos.boot-mirror (162.45s)
19:09:36 [2025-02-25T19:09:36.350Z]     --- [32mPASS[0m: coreos.boot-mirror/sanity-check (1.94s)
19:09:36 [2025-02-25T19:09:36.350Z]     --- [32mPASS[0m: coreos.boot-mirror/detach-primary (30.17s)
19:09:36 [2025-02-25T19:09:36.350Z]     --- [32mPASS[0m: coreos.boot-mirror/verify-fallback (0.86s)
19:11:42 [2025-02-25T19:11:42.689Z] --- [32mPASS[0m: ext.config.root-reprovision.luks (124.55s)
19:13:04 [2025-02-25T19:13:04.003Z] --- [32mPASS[0m: ext.config.root-reprovision.swap-before-root (81.46s)
19:15:10 [2025-02-25T19:15:10.371Z] --- [32mPASS[0m: ext.config.root-reprovision.luks.512e (124.22s)
19:16:17 [2025-02-25T19:16:17.963Z] --- [32mPASS[0m: ext.config.root-reprovision.autosave-xfs (63.93s)
19:23:24 [2025-02-25T19:23:24.443Z] --- [32mPASS[0m: ext.config.rpm-ostree.kernel-replace (419.84s)
19:25:15 [2025-02-25T19:25:15.776Z] --- [32mPASS[0m: ext.config.root-reprovision.luks.autosave-xfs (125.04s)
19:25:15 [2025-02-25T19:25:15.776Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-reprovision-x86_64
19:25:15 [2025-02-25T19:25:15.778Z] [Pipeline] }
19:25:15 [2025-02-25T19:25:15.781Z] [Pipeline] // withEnv
19:25:15 [2025-02-25T19:25:15.786Z] [Pipeline] }
19:25:15 [2025-02-25T19:25:15.843Z] [Pipeline] // parallel
19:25:15 [2025-02-25T19:25:15.862Z] [Pipeline] withEnv
19:25:15 [2025-02-25T19:25:15.862Z] [Pipeline] {
19:25:15 [2025-02-25T19:25:15.865Z] [Pipeline] sh
19:25:16 [2025-02-25T19:25:16.398Z] + set -xeuo pipefail
19:25:16 [2025-02-25T19:25:16.398Z] ++ umask
19:25:16 [2025-02-25T19:25:16.398Z] + '[' 0022 = 0000 ']'
19:25:16 [2025-02-25T19:25:16.398Z] + cd /home/jenkins/agent/workspace/test-override
19:25:16 [2025-02-25T19:25:16.398Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-upgrade-x86_64
19:25:16 [2025-02-25T19:25:16.400Z] [Pipeline] }
19:25:16 [2025-02-25T19:25:16.404Z] [Pipeline] // withEnv
19:25:16 [2025-02-25T19:25:16.409Z] [Pipeline] withEnv
19:25:16 [2025-02-25T19:25:16.409Z] [Pipeline] {
19:25:16 [2025-02-25T19:25:16.418Z] [Pipeline] sh
19:25:16 [2025-02-25T19:25:16.961Z] + set -xeuo pipefail
19:25:16 [2025-02-25T19:25:16.961Z] ++ umask
19:25:16 [2025-02-25T19:25:16.961Z] + '[' 0022 = 0000 ']'
19:25:16 [2025-02-25T19:25:16.961Z] + cd /home/jenkins/agent/workspace/test-override
19:25:16 [2025-02-25T19:25:16.961Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF -c --xz kola-upgrade-x86_64
19:25:17 [2025-02-25T19:25:17.216Z] [Pipeline] }
19:25:17 [2025-02-25T19:25:17.219Z] [Pipeline] // withEnv
19:25:17 [2025-02-25T19:25:17.268Z] [Pipeline] archiveArtifacts
19:25:17 [2025-02-25T19:25:17.278Z] Archiving artifacts
19:25:17 [2025-02-25T19:25:17.865Z] [Pipeline] withEnv
19:25:17 [2025-02-25T19:25:17.866Z] [Pipeline] {
19:25:17 [2025-02-25T19:25:17.869Z] [Pipeline] sh
19:25:18 [2025-02-25T19:25:18.400Z] + set -xeuo pipefail
19:25:18 [2025-02-25T19:25:18.400Z] ++ umask
19:25:18 [2025-02-25T19:25:18.400Z] + '[' 0022 = 0000 ']'
19:25:18 [2025-02-25T19:25:18.400Z] + cd /home/jenkins/agent/workspace/test-override
19:25:18 [2025-02-25T19:25:18.400Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-upgrade-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-upgrade-x86_64 --output -
19:25:18 [2025-02-25T19:25:18.402Z] [Pipeline] }
19:25:18 [2025-02-25T19:25:18.413Z] [Pipeline] // withEnv
19:25:18 [2025-02-25T19:25:18.416Z] [Pipeline] junit
19:25:18 [2025-02-25T19:25:18.417Z] Recording test results
19:25:19 [2025-02-25T19:25:19.026Z] None of the test reports contained any result
19:25:19 [2025-02-25T19:25:19.028Z] [Pipeline] withEnv
19:25:19 [2025-02-25T19:25:19.028Z] [Pipeline] {
19:25:19 [2025-02-25T19:25:19.038Z] [Pipeline] sh
19:25:19 [2025-02-25T19:25:19.572Z] + set -xeuo pipefail
19:25:19 [2025-02-25T19:25:19.572Z] ++ umask
19:25:19 [2025-02-25T19:25:19.572Z] + '[' 0022 = 0000 ']'
19:25:19 [2025-02-25T19:25:19.572Z] + cd /home/jenkins/agent/workspace/test-override
19:25:19 [2025-02-25T19:25:19.572Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-x86_64
19:25:19 [2025-02-25T19:25:19.574Z] [Pipeline] }
19:25:19 [2025-02-25T19:25:19.576Z] [Pipeline] // withEnv
19:25:19 [2025-02-25T19:25:19.581Z] [Pipeline] withEnv
19:25:19 [2025-02-25T19:25:19.581Z] [Pipeline] {
19:25:19 [2025-02-25T19:25:19.678Z] [Pipeline] sh
19:25:20 [2025-02-25T19:25:20.208Z] + set -xeuo pipefail
19:25:20 [2025-02-25T19:25:20.209Z] ++ umask
19:25:20 [2025-02-25T19:25:20.209Z] + '[' 0022 = 0000 ']'
19:25:20 [2025-02-25T19:25:20.209Z] + cd /home/jenkins/agent/workspace/test-override
19:25:20 [2025-02-25T19:25:20.209Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF -c --xz kola-x86_64
19:25:26 [2025-02-25T19:25:26.738Z] [Pipeline] }
19:25:26 [2025-02-25T19:25:26.741Z] [Pipeline] // withEnv
19:25:26 [2025-02-25T19:25:26.748Z] [Pipeline] archiveArtifacts
19:25:26 [2025-02-25T19:25:26.751Z] Archiving artifacts
19:25:29 [2025-02-25T19:25:29.614Z] [Pipeline] withEnv
19:25:29 [2025-02-25T19:25:29.615Z] [Pipeline] {
19:25:29 [2025-02-25T19:25:29.628Z] [Pipeline] sh
19:25:30 [2025-02-25T19:25:30.163Z] + set -xeuo pipefail
19:25:30 [2025-02-25T19:25:30.164Z] ++ umask
19:25:30 [2025-02-25T19:25:30.164Z] + '[' 0022 = 0000 ']'
19:25:30 [2025-02-25T19:25:30.164Z] + cd /home/jenkins/agent/workspace/test-override
19:25:30 [2025-02-25T19:25:30.164Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-x86_64 --output -
19:25:30 [2025-02-25T19:25:30.167Z] [Pipeline] }
19:25:30 [2025-02-25T19:25:30.169Z] [Pipeline] // withEnv
19:25:30 [2025-02-25T19:25:30.244Z] [Pipeline] junit
19:25:30 [2025-02-25T19:25:30.246Z] Recording test results
19:25:30 [2025-02-25T19:25:30.272Z] None of the test reports contained any result
19:25:30 [2025-02-25T19:25:30.283Z] [Pipeline] withEnv
19:25:30 [2025-02-25T19:25:30.283Z] [Pipeline] {
19:25:30 [2025-02-25T19:25:30.287Z] [Pipeline] sh
19:25:30 [2025-02-25T19:25:30.815Z] + set -xeuo pipefail
19:25:30 [2025-02-25T19:25:30.815Z] ++ umask
19:25:30 [2025-02-25T19:25:30.815Z] + '[' 0022 = 0000 ']'
19:25:30 [2025-02-25T19:25:30.815Z] + cd /home/jenkins/agent/workspace/test-override
19:25:30 [2025-02-25T19:25:30.815Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-reprovision-x86_64
19:25:30 [2025-02-25T19:25:30.817Z] [Pipeline] }
19:25:30 [2025-02-25T19:25:30.820Z] [Pipeline] // withEnv
19:25:30 [2025-02-25T19:25:30.825Z] [Pipeline] withEnv
19:25:30 [2025-02-25T19:25:30.836Z] [Pipeline] {
19:25:30 [2025-02-25T19:25:30.838Z] [Pipeline] sh
19:25:31 [2025-02-25T19:25:31.372Z] + set -xeuo pipefail
19:25:31 [2025-02-25T19:25:31.372Z] ++ umask
19:25:31 [2025-02-25T19:25:31.372Z] + '[' 0022 = 0000 ']'
19:25:31 [2025-02-25T19:25:31.372Z] + cd /home/jenkins/agent/workspace/test-override
19:25:31 [2025-02-25T19:25:31.372Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF -c --xz kola-reprovision-x86_64
19:25:34 [2025-02-25T19:25:34.621Z] [Pipeline] }
19:25:34 [2025-02-25T19:25:34.682Z] [Pipeline] // withEnv
19:25:34 [2025-02-25T19:25:34.718Z] [Pipeline] archiveArtifacts
19:25:34 [2025-02-25T19:25:34.720Z] Archiving artifacts
19:25:35 [2025-02-25T19:25:35.086Z] [Pipeline] withEnv
19:25:35 [2025-02-25T19:25:35.087Z] [Pipeline] {
19:25:35 [2025-02-25T19:25:35.090Z] [Pipeline] sh
19:25:35 [2025-02-25T19:25:35.635Z] + set -xeuo pipefail
19:25:35 [2025-02-25T19:25:35.636Z] ++ umask
19:25:35 [2025-02-25T19:25:35.636Z] + '[' 0022 = 0000 ']'
19:25:35 [2025-02-25T19:25:35.636Z] + cd /home/jenkins/agent/workspace/test-override
19:25:35 [2025-02-25T19:25:35.636Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-reprovision-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-MMcnF/kola-reprovision-x86_64 --output -
19:25:35 [2025-02-25T19:25:35.637Z] [Pipeline] }
19:25:35 [2025-02-25T19:25:35.640Z] [Pipeline] // withEnv
19:25:35 [2025-02-25T19:25:35.692Z] [Pipeline] junit
19:25:35 [2025-02-25T19:25:35.693Z] Recording test results
19:25:35 [2025-02-25T19:25:35.770Z] None of the test reports contained any result
19:25:35 [2025-02-25T19:25:35.773Z] [Pipeline] stage
19:25:35 [2025-02-25T19:25:35.773Z] [Pipeline] { (x86_64:Build Metal)
19:25:35 [2025-02-25T19:25:35.786Z] [Pipeline] withEnv
19:25:35 [2025-02-25T19:25:35.786Z] [Pipeline] {
19:25:35 [2025-02-25T19:25:35.816Z] [Pipeline] sh
19:25:36 [2025-02-25T19:25:36.348Z] + set -xeuo pipefail
19:25:36 [2025-02-25T19:25:36.348Z] ++ umask
19:25:36 [2025-02-25T19:25:36.348Z] + '[' 0022 = 0000 ']'
19:25:36 [2025-02-25T19:25:36.348Z] + cosa buildextend-metal
19:25:36 [2025-02-25T19:25:36.348Z] info: Missing CAP_SYS_ADMIN; using virt
19:25:36 [2025-02-25T19:25:36.602Z] Config commit: eeee9d56c54e911a516ac1dfe869082ff9ebd6f4
19:25:36 [2025-02-25T19:25:36.602Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
19:25:37 [2025-02-25T19:25:37.532Z] Will build metal
19:25:55 [2025-02-25T19:25:55.538Z] ++ arch
19:25:55 [2025-02-25T19:25:55.538Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-43.20250225.dev.0"' -D 'ostree_ref=""' -D 'ostree_repo=""' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-43.20250225.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2595 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2082 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-Pm9V.json
19:25:59 [2025-02-25T19:25:59.690Z] + set +x
19:25:59 [2025-02-25T19:25:59.690Z] + 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-Pm9V.json
19:25:59 [2025-02-25T19:25:59.690Z] [33m
19:25:59 [2025-02-25T19:25:59.690Z] Filesystem      Size  Used Avail Use% Mounted on
19:25:59 [2025-02-25T19:25:59.690Z] /dev/vdb1        40G  8.3G   32G  21% /home/jenkins/agent/workspace/test-override/cache
19:25:59 [2025-02-25T19:25:59.690Z] [39m
19:25:59 [2025-02-25T19:25:59.690Z] starting /tmp/osbuild-Pm9V.jsonPipeline source org.osbuild.curl: 5634ea2ddbed8516437c75d08ece910fd10ac01e16e5a66fbcff9d77e3edfdc1
19:25:59 [2025-02-25T19:25:59.690Z] Build
19:25:59 [2025-02-25T19:25:59.690Z]   root: <host>
19:25:59 [2025-02-25T19:25:59.943Z] 
19:25:59 [2025-02-25T19:25:59.943Z] ���  Duration: 1740511559s
19:25:59 [2025-02-25T19:25:59.943Z] Pipeline raw-metal-image: 60216bc38df0fcd6e61887facd5e7ba297d9117c28dab39e881070769842abe4
19:25:59 [2025-02-25T19:25:59.943Z] Build
19:25:59 [2025-02-25T19:25:59.943Z]   root: <host>
19:25:59 [2025-02-25T19:25:59.943Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
19:25:59 [2025-02-25T19:25:59.943Z] org.osbuild.copy: 06243bf40fc8b2815417fe685b4ac934eb16e23972e405977445498cba4d6615 {
19:25:59 [2025-02-25T19:25:59.943Z]   "paths": [
19:25:59 [2025-02-25T19:25:59.943Z]     {
19:25:59 [2025-02-25T19:25:59.943Z]       "from": "input://tree/disk.img",
19:25:59 [2025-02-25T19:25:59.943Z]       "to": "tree:///disk.img"
19:25:59 [2025-02-25T19:25:59.943Z]     }
19:25:59 [2025-02-25T19:25:59.943Z]   ]
19:25:59 [2025-02-25T19:25:59.943Z] }
19:26:00 [2025-02-25T19:26:00.196Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:00 [2025-02-25T19:26:00.196Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
19:26:00 [2025-02-25T19:26:00.450Z] 
19:26:00 [2025-02-25T19:26:00.450Z] ���  Duration: 0s
19:26:00 [2025-02-25T19:26:00.450Z] org.osbuild.coreos.platform: 60216bc38df0fcd6e61887facd5e7ba297d9117c28dab39e881070769842abe4 {
19:26:00 [2025-02-25T19:26:00.450Z]   "platform": "metal"
19:26:00 [2025-02-25T19:26:00.450Z] }
19:26:00 [2025-02-25T19:26:00.714Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:26:00 [2025-02-25T19:26:00.714Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/
19:26:00 [2025-02-25T19:26:00.714Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0'
19:26:00 [2025-02-25T19:26:00.967Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/boot
19:26:00 [2025-02-25T19:26:00.967Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:01 [2025-02-25T19:26:01.220Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/boot unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/boot unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/var unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/sysroot unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts unmounted
19:26:01 [2025-02-25T19:26:01.220Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-1s2w4wld/mounts/
19:26:01 [2025-02-25T19:26:01.473Z] 
19:26:01 [2025-02-25T19:26:01.473Z] ���  Duration: 0s
19:26:01 [2025-02-25T19:26:01.473Z] Pipeline metal: 2d115ba3f6614040c1e94fcd7aa4bb13102d25d7c37b3285fe69d6c3f95c3d07
19:26:01 [2025-02-25T19:26:01.473Z] Build
19:26:01 [2025-02-25T19:26:01.473Z]   root: <host>
19:26:01 [2025-02-25T19:26:01.473Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
19:26:01 [2025-02-25T19:26:01.473Z] org.osbuild.copy: 2d115ba3f6614040c1e94fcd7aa4bb13102d25d7c37b3285fe69d6c3f95c3d07 {
19:26:01 [2025-02-25T19:26:01.473Z]   "paths": [
19:26:01 [2025-02-25T19:26:01.473Z]     {
19:26:01 [2025-02-25T19:26:01.473Z]       "from": "input://tree/disk.img",
19:26:01 [2025-02-25T19:26:01.473Z]       "to": "tree:///fedora-coreos-43.20250225.dev.0-metal.x86_64.raw"
19:26:01 [2025-02-25T19:26:01.473Z]     }
19:26:01 [2025-02-25T19:26:01.473Z]   ]
19:26:01 [2025-02-25T19:26:01.473Z] }
19:26:01 [2025-02-25T19:26:01.473Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:01 [2025-02-25T19:26:01.726Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw'
19:26:01 [2025-02-25T19:26:01.726Z] 
19:26:01 [2025-02-25T19:26:01.726Z] ���  Duration: 0s
19:26:01 [2025-02-25T19:26:01.980Z] manifest /tmp/osbuild-Pm9V.json finished successfully
19:26:01 [2025-02-25T19:26:01.980Z] oci-archive:	ab1ea1bff160056557463318a2a9e9a826c63077fed1f92df5800e24af47f100
19:26:01 [2025-02-25T19:26:01.980Z] deployed-tree:	eb3a9ee305a25bb7bb39f2641dade3eb5eb742ea62dc8a67696a85fc9b2b2362
19:26:01 [2025-02-25T19:26:01.980Z] tree:     	702b3d45036cb3b876184cac23e20c4c9b1c55c5a4a71dd47edd592c928df0a4
19:26:01 [2025-02-25T19:26:01.980Z] raw-image:	8b30d3b8f972e47256e73dab467f37e30c3ddf8aa1945c9f017bcac61c53bed7
19:26:01 [2025-02-25T19:26:01.980Z] raw-4k-image:	f7a36fa7cef9a568bda687aa91a6c05026c6c452611bdcc7683a790173c9253a
19:26:01 [2025-02-25T19:26:01.980Z] raw-aliyun-image:	049834b16a980beee12d1b1f1f9ad31a3e7e82adb955f9d8ab8e2d681d9d1d7b
19:26:01 [2025-02-25T19:26:01.980Z] aliyun:   	368432eb702011689ccafa3743639c56b7fc31074f8ebcb6dbf5df0f2a73e0d0
19:26:01 [2025-02-25T19:26:01.980Z] raw-applehv-image:	7bbb38c4119c0ace536767532bb131331cf23e12410569b1ba84f7e68c0a82f0
19:26:01 [2025-02-25T19:26:01.980Z] applehv:  	c32c07b5cb3ce1c406123ee7a0bdba0e8bafe86bfd752bb6ece27cc2c36a82ae
19:26:01 [2025-02-25T19:26:01.980Z] raw-aws-image:	66961680621b77670ef7d0103ad23e8729a3f9431ed6374766da4f2657ce4380
19:26:01 [2025-02-25T19:26:01.980Z] aws:      	6fce6eba55c254faeb733226154dfc7ce444b1ce8eeb3bf66d04a8b1b8d7ea23
19:26:01 [2025-02-25T19:26:01.980Z] raw-azure-image:	6ddb4d54fc86c6ab25b31033c85ccbef0b01d689ea51d223b7caa98579ece6f9
19:26:01 [2025-02-25T19:26:01.980Z] azure:    	ab710fdd91fda80328285170287933192af1310e8ddc6bdd1de28b3b9e16cee6
19:26:01 [2025-02-25T19:26:01.980Z] raw-azurestack-image:	86434b5766f29e0144e12f4b80976e6da219a862b7d0bbf17d63c56038d67b13
19:26:01 [2025-02-25T19:26:01.980Z] azurestack:	e9d0be7d1e3814992b9a57e945ba4f4aaf976d6ea374807994cb657f4f65e55d
19:26:01 [2025-02-25T19:26:01.980Z] raw-digitalocean-image:	c8ddcfe07933430e0022c829b933d46b4f52c5362d2666b65a92210035292c21
19:26:01 [2025-02-25T19:26:01.980Z] digitalocean:	aa199ce02ec1813e167ccc131c3d5e89f75f9f1910df076985039fe096d44bd8
19:26:01 [2025-02-25T19:26:01.980Z] raw-exoscale-image:	66398e2fbcae64add65d2b2498a56331f85382dcda102ff9e78820ceac26577f
19:26:01 [2025-02-25T19:26:01.980Z] exoscale: 	e5367aad5b7596d37cb717b089f790165e918fd53fe5dd76d45e688d27da7a4c
19:26:01 [2025-02-25T19:26:01.980Z] raw-gcp-image:	0524f480128e15c6ccac80651f3cd7fc70ea2af49e5497667a10b2a073fd3718
19:26:01 [2025-02-25T19:26:01.980Z] raw-gcp-image-tar:	e1ea08d62ebf4f4b1cb445b5e1f90ed8b88adecd0d155b2cf6c5984a293f768d
19:26:01 [2025-02-25T19:26:01.980Z] gcp:      	78c28a80c3eef23a7d278e9f3c10cfff9190a4e3e2ef6bed0349ce5c81870fb8
19:26:01 [2025-02-25T19:26:01.980Z] raw-hetzner-image:	5c089c86cb27188954b9fec62b107e0b0007876ca795a446259db43bebb67a9b
19:26:01 [2025-02-25T19:26:01.980Z] hetzner:  	df5d06eadb4fc2fc156031845749b3cd6a7cbe7ddd2c9faa423bb5c0b6c5a01e
19:26:01 [2025-02-25T19:26:01.980Z] raw-hyperv-image:	1eabfb1824f3ce1fe0415b17e8d0263d9b0e5a7183693f49461e667c0370c11d
19:26:01 [2025-02-25T19:26:01.980Z] hyperv:   	582451195b313b84d255a0b0ca026e7526d456a22211627d8858a5541ab7c89e
19:26:01 [2025-02-25T19:26:01.980Z] raw-ibmcloud-image:	97b39bbc2338afa2c41d9af9685c2f58e5eb2ba2b8aa8703bcdc8deec4649fda
19:26:01 [2025-02-25T19:26:01.980Z] ibmcloud: 	0c63e1e840446a1b09b36c73c947d5c9a4f62017593c28568695416cc76b4435
19:26:01 [2025-02-25T19:26:01.980Z] raw-openstack-image:	a6d3646b9dbd46fdb2782d50d530a9f46867af9d3e31f6e980067cd2da480573
19:26:01 [2025-02-25T19:26:01.980Z] openstack:	0352ea9f637c5a339e1de3ea4809e946d9b7e2adb3888ba63592b9c154eae31c
19:26:01 [2025-02-25T19:26:01.980Z] raw-metal-image:	60216bc38df0fcd6e61887facd5e7ba297d9117c28dab39e881070769842abe4
19:26:01 [2025-02-25T19:26:01.980Z] metal:    	2d115ba3f6614040c1e94fcd7aa4bb13102d25d7c37b3285fe69d6c3f95c3d07
19:26:01 [2025-02-25T19:26:01.980Z] raw-metal4k-image:	db63ca23ea3b39060a6e2f72714ca1ae632d0a26a00977194b9e802e34a302aa
19:26:01 [2025-02-25T19:26:01.980Z] metal4k:  	40a4bf747ff00d0116ea024416041e9c5d51c955e1ce84ae5b2797c7b11d668d
19:26:01 [2025-02-25T19:26:01.980Z] raw-nutanix-image:	ed12d1fe108167562d3ce646c5e90410cfffe309cf90fdacfd68a80a16c71eb0
19:26:01 [2025-02-25T19:26:01.980Z] nutanix:  	91c10e46c2beec05f3014f5af32045b3488d69f3615897a7eff3c3ca16cca4de
19:26:01 [2025-02-25T19:26:01.980Z] raw-qemu-image:	72be16f91b77b7bf346e6a83bb314444277bb51e494f1adc352c38257af56431
19:26:01 [2025-02-25T19:26:01.980Z] qemu:     	19103bcddef8499a404015be87dd01a49f5633fde66309b08f239ff4beac0ce0
19:26:01 [2025-02-25T19:26:01.980Z] raw-vultr-image:	db49cacc68561d5e184a283ade77154d236a07045163e55373ceabaae5baa48b
19:26:01 [2025-02-25T19:26:01.980Z] vultr:    	5e0adfbdbe2c9d5df8936a27654526645990335405ea18b2ee4c1b96be6a1a87
19:26:01 [2025-02-25T19:26:01.980Z] live:     	64a75a1210457975596da38c3dc411750c98b6698c32bbbcf1562735a5df7ecc
19:26:01 [2025-02-25T19:26:01.980Z] + set +x
19:26:08 [2025-02-25T19:26:08.490Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.rePNVuSREY/metal/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw': Operation not permitted
19:26:08 [2025-02-25T19:26:08.490Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.rePNVuSREY/metal': Operation not permitted
19:26:14 [2025-02-25T19:26:14.999Z] /home/jenkins/agent/workspace/test-override/builds/43.20250225.dev.0/x86_64/meta.json wrote with version stamp 1740511574519683904
19:26:14 [2025-02-25T19:26:14.999Z] Successfully generated: fedora-coreos-43.20250225.dev.0-metal.x86_64.raw
19:26:15 [2025-02-25T19:26:15.001Z] [Pipeline] }
19:26:15 [2025-02-25T19:26:15.004Z] [Pipeline] // withEnv
19:26:15 [2025-02-25T19:26:15.010Z] [Pipeline] withEnv
19:26:15 [2025-02-25T19:26:15.011Z] [Pipeline] {
19:26:15 [2025-02-25T19:26:15.080Z] [Pipeline] sh
19:26:15 [2025-02-25T19:26:15.624Z] + set -xeuo pipefail
19:26:15 [2025-02-25T19:26:15.624Z] ++ umask
19:26:15 [2025-02-25T19:26:15.624Z] + '[' 0022 = 0000 ']'
19:26:15 [2025-02-25T19:26:15.624Z] + cosa buildextend-metal4k
19:26:15 [2025-02-25T19:26:15.624Z] info: Missing CAP_SYS_ADMIN; using virt
19:26:15 [2025-02-25T19:26:15.878Z] Config commit: eeee9d56c54e911a516ac1dfe869082ff9ebd6f4
19:26:15 [2025-02-25T19:26:15.881Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
19:26:16 [2025-02-25T19:26:16.801Z] Will build metal4k
19:26:34 [2025-02-25T19:26:34.807Z] ++ arch
19:26:34 [2025-02-25T19:26:34.808Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-43.20250225.dev.0"' -D 'ostree_ref=""' -D 'ostree_repo=""' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-43.20250225.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2595 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2082 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-CaMj.json
19:26:35 [2025-02-25T19:26:35.725Z] + set +x
19:26:35 [2025-02-25T19:26:35.725Z] + 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-CaMj.json
19:26:35 [2025-02-25T19:26:35.725Z] [33m
19:26:35 [2025-02-25T19:26:35.725Z] Filesystem      Size  Used Avail Use% Mounted on
19:26:35 [2025-02-25T19:26:35.725Z] /dev/vdb1        40G  8.3G   32G  21% /home/jenkins/agent/workspace/test-override/cache
19:26:35 [2025-02-25T19:26:35.725Z] [39m
19:26:36 [2025-02-25T19:26:36.281Z] starting /tmp/osbuild-CaMj.jsonPipeline source org.osbuild.curl: 5634ea2ddbed8516437c75d08ece910fd10ac01e16e5a66fbcff9d77e3edfdc1
19:26:36 [2025-02-25T19:26:36.281Z] Build
19:26:36 [2025-02-25T19:26:36.281Z]   root: <host>
19:26:36 [2025-02-25T19:26:36.281Z] 
19:26:36 [2025-02-25T19:26:36.281Z] ���  Duration: 1740511595s
19:26:36 [2025-02-25T19:26:36.281Z] Pipeline raw-4k-image: f7a36fa7cef9a568bda687aa91a6c05026c6c452611bdcc7683a790173c9253a
19:26:36 [2025-02-25T19:26:36.281Z] Build
19:26:36 [2025-02-25T19:26:36.281Z]   root: <host>
19:26:36 [2025-02-25T19:26:36.281Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
19:26:36 [2025-02-25T19:26:36.281Z] org.osbuild.truncate: 77ebf5d518bbb5f564ad745f86d784531017227e6e877c96cd8b81aeb28017ac {
19:26:36 [2025-02-25T19:26:36.281Z]   "filename": "disk.img",
19:26:36 [2025-02-25T19:26:36.281Z]   "size": "2721054720"
19:26:36 [2025-02-25T19:26:36.281Z] }
19:26:36 [2025-02-25T19:26:36.543Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:36 [2025-02-25T19:26:36.543Z] 
19:26:36 [2025-02-25T19:26:36.543Z] ���  Duration: 0s
19:26:36 [2025-02-25T19:26:36.543Z] org.osbuild.sfdisk: 0b785c375cdac7575f0a52913cf388506737045db837d77fd3a5e223978991b9 {
19:26:36 [2025-02-25T19:26:36.543Z]   "uuid": "00000000-0000-4000-a000-000000000001",
19:26:36 [2025-02-25T19:26:36.543Z]   "label": "gpt",
19:26:36 [2025-02-25T19:26:36.543Z]   "partitions": [
19:26:36 [2025-02-25T19:26:36.543Z]     {
19:26:36 [2025-02-25T19:26:36.543Z]       "start": 256,
19:26:36 [2025-02-25T19:26:36.543Z]       "partnum": 1,
19:26:36 [2025-02-25T19:26:36.543Z]       "size": 256,
19:26:36 [2025-02-25T19:26:36.543Z]       "type": "21686148-6449-6E6F-744E-656564454649",
19:26:36 [2025-02-25T19:26:36.543Z]       "bootable": true,
19:26:36 [2025-02-25T19:26:36.543Z]       "name": "BIOS-BOOT"
19:26:36 [2025-02-25T19:26:36.543Z]     },
19:26:36 [2025-02-25T19:26:36.543Z]     {
19:26:36 [2025-02-25T19:26:36.543Z]       "start": 512,
19:26:36 [2025-02-25T19:26:36.543Z]       "partnum": 2,
19:26:36 [2025-02-25T19:26:36.543Z]       "size": 32512,
19:26:36 [2025-02-25T19:26:36.543Z]       "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
19:26:36 [2025-02-25T19:26:36.543Z]       "name": "EFI-SYSTEM"
19:26:36 [2025-02-25T19:26:36.543Z]     },
19:26:36 [2025-02-25T19:26:36.796Z]     {
19:26:36 [2025-02-25T19:26:36.796Z]       "start": 33024,
19:26:36 [2025-02-25T19:26:36.796Z]       "partnum": 3,
19:26:36 [2025-02-25T19:26:36.796Z]       "size": 98304,
19:26:36 [2025-02-25T19:26:36.796Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
19:26:36 [2025-02-25T19:26:36.796Z]       "name": "boot"
19:26:36 [2025-02-25T19:26:36.796Z]     },
19:26:36 [2025-02-25T19:26:36.796Z]     {
19:26:36 [2025-02-25T19:26:36.796Z]       "start": 131328,
19:26:36 [2025-02-25T19:26:36.796Z]       "partnum": 4,
19:26:36 [2025-02-25T19:26:36.796Z]       "size": 532736,
19:26:36 [2025-02-25T19:26:36.796Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
19:26:36 [2025-02-25T19:26:36.796Z]       "name": "root"
19:26:36 [2025-02-25T19:26:36.796Z]     }
19:26:36 [2025-02-25T19:26:36.796Z]   ]
19:26:36 [2025-02-25T19:26:36.796Z] }
19:26:36 [2025-02-25T19:26:36.796Z] device/device (org.osbuild.loopback): loop0 acquired (locked: False)
19:26:37 [2025-02-25T19:26:37.048Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:37 [2025-02-25T19:26:37.048Z] label: gpt
19:26:37 [2025-02-25T19:26:37.048Z] label-id: 00000000-0000-4000-a000-000000000001
19:26:37 [2025-02-25T19:26:37.048Z] /dev/loop0p1: start="256", size="256", type="21686148-6449-6E6F-744E-656564454649", name="BIOS-BOOT", bootable
19:26:37 [2025-02-25T19:26:37.048Z] /dev/loop0p2: start="512", size="32512", type="C12A7328-F81F-11D2-BA4B-00A0C93EC93B", name="EFI-SYSTEM"
19:26:37 [2025-02-25T19:26:37.048Z] /dev/loop0p3: start="33024", size="98304", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="boot"
19:26:37 [2025-02-25T19:26:37.048Z] /dev/loop0p4: start="131328", size="532736", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="root"
19:26:37 [2025-02-25T19:26:37.048Z] {
19:26:37 [2025-02-25T19:26:37.048Z]    "partitiontable": {
19:26:37 [2025-02-25T19:26:37.048Z]       "label": "gpt",
19:26:37 [2025-02-25T19:26:37.048Z]       "id": "00000000-0000-4000-A000-000000000001",
19:26:37 [2025-02-25T19:26:37.048Z]       "device": "/dev/loop0",
19:26:37 [2025-02-25T19:26:37.048Z]       "unit": "sectors",
19:26:37 [2025-02-25T19:26:37.048Z]       "firstlba": 256,
19:26:37 [2025-02-25T19:26:37.048Z]       "lastlba": 664314,
19:26:37 [2025-02-25T19:26:37.048Z]       "sectorsize": 4096,
19:26:37 [2025-02-25T19:26:37.048Z]       "partitions": [
19:26:37 [2025-02-25T19:26:37.048Z]          {
19:26:37 [2025-02-25T19:26:37.048Z]             "node": "/dev/loop0p1",
19:26:37 [2025-02-25T19:26:37.048Z]             "start": 256,
19:26:37 [2025-02-25T19:26:37.048Z]             "size": 256,
19:26:37 [2025-02-25T19:26:37.048Z]             "type": "21686148-6449-6E6F-744E-656564454649",
19:26:37 [2025-02-25T19:26:37.048Z]             "uuid": "2D9784A5-66DE-4F0D-A249-B62518BA7F99",
19:26:37 [2025-02-25T19:26:37.048Z]             "name": "BIOS-BOOT"
19:26:37 [2025-02-25T19:26:37.048Z]          },{
19:26:37 [2025-02-25T19:26:37.048Z]             "node": "/dev/loop0p2",
19:26:37 [2025-02-25T19:26:37.048Z]             "start": 512,
19:26:37 [2025-02-25T19:26:37.048Z]             "size": 32512,
19:26:37 [2025-02-25T19:26:37.048Z]             "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
19:26:37 [2025-02-25T19:26:37.048Z]             "uuid": "F702E65B-6C19-4CAB-A0AF-AEC8B2E0D3C4",
19:26:37 [2025-02-25T19:26:37.048Z]             "name": "EFI-SYSTEM"
19:26:37 [2025-02-25T19:26:37.049Z]          },{
19:26:37 [2025-02-25T19:26:37.049Z]             "node": "/dev/loop0p3",
19:26:37 [2025-02-25T19:26:37.049Z]             "start": 33024,
19:26:37 [2025-02-25T19:26:37.049Z]             "size": 98304,
19:26:37 [2025-02-25T19:26:37.049Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
19:26:37 [2025-02-25T19:26:37.049Z]             "uuid": "C4997FF0-2753-4D0D-B48B-F881D6FF0DCA",
19:26:37 [2025-02-25T19:26:37.049Z]             "name": "boot"
19:26:37 [2025-02-25T19:26:37.049Z]          },{
19:26:37 [2025-02-25T19:26:37.049Z]             "node": "/dev/loop0p4",
19:26:37 [2025-02-25T19:26:37.049Z]             "start": 131328,
19:26:37 [2025-02-25T19:26:37.049Z]             "size": 532736,
19:26:37 [2025-02-25T19:26:37.049Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
19:26:37 [2025-02-25T19:26:37.049Z]             "uuid": "A53DDB03-8B72-4C8C-A038-0F3DCC75BC39",
19:26:37 [2025-02-25T19:26:37.049Z]             "name": "root"
19:26:37 [2025-02-25T19:26:37.049Z]          }
19:26:37 [2025-02-25T19:26:37.049Z]       ]
19:26:37 [2025-02-25T19:26:37.049Z]    }
19:26:37 [2025-02-25T19:26:37.049Z] }
19:26:37 [2025-02-25T19:26:37.049Z] 
19:26:37 [2025-02-25T19:26:37.049Z] ���  Duration: 0s
19:26:37 [2025-02-25T19:26:37.049Z] org.osbuild.mkfs.fat: ab892192be4834952923f9515927e01249bcc566bf63647a6803f6e918b0ce50 {
19:26:37 [2025-02-25T19:26:37.049Z]   "label": "EFI-SYSTEM",
19:26:37 [2025-02-25T19:26:37.049Z]   "volid": "7B7795E7"
19:26:37 [2025-02-25T19:26:37.049Z] }
19:26:37 [2025-02-25T19:26:37.301Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
19:26:37 [2025-02-25T19:26:37.301Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:37 [2025-02-25T19:26:37.554Z] mkfs.fat 4.2 (2021-01-31)
19:26:37 [2025-02-25T19:26:37.554Z] 
19:26:37 [2025-02-25T19:26:37.554Z] ���  Duration: 0s
19:26:37 [2025-02-25T19:26:37.554Z] org.osbuild.mkfs.ext4: 7cd417e7a8bbc323afa3eccb057f1e7f49847fe2bf6694ad0e266de7107896e6 {
19:26:37 [2025-02-25T19:26:37.554Z]   "uuid": "96d15588-3596-4b3c-adca-a2ff7279ea63",
19:26:37 [2025-02-25T19:26:37.554Z]   "label": "boot",
19:26:37 [2025-02-25T19:26:37.554Z]   "metadata_csum_seed": true
19:26:37 [2025-02-25T19:26:37.554Z] }
19:26:37 [2025-02-25T19:26:37.554Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
19:26:37 [2025-02-25T19:26:37.809Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:37 [2025-02-25T19:26:37.809Z] mke2fs 1.47.1 (20-May-2024)
19:26:37 [2025-02-25T19:26:37.809Z] Discarding device blocks:     0/98304           done                            
19:26:37 [2025-02-25T19:26:37.809Z] Creating filesystem with 98304 4k blocks and 98304 inodes
19:26:37 [2025-02-25T19:26:37.809Z] Filesystem UUID: 96d15588-3596-4b3c-adca-a2ff7279ea63
19:26:37 [2025-02-25T19:26:37.809Z] Superblock backups stored on blocks: 
19:26:37 [2025-02-25T19:26:37.809Z] 	32768
19:26:37 [2025-02-25T19:26:37.809Z] 
19:26:37 [2025-02-25T19:26:37.809Z] Allocating group tables: 0/3   done                            
19:26:37 [2025-02-25T19:26:37.809Z] Writing inode tables: 0/3   done                            
19:26:37 [2025-02-25T19:26:37.809Z] Creating journal (4096 blocks): done
19:26:37 [2025-02-25T19:26:37.809Z] Writing superblocks and filesystem accounting information: 0/3   done
19:26:37 [2025-02-25T19:26:37.809Z] 
19:26:37 [2025-02-25T19:26:37.809Z] 
19:26:37 [2025-02-25T19:26:37.809Z] ���  Duration: 0s
19:26:37 [2025-02-25T19:26:37.809Z] org.osbuild.mkfs.xfs: a81f738692e64996f811e4901fc4a3c51dc3ddd38dbdd36164b4b73e05a50de0 {
19:26:37 [2025-02-25T19:26:37.809Z]   "uuid": "910678ff-f77e-4a7d-8d53-86f2ac47a823",
19:26:37 [2025-02-25T19:26:37.809Z]   "label": "root"
19:26:37 [2025-02-25T19:26:37.809Z] }
19:26:38 [2025-02-25T19:26:38.062Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
19:26:38 [2025-02-25T19:26:38.062Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:38 [2025-02-25T19:26:38.062Z] meta-data=/dev/loop0             isize=512    agcount=4, agsize=133184 blks
19:26:38 [2025-02-25T19:26:38.062Z]          =                       sectsz=4096  attr=2, projid32bit=1
19:26:38 [2025-02-25T19:26:38.062Z]          =                       crc=1        finobt=1, sparse=1, rmapbt=1
19:26:38 [2025-02-25T19:26:38.062Z]          =                       reflink=1    bigtime=1 inobtcount=1 nrext64=1
19:26:38 [2025-02-25T19:26:38.062Z] data     =                       bsize=4096   blocks=532736, imaxpct=25
19:26:38 [2025-02-25T19:26:38.062Z]          =                       sunit=0      swidth=0 blks
19:26:38 [2025-02-25T19:26:38.062Z] naming   =version 2              bsize=4096   ascii-ci=0, ftype=1
19:26:38 [2025-02-25T19:26:38.062Z] log      =internal log           bsize=4096   blocks=16384, version=2
19:26:38 [2025-02-25T19:26:38.062Z]          =                       sectsz=4096  sunit=1 blks, lazy-count=1
19:26:38 [2025-02-25T19:26:38.062Z] realtime =none                   extsz=4096   blocks=0, rtextents=0
19:26:38 [2025-02-25T19:26:38.315Z] Discarding blocks...Done.
19:26:38 [2025-02-25T19:26:38.315Z] 
19:26:38 [2025-02-25T19:26:38.315Z] ���  Duration: 0s
19:26:38 [2025-02-25T19:26:38.315Z] org.osbuild.mkdir: 9c8a27680e974f711882318da85c26c3f8713989e2377a08005e1a1314ec88f6 {
19:26:38 [2025-02-25T19:26:38.315Z]   "paths": [
19:26:38 [2025-02-25T19:26:38.315Z]     {
19:26:38 [2025-02-25T19:26:38.315Z]       "path": "mount://root/boot",
19:26:38 [2025-02-25T19:26:38.315Z]       "mode": 493
19:26:38 [2025-02-25T19:26:38.315Z]     },
19:26:38 [2025-02-25T19:26:38.315Z]     {
19:26:38 [2025-02-25T19:26:38.315Z]       "path": "mount://boot/efi",
19:26:38 [2025-02-25T19:26:38.315Z]       "mode": 493
19:26:38 [2025-02-25T19:26:38.315Z]     }
19:26:38 [2025-02-25T19:26:38.315Z]   ]
19:26:38 [2025-02-25T19:26:38.315Z] }
19:26:38 [2025-02-25T19:26:38.315Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:26:38 [2025-02-25T19:26:38.567Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-eyrzas5x/mounts/root-mount-point
19:26:38 [2025-02-25T19:26:38.567Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-eyrzas5x/mounts/boot-mount-point
19:26:38 [2025-02-25T19:26:38.567Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:38 [2025-02-25T19:26:38.820Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-eyrzas5x/mounts/boot-mount-point unmounted
19:26:38 [2025-02-25T19:26:38.820Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-eyrzas5x/mounts/root-mount-point unmounted
19:26:38 [2025-02-25T19:26:38.820Z] 
19:26:38 [2025-02-25T19:26:38.820Z] ���  Duration: 0s
19:26:38 [2025-02-25T19:26:38.820Z] org.osbuild.selinux: 236dc12dd70f411800ebb347c148b08add78bbd08797e735aa5b22f340a268e9 {
19:26:38 [2025-02-25T19:26:38.820Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
19:26:38 [2025-02-25T19:26:38.820Z]   "target": "mount://root/"
19:26:38 [2025-02-25T19:26:38.820Z] }
19:26:39 [2025-02-25T19:26:39.074Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:26:39 [2025-02-25T19:26:39.074Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qa4nccfu/mounts/
19:26:39 [2025-02-25T19:26:39.327Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:39 [2025-02-25T19:26:39.327Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.bin:  line 1 error due to: Non-ASCII characters found
19:26:39 [2025-02-25T19:26:39.327Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.homedirs.bin:  line 1 error due to: Non-ASCII characters found
19:26:39 [2025-02-25T19:26:39.327Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qa4nccfu/mounts/ unmounted
19:26:39 [2025-02-25T19:26:39.589Z] 
19:26:39 [2025-02-25T19:26:39.589Z] ���  Duration: 0s
19:26:39 [2025-02-25T19:26:39.589Z] org.osbuild.selinux: f2151653c7ff5235fd9f51c8baf2287b9d4fb70db167a90e0d325b470ded3924 {
19:26:39 [2025-02-25T19:26:39.589Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
19:26:39 [2025-02-25T19:26:39.589Z]   "target": "mount://root/boot/"
19:26:39 [2025-02-25T19:26:39.589Z] }
19:26:39 [2025-02-25T19:26:39.589Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:26:39 [2025-02-25T19:26:39.842Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-l4lldy0f/mounts/
19:26:39 [2025-02-25T19:26:39.842Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-l4lldy0f/mounts/boot
19:26:40 [2025-02-25T19:26:40.095Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:40 [2025-02-25T19:26:40.095Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.bin:  line 1 error due to: Non-ASCII characters found
19:26:40 [2025-02-25T19:26:40.095Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.homedirs.bin:  line 1 error due to: Non-ASCII characters found
19:26:40 [2025-02-25T19:26:40.095Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-l4lldy0f/mounts/boot unmounted
19:26:40 [2025-02-25T19:26:40.095Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-l4lldy0f/mounts/ unmounted
19:26:40 [2025-02-25T19:26:40.095Z] 
19:26:40 [2025-02-25T19:26:40.095Z] ���  Duration: 0s
19:26:40 [2025-02-25T19:26:40.095Z] org.osbuild.copy: 4e3cce2d2e94ee2b5231564946e5bc348c3c663d27bfb9b7c74619725d5783b5 {
19:26:40 [2025-02-25T19:26:40.095Z]   "paths": [
19:26:40 [2025-02-25T19:26:40.095Z]     {
19:26:40 [2025-02-25T19:26:40.095Z]       "from": "input://tree/",
19:26:40 [2025-02-25T19:26:40.095Z]       "to": "mount://root/"
19:26:40 [2025-02-25T19:26:40.095Z]     }
19:26:40 [2025-02-25T19:26:40.095Z]   ]
19:26:40 [2025-02-25T19:26:40.095Z] }
19:26:40 [2025-02-25T19:26:40.349Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:26:40 [2025-02-25T19:26:40.349Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-95jjrf65/mounts/
19:26:40 [2025-02-25T19:26:40.602Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-95jjrf65/mounts/boot
19:26:40 [2025-02-25T19:26:40.602Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-95jjrf65/mounts/boot/efi
19:26:40 [2025-02-25T19:26:40.855Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:26:40 [2025-02-25T19:26:40.856Z] copying '/run/osbuild/inputs/tree/.' -> '/run/osbuild/mounts/.'
19:26:46 [2025-02-25T19:26:46.083Z] [33m
19:26:46 [2025-02-25T19:26:46.083Z] Filesystem      Size  Used Avail Use% Mounted on
19:26:46 [2025-02-25T19:26:46.083Z] /dev/vdb1        40G  8.6G   32G  22% /home/jenkins/agent/workspace/test-override/cache
19:26:46 [2025-02-25T19:26:46.083Z] [39m
19:26:56 [2025-02-25T19:26:56.011Z] [33m
19:26:56 [2025-02-25T19:26:56.011Z] Filesystem      Size  Used Avail Use% Mounted on
19:26:56 [2025-02-25T19:26:56.011Z] /dev/vdb1        40G  9.4G   31G  24% /home/jenkins/agent/workspace/test-override/cache
19:26:56 [2025-02-25T19:26:56.011Z] [39m
19:27:05 [2025-02-25T19:27:05.935Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-95jjrf65/mounts/boot/efi unmounted
19:27:05 [2025-02-25T19:27:05.935Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-95jjrf65/mounts/boot unmounted
19:27:05 [2025-02-25T19:27:05.935Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-95jjrf65/mounts/ unmounted
19:27:05 [2025-02-25T19:27:05.935Z] 
19:27:05 [2025-02-25T19:27:05.935Z] ���  Duration: 25s
19:27:05 [2025-02-25T19:27:05.935Z] org.osbuild.bootupd: e1316e34be428a9f8db474008ac299d7128da8eccfcac304570ed7bfa43bab1b {
19:27:05 [2025-02-25T19:27:05.935Z]   "static-configs": true,
19:27:05 [2025-02-25T19:27:05.935Z]   "deployment": {
19:27:05 [2025-02-25T19:27:05.935Z]     "default": true
19:27:05 [2025-02-25T19:27:05.935Z]   }
19:27:05 [2025-02-25T19:27:05.935Z] }
19:27:05 [2025-02-25T19:27:05.935Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:27:05 [2025-02-25T19:27:05.935Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-m3f8b1bn/mounts/
19:27:05 [2025-02-25T19:27:05.935Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-m3f8b1bn/mounts/boot
19:27:05 [2025-02-25T19:27:05.935Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-m3f8b1bn/mounts/boot/efi
19:27:05 [2025-02-25T19:27:05.935Z] [33m
19:27:05 [2025-02-25T19:27:05.935Z] Filesystem      Size  Used Avail Use% Mounted on
19:27:05 [2025-02-25T19:27:05.935Z] /dev/vdb1        40G   10G   31G  25% /home/jenkins/agent/workspace/test-override/cache
19:27:05 [2025-02-25T19:27:05.935Z] [39m
19:27:05 [2025-02-25T19:27:05.935Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:27:06 [2025-02-25T19:27:06.188Z] Skip installing component BIOS without target device
19:27:06 [2025-02-25T19:27:06.188Z] Installed 40_coreos-ignition.cfg
19:27:06 [2025-02-25T19:27:06.188Z] Installed 70_coreos-user.cfg
19:27:06 [2025-02-25T19:27:06.188Z] Installed: grub.cfg
19:27:06 [2025-02-25T19:27:06.188Z] Installed: "fedora/grub.cfg"
19:27:06 [2025-02-25T19:27:06.188Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-m3f8b1bn/mounts/boot/efi unmounted
19:27:06 [2025-02-25T19:27:06.188Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-m3f8b1bn/mounts/boot unmounted
19:27:06 [2025-02-25T19:27:06.188Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-m3f8b1bn/mounts/ unmounted
19:27:06 [2025-02-25T19:27:06.441Z] 
19:27:06 [2025-02-25T19:27:06.441Z] ���  Duration: 0s
19:27:06 [2025-02-25T19:27:06.441Z] org.osbuild.chattr: f7a36fa7cef9a568bda687aa91a6c05026c6c452611bdcc7683a790173c9253a {
19:27:06 [2025-02-25T19:27:06.441Z]   "items": {
19:27:06 [2025-02-25T19:27:06.441Z]     "mount://root/": {
19:27:06 [2025-02-25T19:27:06.441Z]       "immutable": true
19:27:06 [2025-02-25T19:27:06.441Z]     }
19:27:06 [2025-02-25T19:27:06.441Z]   }
19:27:06 [2025-02-25T19:27:06.441Z] }
19:27:06 [2025-02-25T19:27:06.441Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:27:06 [2025-02-25T19:27:06.441Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts/
19:27:06 [2025-02-25T19:27:06.694Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0'
19:27:06 [2025-02-25T19:27:06.694Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts/boot unmounted
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts/var unmounted
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts/sysroot unmounted
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts unmounted
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts unmounted
19:27:06 [2025-02-25T19:27:06.946Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts unmounted
19:27:06 [2025-02-25T19:27:06.946Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-ez1sra9k/mounts/
19:27:06 [2025-02-25T19:27:06.946Z] 
19:27:06 [2025-02-25T19:27:06.946Z] ���  Duration: 0s
19:27:06 [2025-02-25T19:27:06.946Z] Pipeline raw-metal4k-image: db63ca23ea3b39060a6e2f72714ca1ae632d0a26a00977194b9e802e34a302aa
19:27:06 [2025-02-25T19:27:06.946Z] Build
19:27:06 [2025-02-25T19:27:06.946Z]   root: <host>
19:27:06 [2025-02-25T19:27:06.946Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
19:27:06 [2025-02-25T19:27:06.946Z] org.osbuild.copy: fd2306645fa8551b2859a908fce904e0e8121f68085f8245308b49dc432215ac {
19:27:06 [2025-02-25T19:27:06.946Z]   "paths": [
19:27:06 [2025-02-25T19:27:06.946Z]     {
19:27:06 [2025-02-25T19:27:06.946Z]       "from": "input://tree/disk.img",
19:27:06 [2025-02-25T19:27:06.946Z]       "to": "tree:///disk.img"
19:27:06 [2025-02-25T19:27:06.946Z]     }
19:27:06 [2025-02-25T19:27:06.946Z]   ]
19:27:06 [2025-02-25T19:27:06.946Z] }
19:27:07 [2025-02-25T19:27:07.199Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:27:07 [2025-02-25T19:27:07.199Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
19:27:07 [2025-02-25T19:27:07.451Z] 
19:27:07 [2025-02-25T19:27:07.451Z] ���  Duration: 0s
19:27:07 [2025-02-25T19:27:07.451Z] org.osbuild.coreos.platform: db63ca23ea3b39060a6e2f72714ca1ae632d0a26a00977194b9e802e34a302aa {
19:27:07 [2025-02-25T19:27:07.451Z]   "platform": "metal"
19:27:07 [2025-02-25T19:27:07.451Z] }
19:27:07 [2025-02-25T19:27:07.451Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
19:27:07 [2025-02-25T19:27:07.451Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/
19:27:07 [2025-02-25T19:27:07.706Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0'
19:27:07 [2025-02-25T19:27:07.706Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/boot
19:27:07 [2025-02-25T19:27:07.958Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:27:07 [2025-02-25T19:27:07.958Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/boot unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/boot unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/var unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/sysroot unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts unmounted
19:27:07 [2025-02-25T19:27:07.959Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-t6ac3a9q/mounts/
19:27:07 [2025-02-25T19:27:07.959Z] 
19:27:07 [2025-02-25T19:27:07.959Z] ���  Duration: 0s
19:27:07 [2025-02-25T19:27:07.959Z] Pipeline metal4k: 40a4bf747ff00d0116ea024416041e9c5d51c955e1ce84ae5b2797c7b11d668d
19:27:07 [2025-02-25T19:27:07.959Z] Build
19:27:07 [2025-02-25T19:27:07.959Z]   root: <host>
19:27:07 [2025-02-25T19:27:07.959Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
19:27:07 [2025-02-25T19:27:07.959Z] org.osbuild.copy: 40a4bf747ff00d0116ea024416041e9c5d51c955e1ce84ae5b2797c7b11d668d {
19:27:07 [2025-02-25T19:27:07.959Z]   "paths": [
19:27:07 [2025-02-25T19:27:07.959Z]     {
19:27:07 [2025-02-25T19:27:07.959Z]       "from": "input://tree/disk.img",
19:27:07 [2025-02-25T19:27:07.959Z]       "to": "tree:///fedora-coreos-43.20250225.dev.0-metal4k.x86_64.raw"
19:27:07 [2025-02-25T19:27:07.959Z]     }
19:27:07 [2025-02-25T19:27:07.959Z]   ]
19:27:07 [2025-02-25T19:27:07.959Z] }
19:27:08 [2025-02-25T19:27:08.211Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
19:27:08 [2025-02-25T19:27:08.463Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-43.20250225.dev.0-metal4k.x86_64.raw'
19:27:08 [2025-02-25T19:27:08.463Z] 
19:27:08 [2025-02-25T19:27:08.463Z] ���  Duration: 0s
19:27:08 [2025-02-25T19:27:08.463Z] manifest /tmp/osbuild-CaMj.json finished successfully
19:27:08 [2025-02-25T19:27:08.716Z] oci-archive:	ab1ea1bff160056557463318a2a9e9a826c63077fed1f92df5800e24af47f100
19:27:08 [2025-02-25T19:27:08.716Z] deployed-tree:	eb3a9ee305a25bb7bb39f2641dade3eb5eb742ea62dc8a67696a85fc9b2b2362
19:27:08 [2025-02-25T19:27:08.716Z] tree:     	702b3d45036cb3b876184cac23e20c4c9b1c55c5a4a71dd47edd592c928df0a4
19:27:08 [2025-02-25T19:27:08.716Z] raw-image:	8b30d3b8f972e47256e73dab467f37e30c3ddf8aa1945c9f017bcac61c53bed7
19:27:08 [2025-02-25T19:27:08.716Z] raw-4k-image:	f7a36fa7cef9a568bda687aa91a6c05026c6c452611bdcc7683a790173c9253a
19:27:08 [2025-02-25T19:27:08.716Z] raw-aliyun-image:	049834b16a980beee12d1b1f1f9ad31a3e7e82adb955f9d8ab8e2d681d9d1d7b
19:27:08 [2025-02-25T19:27:08.716Z] aliyun:   	368432eb702011689ccafa3743639c56b7fc31074f8ebcb6dbf5df0f2a73e0d0
19:27:08 [2025-02-25T19:27:08.716Z] raw-applehv-image:	7bbb38c4119c0ace536767532bb131331cf23e12410569b1ba84f7e68c0a82f0
19:27:08 [2025-02-25T19:27:08.716Z] applehv:  	c32c07b5cb3ce1c406123ee7a0bdba0e8bafe86bfd752bb6ece27cc2c36a82ae
19:27:08 [2025-02-25T19:27:08.716Z] raw-aws-image:	66961680621b77670ef7d0103ad23e8729a3f9431ed6374766da4f2657ce4380
19:27:08 [2025-02-25T19:27:08.716Z] aws:      	6fce6eba55c254faeb733226154dfc7ce444b1ce8eeb3bf66d04a8b1b8d7ea23
19:27:08 [2025-02-25T19:27:08.716Z] raw-azure-image:	6ddb4d54fc86c6ab25b31033c85ccbef0b01d689ea51d223b7caa98579ece6f9
19:27:08 [2025-02-25T19:27:08.716Z] azure:    	ab710fdd91fda80328285170287933192af1310e8ddc6bdd1de28b3b9e16cee6
19:27:08 [2025-02-25T19:27:08.716Z] raw-azurestack-image:	86434b5766f29e0144e12f4b80976e6da219a862b7d0bbf17d63c56038d67b13
19:27:08 [2025-02-25T19:27:08.716Z] azurestack:	e9d0be7d1e3814992b9a57e945ba4f4aaf976d6ea374807994cb657f4f65e55d
19:27:08 [2025-02-25T19:27:08.716Z] raw-digitalocean-image:	c8ddcfe07933430e0022c829b933d46b4f52c5362d2666b65a92210035292c21
19:27:08 [2025-02-25T19:27:08.716Z] digitalocean:	aa199ce02ec1813e167ccc131c3d5e89f75f9f1910df076985039fe096d44bd8
19:27:08 [2025-02-25T19:27:08.716Z] raw-exoscale-image:	66398e2fbcae64add65d2b2498a56331f85382dcda102ff9e78820ceac26577f
19:27:08 [2025-02-25T19:27:08.716Z] exoscale: 	e5367aad5b7596d37cb717b089f790165e918fd53fe5dd76d45e688d27da7a4c
19:27:08 [2025-02-25T19:27:08.716Z] raw-gcp-image:	0524f480128e15c6ccac80651f3cd7fc70ea2af49e5497667a10b2a073fd3718
19:27:08 [2025-02-25T19:27:08.716Z] raw-gcp-image-tar:	e1ea08d62ebf4f4b1cb445b5e1f90ed8b88adecd0d155b2cf6c5984a293f768d
19:27:08 [2025-02-25T19:27:08.716Z] gcp:      	78c28a80c3eef23a7d278e9f3c10cfff9190a4e3e2ef6bed0349ce5c81870fb8
19:27:08 [2025-02-25T19:27:08.716Z] raw-hetzner-image:	5c089c86cb27188954b9fec62b107e0b0007876ca795a446259db43bebb67a9b
19:27:08 [2025-02-25T19:27:08.716Z] hetzner:  	df5d06eadb4fc2fc156031845749b3cd6a7cbe7ddd2c9faa423bb5c0b6c5a01e
19:27:08 [2025-02-25T19:27:08.716Z] raw-hyperv-image:	1eabfb1824f3ce1fe0415b17e8d0263d9b0e5a7183693f49461e667c0370c11d
19:27:08 [2025-02-25T19:27:08.716Z] hyperv:   	582451195b313b84d255a0b0ca026e7526d456a22211627d8858a5541ab7c89e
19:27:08 [2025-02-25T19:27:08.716Z] raw-ibmcloud-image:	97b39bbc2338afa2c41d9af9685c2f58e5eb2ba2b8aa8703bcdc8deec4649fda
19:27:08 [2025-02-25T19:27:08.716Z] ibmcloud: 	0c63e1e840446a1b09b36c73c947d5c9a4f62017593c28568695416cc76b4435
19:27:08 [2025-02-25T19:27:08.716Z] raw-openstack-image:	a6d3646b9dbd46fdb2782d50d530a9f46867af9d3e31f6e980067cd2da480573
19:27:08 [2025-02-25T19:27:08.716Z] openstack:	0352ea9f637c5a339e1de3ea4809e946d9b7e2adb3888ba63592b9c154eae31c
19:27:08 [2025-02-25T19:27:08.716Z] raw-metal-image:	60216bc38df0fcd6e61887facd5e7ba297d9117c28dab39e881070769842abe4
19:27:08 [2025-02-25T19:27:08.716Z] metal:    	2d115ba3f6614040c1e94fcd7aa4bb13102d25d7c37b3285fe69d6c3f95c3d07
19:27:08 [2025-02-25T19:27:08.716Z] raw-metal4k-image:	db63ca23ea3b39060a6e2f72714ca1ae632d0a26a00977194b9e802e34a302aa
19:27:08 [2025-02-25T19:27:08.716Z] metal4k:  	40a4bf747ff00d0116ea024416041e9c5d51c955e1ce84ae5b2797c7b11d668d
19:27:08 [2025-02-25T19:27:08.716Z] raw-nutanix-image:	ed12d1fe108167562d3ce646c5e90410cfffe309cf90fdacfd68a80a16c71eb0
19:27:08 [2025-02-25T19:27:08.716Z] nutanix:  	91c10e46c2beec05f3014f5af32045b3488d69f3615897a7eff3c3ca16cca4de
19:27:08 [2025-02-25T19:27:08.716Z] raw-qemu-image:	72be16f91b77b7bf346e6a83bb314444277bb51e494f1adc352c38257af56431
19:27:08 [2025-02-25T19:27:08.716Z] qemu:     	19103bcddef8499a404015be87dd01a49f5633fde66309b08f239ff4beac0ce0
19:27:08 [2025-02-25T19:27:08.716Z] raw-vultr-image:	db49cacc68561d5e184a283ade77154d236a07045163e55373ceabaae5baa48b
19:27:08 [2025-02-25T19:27:08.716Z] vultr:    	5e0adfbdbe2c9d5df8936a27654526645990335405ea18b2ee4c1b96be6a1a87
19:27:08 [2025-02-25T19:27:08.716Z] live:     	64a75a1210457975596da38c3dc411750c98b6698c32bbbcf1562735a5df7ecc
19:27:08 [2025-02-25T19:27:08.716Z] + set +x
19:27:12 [2025-02-25T19:27:12.861Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.SKD82qCyS2/metal4k/fedora-coreos-43.20250225.dev.0-metal4k.x86_64.raw': Operation not permitted
19:27:12 [2025-02-25T19:27:12.861Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.SKD82qCyS2/metal4k': Operation not permitted
19:27:22 [2025-02-25T19:27:22.768Z] /home/jenkins/agent/workspace/test-override/builds/43.20250225.dev.0/x86_64/meta.json wrote with version stamp 1740511642106583936
19:27:22 [2025-02-25T19:27:22.768Z] Successfully generated: fedora-coreos-43.20250225.dev.0-metal4k.x86_64.raw
19:27:22 [2025-02-25T19:27:22.770Z] [Pipeline] }
19:27:22 [2025-02-25T19:27:22.773Z] [Pipeline] // withEnv
19:27:22 [2025-02-25T19:27:22.833Z] [Pipeline] }
19:27:22 [2025-02-25T19:27:22.874Z] [Pipeline] // stage
19:27:22 [2025-02-25T19:27:22.923Z] [Pipeline] stage
19:27:22 [2025-02-25T19:27:22.924Z] [Pipeline] { (x86_64:Build Live)
19:27:23 [2025-02-25T19:27:23.001Z] [Pipeline] withEnv
19:27:23 [2025-02-25T19:27:23.001Z] [Pipeline] {
19:27:23 [2025-02-25T19:27:23.021Z] [Pipeline] sh
19:27:23 [2025-02-25T19:27:23.576Z] + set -xeuo pipefail
19:27:23 [2025-02-25T19:27:23.576Z] ++ umask
19:27:23 [2025-02-25T19:27:23.576Z] + '[' 0022 = 0000 ']'
19:27:23 [2025-02-25T19:27:23.576Z] + cosa buildextend-live --fast
19:27:23 [2025-02-25T19:27:23.576Z] Targeting build: 43.20250225.dev.0
19:27:23 [2025-02-25T19:27:23.830Z] 2025-02-25 19:27:23,635 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '67ae3e067083eb23bcb47e3b390331728df448965967579116db078dce21a815', '/usr/lib/modules']
19:27:23 [2025-02-25T19:27:23.830Z] 2025-02-25 19:27:23,646 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.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64/vmlinuz', '67ae3e067083eb23bcb47e3b390331728df448965967579116db078dce21a815', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
19:27:23 [2025-02-25T19:27:23.830Z] 2025-02-25 19:27:23,693 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.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64/initramfs.img', '67ae3e067083eb23bcb47e3b390331728df448965967579116db078dce21a815', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
19:27:24 [2025-02-25T19:27:24.083Z] 2025-02-25 19:27:23,894 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '67ae3e067083eb23bcb47e3b390331728df448965967579116db078dce21a815', '/usr/share/coreos-installer/example-config.yaml']
19:27:24 [2025-02-25T19:27:24.083Z] 2025-02-25 19:27:23,911 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '67ae3e067083eb23bcb47e3b390331728df448965967579116db078dce21a815', '/tmp/tmpl28ag1m5']
19:27:24 [2025-02-25T19:27:24.083Z] Generating osmet file for 512b metal image
19:27:24 [2025-02-25T19:27:24.083Z] 2025-02-25 19:27:23,928 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43.20250225.dev.0', '--checksum', 'dd4b3f9bb64f4f385a88feaee20c61dd56cad567399b1424559980bf58ff04e4', '--output', '/var/tmp/coreos-installer-output', '--fast']
19:27:42 [2025-02-25T19:27:42.097Z] + RUST_BACKTRACE=full
19:27:42 [2025-02-25T19:27:42.097Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43.20250225.dev.0' --checksum dd4b3f9bb64f4f385a88feaee20c61dd56cad567399b1424559980bf58ff04e4 --output /var/tmp/coreos-installer-output --fast
19:27:42 [2025-02-25T19:27:42.097Z] Total OSTree objects scanned from /root: 17881 (17875 mapped, 6 empty)
19:27:42 [2025-02-25T19:27:42.097Z] Total OSTree objects found in /boot: 317
19:27:42 [2025-02-25T19:27:42.097Z] Duplicate extents dropped: 0
19:27:42 [2025-02-25T19:27:42.097Z] Overlapping extents clamped: 0
19:27:42 [2025-02-25T19:27:42.097Z] Total /root extents: 17875
19:27:42 [2025-02-25T19:27:42.097Z] Duplicate extents dropped: 0
19:27:42 [2025-02-25T19:27:42.097Z] Overlapping extents clamped: 0
19:27:42 [2025-02-25T19:27:42.097Z] Total /boot extents: 322
19:27:42 [2025-02-25T19:27:42.097Z] Packing image
19:28:00 [2025-02-25T19:28:00.104Z] Total bytes skipped: 1640390656
19:28:00 [2025-02-25T19:28:00.104Z] Total bytes written: 1080664064
19:28:00 [2025-02-25T19:28:00.104Z] Total bytes written (compressed): 25302964
19:28:00 [2025-02-25T19:28:00.104Z] Verifying that repacked image matches digest
19:28:06 [2025-02-25T19:28:06.608Z] Packing successful!
19:28:06 [2025-02-25T19:28:06.608Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:28:06 [2025-02-25T19:28:06.608Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
19:28:09 [2025-02-25T19:28:09.103Z] Generating osmet file for 4k metal image
19:28:09 [2025-02-25T19:28:09.103Z] 2025-02-25 19:28:08,856 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-43.20250225.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43.20250225.dev.0', '--checksum', 'a377b1c0230fa3bf1c99fa2902b1789530fb908f43bd701ea6901f921aa34cd3', '--output', '/var/tmp/coreos-installer-output', '--fast']
19:28:27 [2025-02-25T19:28:27.104Z] + RUST_BACKTRACE=full
19:28:27 [2025-02-25T19:28:27.104Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43.20250225.dev.0' --checksum a377b1c0230fa3bf1c99fa2902b1789530fb908f43bd701ea6901f921aa34cd3 --output /var/tmp/coreos-installer-output --fast
19:28:27 [2025-02-25T19:28:27.104Z] Total OSTree objects scanned from /root: 17881 (17875 mapped, 6 empty)
19:28:27 [2025-02-25T19:28:27.104Z] Total OSTree objects found in /boot: 3
19:28:27 [2025-02-25T19:28:27.104Z] Duplicate extents dropped: 0
19:28:27 [2025-02-25T19:28:27.104Z] Overlapping extents clamped: 0
19:28:27 [2025-02-25T19:28:27.104Z] Total /root extents: 17875
19:28:27 [2025-02-25T19:28:27.104Z] Duplicate extents dropped: 0
19:28:27 [2025-02-25T19:28:27.104Z] Overlapping extents clamped: 0
19:28:27 [2025-02-25T19:28:27.104Z] Total /boot extents: 4
19:28:27 [2025-02-25T19:28:27.104Z] Packing image
19:28:42 [2025-02-25T19:28:42.089Z] Total bytes skipped: 1629515776
19:28:42 [2025-02-25T19:28:42.089Z] Total bytes written: 1091538944
19:28:42 [2025-02-25T19:28:42.089Z] Total bytes written (compressed): 25448296
19:28:42 [2025-02-25T19:28:42.089Z] Verifying that repacked image matches digest
19:28:48 [2025-02-25T19:28:48.605Z] Packing successful!
19:28:48 [2025-02-25T19:28:48.605Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:28:48 [2025-02-25T19:28:48.605Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
19:28:50 [2025-02-25T19:28:50.480Z] Compressing squashfs with lz4
19:28:50 [2025-02-25T19:28:50.480Z] 2025-02-25 19:28:50,389 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
19:28:50 [2025-02-25T19:28:50.734Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
19:28:50 [2025-02-25T19:28:50.734Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
19:28:50 [2025-02-25T19:28:50.734Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO
19:28:50 [2025-02-25T19:28:50.734Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/image.squashfs
19:28:50 [2025-02-25T19:28:50.734Z] + coreos_gf_run_mount builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:28:50 [2025-02-25T19:28:50.734Z] + local mntarg=mount
19:28:50 [2025-02-25T19:28:50.734Z] + '[' builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw = ro ']'
19:28:50 [2025-02-25T19:28:50.734Z] + coreos_gf_run builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:28:50 [2025-02-25T19:28:50.734Z] + '[' -n '' ']'
19:28:50 [2025-02-25T19:28:50.734Z] + coreos_gf_launch builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:28:50 [2025-02-25T19:28:50.734Z] + '[' -n '' ']'
19:28:50 [2025-02-25T19:28:50.734Z] ++ guestfish --listen -a builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:28:50 [2025-02-25T19:28:50.734Z] + eval 'GUESTFISH_PID=12472; export GUESTFISH_PID'
19:28:50 [2025-02-25T19:28:50.734Z] ++ GUESTFISH_PID=12472
19:28:50 [2025-02-25T19:28:50.734Z] ++ export GUESTFISH_PID
19:28:50 [2025-02-25T19:28:50.734Z] + '[' -z 12472 ']'
19:28:50 [2025-02-25T19:28:50.734Z] ++ kola ncpu
19:28:50 [2025-02-25T19:28:50.734Z] + coreos_gf set-smp 6
19:28:50 [2025-02-25T19:28:50.734Z] + guestfish --remote -- set-smp 6
19:28:50 [2025-02-25T19:28:50.734Z] + coreos_gf run
19:28:50 [2025-02-25T19:28:50.734Z] + guestfish --remote -- run
19:28:52 [2025-02-25T19:28:52.619Z] + GUESTFISH_RUNNING=1
19:28:52 [2025-02-25T19:28:52.619Z] ++ coreos_gf findfs-label root
19:28:52 [2025-02-25T19:28:52.619Z] ++ guestfish --remote -- findfs-label root
19:28:52 [2025-02-25T19:28:52.619Z] + root=/dev/sda4
19:28:52 [2025-02-25T19:28:52.619Z] + coreos_gf mount /dev/sda4 /
19:28:52 [2025-02-25T19:28:52.619Z] + guestfish --remote -- mount /dev/sda4 /
19:28:52 [2025-02-25T19:28:52.871Z] + local boot
19:28:52 [2025-02-25T19:28:52.871Z] ++ coreos_gf findfs-label boot
19:28:52 [2025-02-25T19:28:52.871Z] ++ guestfish --remote -- findfs-label boot
19:28:52 [2025-02-25T19:28:52.871Z] + boot=/dev/sda3
19:28:52 [2025-02-25T19:28:52.871Z] + coreos_gf mount /dev/sda3 /boot
19:28:52 [2025-02-25T19:28:52.871Z] + guestfish --remote -- mount /dev/sda3 /boot
19:28:53 [2025-02-25T19:28:53.125Z] + local partitions
19:28:53 [2025-02-25T19:28:53.125Z] + local label
19:28:53 [2025-02-25T19:28:53.125Z] ++ coreos_gf list-partitions
19:28:53 [2025-02-25T19:28:53.125Z] ++ guestfish --remote -- list-partitions
19:28:53 [2025-02-25T19:28:53.125Z] + partitions='/dev/sda1
19:28:53 [2025-02-25T19:28:53.125Z] /dev/sda2
19:28:53 [2025-02-25T19:28:53.125Z] /dev/sda3
19:28:53 [2025-02-25T19:28:53.125Z] /dev/sda4'
19:28:53 [2025-02-25T19:28:53.125Z] + for pt in $partitions
19:28:53 [2025-02-25T19:28:53.125Z] ++ coreos_gf vfs-label /dev/sda1
19:28:53 [2025-02-25T19:28:53.125Z] ++ guestfish --remote -- vfs-label /dev/sda1
19:28:53 [2025-02-25T19:28:53.125Z] + label=
19:28:53 [2025-02-25T19:28:53.125Z] + '[' '' == EFI-SYSTEM ']'
19:28:53 [2025-02-25T19:28:53.125Z] + for pt in $partitions
19:28:53 [2025-02-25T19:28:53.125Z] ++ coreos_gf vfs-label /dev/sda2
19:28:53 [2025-02-25T19:28:53.125Z] ++ guestfish --remote -- vfs-label /dev/sda2
19:28:53 [2025-02-25T19:28:53.125Z] + label=EFI-SYSTEM
19:28:53 [2025-02-25T19:28:53.125Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
19:28:53 [2025-02-25T19:28:53.125Z] + coreos_gf mount /dev/sda2 /boot/efi
19:28:53 [2025-02-25T19:28:53.125Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
19:28:53 [2025-02-25T19:28:53.125Z] + for pt in $partitions
19:28:53 [2025-02-25T19:28:53.125Z] ++ coreos_gf vfs-label /dev/sda3
19:28:53 [2025-02-25T19:28:53.125Z] ++ guestfish --remote -- vfs-label /dev/sda3
19:28:53 [2025-02-25T19:28:53.125Z] + label=boot
19:28:53 [2025-02-25T19:28:53.125Z] + '[' boot == EFI-SYSTEM ']'
19:28:53 [2025-02-25T19:28:53.125Z] + for pt in $partitions
19:28:53 [2025-02-25T19:28:53.125Z] ++ coreos_gf vfs-label /dev/sda4
19:28:53 [2025-02-25T19:28:53.125Z] ++ guestfish --remote -- vfs-label /dev/sda4
19:28:53 [2025-02-25T19:28:53.125Z] + label=root
19:28:53 [2025-02-25T19:28:53.125Z] + '[' root == EFI-SYSTEM ']'
19:28:53 [2025-02-25T19:28:53.125Z] ++ coreos_gf ls /ostree/deploy
19:28:53 [2025-02-25T19:28:53.125Z] ++ guestfish --remote -- ls /ostree/deploy
19:28:53 [2025-02-25T19:28:53.378Z] + stateroot=/ostree/deploy/fedora-coreos
19:28:53 [2025-02-25T19:28:53.378Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
19:28:53 [2025-02-25T19:28:53.378Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
19:28:53 [2025-02-25T19:28:53.378Z] ++ grep -v .origin
19:28:53 [2025-02-25T19:28:53.378Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0
19:28:53 [2025-02-25T19:28:53.378Z] + export stateroot deploydir
19:28:53 [2025-02-25T19:28:53.378Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/config
19:28:53 [2025-02-25T19:28:53.378Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/config
19:28:53 [2025-02-25T19:28:53.378Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/config
19:28:53 [2025-02-25T19:28:53.378Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/config.new /ostree/repo/config
19:28:53 [2025-02-25T19:28:53.378Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/config.new /ostree/repo/config
19:28:53 [2025-02-25T19:28:53.378Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
19:28:53 [2025-02-25T19:28:53.378Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
19:28:53 [2025-02-25T19:28:53.378Z] + kernel_binary=/boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
19:28:53 [2025-02-25T19:28:53.378Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
19:28:53 [2025-02-25T19:28:53.378Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
19:28:53 [2025-02-25T19:28:53.378Z] + kernel_hmac=/boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
19:28:53 [2025-02-25T19:28:53.378Z] ++ basename /boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
19:28:53 [2025-02-25T19:28:53.378Z] + coreos_gf ln /boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
19:28:53 [2025-02-25T19:28:53.378Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
19:28:53 [2025-02-25T19:28:53.378Z] ++ basename /boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
19:28:53 [2025-02-25T19:28:53.378Z] + coreos_gf ln /boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64 /boot/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
19:28:53 [2025-02-25T19:28:53.378Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-52058e2c5fc5d0a093f1ca7545a6f101b8d0ee2e4777d15cfa58cd3f54efe400/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64 /boot/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
19:28:53 [2025-02-25T19:28:53.378Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/image.squashfs compress:lz4
19:28:53 [2025-02-25T19:28:53.378Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/image.squashfs compress:lz4
19:29:03 [2025-02-25T19:29:03.300Z] + coreos_gf_shutdown
19:29:03 [2025-02-25T19:29:03.300Z] + coreos_gf umount-all
19:29:03 [2025-02-25T19:29:03.300Z] + guestfish --remote -- umount-all
19:29:03 [2025-02-25T19:29:03.300Z] + coreos_gf exit
19:29:03 [2025-02-25T19:29:03.300Z] + guestfish --remote -- exit
19:29:03 [2025-02-25T19:29:03.300Z] + GUESTFISH_RUNNING=
19:29:03 [2025-02-25T19:29:03.300Z] + GUESTFISH_PID=
19:29:03 [2025-02-25T19:29:03.300Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
19:29:03 [2025-02-25T19:29:03.300Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.WKFsuO -rf
19:29:03 [2025-02-25T19:29:03.300Z] + _coreos_gf_cleanup
19:29:03 [2025-02-25T19:29:03.300Z] + guestfish --remote -- exit
19:29:03 [2025-02-25T19:29:03.300Z] + :
19:29:07 [2025-02-25T19:29:07.440Z] 2025-02-25 19:29:07,083 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw']
19:29:07 [2025-02-25T19:29:07.440Z] + coreos_gf_run_mount builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:29:07 [2025-02-25T19:29:07.441Z] + local mntarg=mount
19:29:07 [2025-02-25T19:29:07.441Z] + '[' builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw = ro ']'
19:29:07 [2025-02-25T19:29:07.441Z] + coreos_gf_run builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:29:07 [2025-02-25T19:29:07.441Z] + '[' -n '' ']'
19:29:07 [2025-02-25T19:29:07.441Z] + coreos_gf_launch builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:29:07 [2025-02-25T19:29:07.441Z] + '[' -n '' ']'
19:29:07 [2025-02-25T19:29:07.441Z] ++ guestfish --listen -a builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw --ro
19:29:07 [2025-02-25T19:29:07.441Z] + eval 'GUESTFISH_PID=12611; export GUESTFISH_PID'
19:29:07 [2025-02-25T19:29:07.441Z] ++ GUESTFISH_PID=12611
19:29:07 [2025-02-25T19:29:07.441Z] ++ export GUESTFISH_PID
19:29:07 [2025-02-25T19:29:07.441Z] + '[' -z 12611 ']'
19:29:07 [2025-02-25T19:29:07.441Z] ++ kola ncpu
19:29:07 [2025-02-25T19:29:07.441Z] + coreos_gf set-smp 6
19:29:07 [2025-02-25T19:29:07.441Z] + guestfish --remote -- set-smp 6
19:29:07 [2025-02-25T19:29:07.441Z] + coreos_gf run
19:29:07 [2025-02-25T19:29:07.441Z] + guestfish --remote -- run
19:29:09 [2025-02-25T19:29:09.324Z] + GUESTFISH_RUNNING=1
19:29:09 [2025-02-25T19:29:09.324Z] ++ coreos_gf findfs-label root
19:29:09 [2025-02-25T19:29:09.324Z] ++ guestfish --remote -- findfs-label root
19:29:09 [2025-02-25T19:29:09.324Z] + root=/dev/sda4
19:29:09 [2025-02-25T19:29:09.324Z] + coreos_gf mount /dev/sda4 /
19:29:09 [2025-02-25T19:29:09.324Z] + guestfish --remote -- mount /dev/sda4 /
19:29:09 [2025-02-25T19:29:09.576Z] + local boot
19:29:09 [2025-02-25T19:29:09.576Z] ++ coreos_gf findfs-label boot
19:29:09 [2025-02-25T19:29:09.576Z] ++ guestfish --remote -- findfs-label boot
19:29:09 [2025-02-25T19:29:09.576Z] + boot=/dev/sda3
19:29:09 [2025-02-25T19:29:09.576Z] + coreos_gf mount /dev/sda3 /boot
19:29:09 [2025-02-25T19:29:09.576Z] + guestfish --remote -- mount /dev/sda3 /boot
19:29:09 [2025-02-25T19:29:09.829Z] + local partitions
19:29:09 [2025-02-25T19:29:09.829Z] + local label
19:29:09 [2025-02-25T19:29:09.829Z] ++ coreos_gf list-partitions
19:29:09 [2025-02-25T19:29:09.829Z] ++ guestfish --remote -- list-partitions
19:29:09 [2025-02-25T19:29:09.829Z] + partitions='/dev/sda1
19:29:09 [2025-02-25T19:29:09.829Z] /dev/sda2
19:29:09 [2025-02-25T19:29:09.829Z] /dev/sda3
19:29:09 [2025-02-25T19:29:09.829Z] /dev/sda4'
19:29:09 [2025-02-25T19:29:09.829Z] + for pt in $partitions
19:29:09 [2025-02-25T19:29:09.829Z] ++ coreos_gf vfs-label /dev/sda1
19:29:09 [2025-02-25T19:29:09.829Z] ++ guestfish --remote -- vfs-label /dev/sda1
19:29:09 [2025-02-25T19:29:09.829Z] + label=
19:29:09 [2025-02-25T19:29:09.829Z] + '[' '' == EFI-SYSTEM ']'
19:29:09 [2025-02-25T19:29:09.829Z] + for pt in $partitions
19:29:09 [2025-02-25T19:29:09.829Z] ++ coreos_gf vfs-label /dev/sda2
19:29:09 [2025-02-25T19:29:09.829Z] ++ guestfish --remote -- vfs-label /dev/sda2
19:29:09 [2025-02-25T19:29:09.829Z] + label=EFI-SYSTEM
19:29:09 [2025-02-25T19:29:09.829Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
19:29:09 [2025-02-25T19:29:09.829Z] + coreos_gf mount /dev/sda2 /boot/efi
19:29:09 [2025-02-25T19:29:09.829Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
19:29:09 [2025-02-25T19:29:09.829Z] + for pt in $partitions
19:29:09 [2025-02-25T19:29:09.829Z] ++ coreos_gf vfs-label /dev/sda3
19:29:09 [2025-02-25T19:29:09.829Z] ++ guestfish --remote -- vfs-label /dev/sda3
19:29:09 [2025-02-25T19:29:09.829Z] + label=boot
19:29:09 [2025-02-25T19:29:09.829Z] + '[' boot == EFI-SYSTEM ']'
19:29:09 [2025-02-25T19:29:09.829Z] + for pt in $partitions
19:29:09 [2025-02-25T19:29:09.829Z] ++ coreos_gf vfs-label /dev/sda4
19:29:09 [2025-02-25T19:29:09.829Z] ++ guestfish --remote -- vfs-label /dev/sda4
19:29:09 [2025-02-25T19:29:09.829Z] + label=root
19:29:09 [2025-02-25T19:29:09.829Z] + '[' root == EFI-SYSTEM ']'
19:29:09 [2025-02-25T19:29:09.829Z] ++ coreos_gf ls /ostree/deploy
19:29:09 [2025-02-25T19:29:09.829Z] ++ guestfish --remote -- ls /ostree/deploy
19:29:10 [2025-02-25T19:29:10.082Z] + stateroot=/ostree/deploy/fedora-coreos
19:29:10 [2025-02-25T19:29:10.082Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
19:29:10 [2025-02-25T19:29:10.082Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
19:29:10 [2025-02-25T19:29:10.082Z] ++ grep -v .origin
19:29:10 [2025-02-25T19:29:10.082Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.0
19:29:10 [2025-02-25T19:29:10.082Z] + export stateroot deploydir
19:29:10 [2025-02-25T19:29:10.082Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
19:29:10 [2025-02-25T19:29:10.082Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
19:29:10 [2025-02-25T19:29:10.082Z] + sed -e '/^options/!d' -e 's/^options\s*//'
19:29:10 [2025-02-25T19:29:10.082Z] + coreos_gf_shutdown
19:29:10 [2025-02-25T19:29:10.082Z] + coreos_gf umount-all
19:29:10 [2025-02-25T19:29:10.082Z] + guestfish --remote -- umount-all
19:29:10 [2025-02-25T19:29:10.082Z] + coreos_gf exit
19:29:10 [2025-02-25T19:29:10.082Z] + guestfish --remote -- exit
19:29:10 [2025-02-25T19:29:10.336Z] + GUESTFISH_RUNNING=
19:29:10 [2025-02-25T19:29:10.336Z] + GUESTFISH_PID=
19:29:10 [2025-02-25T19:29:10.336Z] + _coreos_gf_cleanup
19:29:10 [2025-02-25T19:29:10.336Z] + guestfish --remote -- exit
19:29:10 [2025-02-25T19:29:10.336Z] + :
19:29:10 [2025-02-25T19:29:10.336Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-43.20250225.dev.0
19:29:10 [2025-02-25T19:29:10.336Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
19:29:10 [2025-02-25T19:29:10.336Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
19:29:10 [2025-02-25T19:29:10.336Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
19:29:10 [2025-02-25T19:29:10.589Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
19:29:10 [2025-02-25T19:29:10.589Z] 2025-02-25 19:29:10,366 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '67ae3e067083eb23bcb47e3b390331728df448965967579116db078dce21a815', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
19:29:11 [2025-02-25T19:29:11.520Z] 2025-02-25 19:29:11,242 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmp84mxqcc1.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
19:29:13 [2025-02-25T19:29:13.398Z] 2025-02-25 19:29:13,307 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-43.20250225.dev.0', '-volset', 'fedora-coreos-43.20250225.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-43.20250225.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
19:29:13 [2025-02-25T19:29:13.398Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
19:29:13 [2025-02-25T19:29:13.398Z] genisoimage 1.1.11 (Linux)
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
19:29:13 [2025-02-25T19:29:13.398Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Initial Padblock                        Start Block 0
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Initial Padblock                        Block(s)    16
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Primary Volume Descriptor               Start Block 16
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Primary Volume Descriptor               Block(s)    1
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Eltorito Volume Descriptor              Start Block 17
19:29:13 [2025-02-25T19:29:13.398Z] Size of boot image is 4 sectors -> No emulation
19:29:13 [2025-02-25T19:29:13.398Z] Size of boot image is 13104 sectors -> No emulation
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Eltorito Volume Descriptor              Block(s)    1
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Joliet Volume Descriptor                Start Block 18
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Joliet Volume Descriptor                Block(s)    1
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   End Volume Descriptor                   Start Block 19
19:29:13 [2025-02-25T19:29:13.398Z] Done with: End Volume Descriptor                   Block(s)    1
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Version block                           Start Block 20
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Version block                           Block(s)    1
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Path table                              Start Block 21
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Path table                              Block(s)    4
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Joliet path table                       Start Block 25
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Joliet path table                       Block(s)    4
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Directory tree                          Start Block 29
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Directory tree                          Block(s)    7
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Joliet directory tree                   Start Block 36
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Joliet directory tree                   Block(s)    7
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Directory tree cleanup                  Start Block 43
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Directory tree cleanup                  Block(s)    0
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   Extension record                        Start Block 43
19:29:13 [2025-02-25T19:29:13.398Z] Done with: Extension record                        Block(s)    1
19:29:13 [2025-02-25T19:29:13.398Z] Writing:   The File(s)                             Start Block 44
19:29:13 [2025-02-25T19:29:13.398Z]   0.92% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   1.84% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   2.76% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   3.68% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   4.60% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   5.52% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   6.44% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   7.36% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.398Z]   8.28% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]   9.21% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  10.13% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  11.05% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  11.97% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  12.89% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  13.81% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  14.73% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  15.65% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  16.57% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  17.49% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  18.41% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  19.33% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  20.25% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  21.17% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  22.09% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  23.01% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  23.93% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  24.85% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  25.77% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  26.69% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  27.61% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  28.53% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  29.46% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  30.37% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  31.30% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  32.21% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  33.14% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  34.06% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  34.98% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.650Z]  35.90% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  36.82% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  37.74% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  38.66% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  39.58% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  40.50% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  41.42% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  42.34% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  43.26% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  44.18% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  45.10% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  46.02% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  46.94% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  47.86% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  48.78% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  49.70% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  50.62% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  51.54% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  52.46% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  53.39% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  54.30% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  55.23% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  56.15% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  57.07% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  57.99% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  58.91% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  59.83% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  60.75% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  61.67% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  62.59% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  63.51% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:13 [2025-02-25T19:29:13.903Z]  64.43% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  65.35% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  66.27% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  67.19% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  68.11% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  69.03% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  69.95% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  70.87% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  71.79% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  72.71% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  73.63% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  74.55% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  75.47% done, estimate finish Tue Feb 25 19:29:13 2025
19:29:14 [2025-02-25T19:29:14.156Z]  76.39% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  77.32% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  78.23% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  79.16% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  80.08% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  81.00% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  81.92% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  82.84% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  83.76% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  84.68% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  85.60% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  86.52% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  87.44% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  88.36% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  89.28% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.156Z]  90.20% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  91.12% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  92.04% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  92.96% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  93.88% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  94.80% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  95.72% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  96.64% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  97.56% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  98.48% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z]  99.41% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.408Z] Total translation table size: 2048
19:29:14 [2025-02-25T19:29:14.408Z] Total rockridge attributes bytes: 3006
19:29:14 [2025-02-25T19:29:14.408Z] Total directory bytes: 12288
19:29:14 [2025-02-25T19:29:14.408Z] Path table size(bytes): 96
19:29:14 [2025-02-25T19:29:14.408Z] Done with: The File(s)                             Block(s)    543050
19:29:14 [2025-02-25T19:29:14.408Z] Writing:   Ending Padblock                         Start Block 543094
19:29:14 [2025-02-25T19:29:14.408Z] Done with: Ending Padblock                         Block(s)    150
19:29:14 [2025-02-25T19:29:14.408Z] Max brk space used 1c000
19:29:14 [2025-02-25T19:29:14.408Z] 543244 extents written (1061 MB)
19:29:14 [2025-02-25T19:29:14.408Z] 2025-02-25 19:29:14,278 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250225.dev.0-live.x86_64.iso']
19:29:14 [2025-02-25T19:29:14.408Z] isohybrid: Warning: more than 1024 cylinders: 1062
19:29:14 [2025-02-25T19:29:14.408Z] isohybrid: Not all BIOSes will be able to boot this device
19:29:14 [2025-02-25T19:29:14.963Z] 2025-02-25 19:29:14,753 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-43.20250225.dev.0', '-volset', 'fedora-coreos-43.20250225.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-43.20250225.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
19:29:14 [2025-02-25T19:29:14.963Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
19:29:14 [2025-02-25T19:29:14.963Z] genisoimage 1.1.11 (Linux)
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
19:29:14 [2025-02-25T19:29:14.963Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Initial Padblock                        Start Block 0
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Initial Padblock                        Block(s)    16
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Primary Volume Descriptor               Start Block 16
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Primary Volume Descriptor               Block(s)    1
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Eltorito Volume Descriptor              Start Block 17
19:29:14 [2025-02-25T19:29:14.963Z] Size of boot image is 4 sectors -> No emulation
19:29:14 [2025-02-25T19:29:14.963Z] Size of boot image is 13104 sectors -> No emulation
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Eltorito Volume Descriptor              Block(s)    1
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Joliet Volume Descriptor                Start Block 18
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Joliet Volume Descriptor                Block(s)    1
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   End Volume Descriptor                   Start Block 19
19:29:14 [2025-02-25T19:29:14.963Z] Done with: End Volume Descriptor                   Block(s)    1
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Version block                           Start Block 20
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Version block                           Block(s)    1
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Path table                              Start Block 21
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Path table                              Block(s)    4
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Joliet path table                       Start Block 25
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Joliet path table                       Block(s)    4
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Directory tree                          Start Block 29
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Directory tree                          Block(s)    7
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Joliet directory tree                   Start Block 36
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Joliet directory tree                   Block(s)    7
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Directory tree cleanup                  Start Block 43
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Directory tree cleanup                  Block(s)    0
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Extension record                        Start Block 43
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Extension record                        Block(s)    1
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   The File(s)                             Start Block 44
19:29:14 [2025-02-25T19:29:14.963Z]   8.39% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  16.75% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  25.13% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  33.49% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  41.88% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  50.24% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  58.63% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  66.99% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  75.37% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  83.73% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z]  92.13% done, estimate finish Tue Feb 25 19:29:14 2025
19:29:14 [2025-02-25T19:29:14.963Z] Total translation table size: 2048
19:29:14 [2025-02-25T19:29:14.963Z] Total rockridge attributes bytes: 2842
19:29:14 [2025-02-25T19:29:14.963Z] Total directory bytes: 12288
19:29:14 [2025-02-25T19:29:14.963Z] Path table size(bytes): 96
19:29:14 [2025-02-25T19:29:14.963Z] Done with: The File(s)                             Block(s)    59520
19:29:14 [2025-02-25T19:29:14.963Z] Writing:   Ending Padblock                         Start Block 59564
19:29:14 [2025-02-25T19:29:14.963Z] Done with: Ending Padblock                         Block(s)    150
19:29:14 [2025-02-25T19:29:14.963Z] Max brk space used 1b000
19:29:14 [2025-02-25T19:29:14.963Z] 59714 extents written (116 MB)
19:29:14 [2025-02-25T19:29:14.963Z] 2025-02-25 19:29:14,863 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250225.dev.0-live.x86_64.iso.minimal']
19:29:14 [2025-02-25T19:29:14.963Z] 2025-02-25 19:29:14,900 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250225.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250225.dev.0-live.x86_64.iso.minimal', '--consume']
19:29:32 [2025-02-25T19:29:32.978Z] + RUST_BACKTRACE=full
19:29:32 [2025-02-25T19:29:32.978Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/ab8bcae0f618756fe7000ac7c505e99de79b08553a1d55d0cf78ddd8e9188ebe.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-43.20250225.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250225.dev.0-live.x86_64.iso.minimal --consume
19:29:32 [2025-02-25T19:29:32.978Z] Packing minimal ISO
19:29:32 [2025-02-25T19:29:32.978Z] Matched 17 files of 17
19:29:32 [2025-02-25T19:29:32.978Z] Total bytes skipped: 121874935
19:29:32 [2025-02-25T19:29:32.978Z] Total bytes written: 808457
19:29:32 [2025-02-25T19:29:32.978Z] Total bytes written (compressed): 2832
19:29:32 [2025-02-25T19:29:32.978Z] Verifying that packed image matches digest
19:29:32 [2025-02-25T19:29:32.978Z] Packing successful!
19:29:32 [2025-02-25T19:29:32.978Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:29:36 [2025-02-25T19:29:36.221Z] Updated: builds/43.20250225.dev.0/x86_64/meta.json
19:29:36 [2025-02-25T19:29:36.224Z] [Pipeline] }
19:29:36 [2025-02-25T19:29:36.227Z] [Pipeline] // withEnv
19:29:36 [2025-02-25T19:29:36.243Z] [Pipeline] withEnv
19:29:36 [2025-02-25T19:29:36.244Z] [Pipeline] {
19:29:36 [2025-02-25T19:29:36.262Z] [Pipeline] sh
19:29:36 [2025-02-25T19:29:36.839Z] + set -xeuo pipefail
19:29:36 [2025-02-25T19:29:36.839Z] ++ umask
19:29:36 [2025-02-25T19:29:36.839Z] + '[' 0022 = 0000 ']'
19:29:36 [2025-02-25T19:29:36.839Z] + cosa shell -- env XZ_DEFAULTS=--memlimit=4G cosa compress --artifact=metal
19:29:37 [2025-02-25T19:29:37.092Z] Targeting build: 43.20250225.dev.0
19:29:37 [2025-02-25T19:29:37.092Z] Compressing: builds/43.20250225.dev.0/x86_64
19:29:37 [2025-02-25T19:29:37.092Z] 2025-02-25 19:29:36,918 INFO - Running command: ['xz', '-c9', '-T6', 'builds/43.20250225.dev.0/x86_64/fedora-coreos-43.20250225.dev.0-metal.x86_64.raw']
19:34:13 [2025-02-25T19:34:13.505Z] Compressed: fedora-coreos-43.20250225.dev.0-metal.x86_64.raw.xz
19:34:13 [2025-02-25T19:34:13.505Z] Skipped compressing artifacts: ostree oci-manifest live-iso live-kernel live-initramfs live-rootfs
19:34:13 [2025-02-25T19:34:13.505Z] Updated: builds/43.20250225.dev.0/x86_64/meta.json
19:34:13 [2025-02-25T19:34:13.507Z] [Pipeline] }
19:34:13 [2025-02-25T19:34:13.510Z] [Pipeline] // withEnv
19:34:13 [2025-02-25T19:34:13.575Z] [Pipeline] }
19:34:13 [2025-02-25T19:34:13.633Z] [Pipeline] // stage
19:34:13 [2025-02-25T19:34:13.647Z] [Pipeline] stage
19:34:13 [2025-02-25T19:34:13.648Z] [Pipeline] { (x86_64:kola:testiso)
19:34:13 [2025-02-25T19:34:13.671Z] [Pipeline] withEnv
19:34:13 [2025-02-25T19:34:13.671Z] [Pipeline] {
19:34:13 [2025-02-25T19:34:13.682Z] [Pipeline] sh
19:34:14 [2025-02-25T19:34:14.263Z] + set -euo pipefail
19:34:14 [2025-02-25T19:34:14.263Z] ++ umask
19:34:14 [2025-02-25T19:34:14.263Z] + '[' 0022 = 0000 ']'
19:34:14 [2025-02-25T19:34:14.263Z] + uuidgen
19:34:14 [2025-02-25T19:34:14.263Z] + cut -f1 -d-
19:34:14 [2025-02-25T19:34:14.267Z] [Pipeline] }
19:34:14 [2025-02-25T19:34:14.269Z] [Pipeline] // withEnv
19:34:14 [2025-02-25T19:34:14.274Z] [Pipeline] withEnv
19:34:14 [2025-02-25T19:34:14.275Z] [Pipeline] {
19:34:14 [2025-02-25T19:34:14.286Z] [Pipeline] sh
19:34:14 [2025-02-25T19:34:14.818Z] + set -euo pipefail
19:34:14 [2025-02-25T19:34:14.818Z] ++ umask
19:34:14 [2025-02-25T19:34:14.818Z] + '[' 0022 = 0000 ']'
19:34:14 [2025-02-25T19:34:14.818Z] + cd /home/jenkins/agent/workspace/test-override
19:34:14 [2025-02-25T19:34:14.818Z] + cosa shell -- mktemp -d /home/jenkins/agent/workspace/test-override/tmp/kola-XXXXX
19:34:14 [2025-02-25T19:34:14.821Z] [Pipeline] }
19:34:14 [2025-02-25T19:34:14.823Z] [Pipeline] // withEnv
19:34:14 [2025-02-25T19:34:14.828Z] [Pipeline] withEnv
19:34:14 [2025-02-25T19:34:14.828Z] [Pipeline] {
19:34:14 [2025-02-25T19:34:14.840Z] [Pipeline] sh
19:34:15 [2025-02-25T19:34:15.367Z] + set -xeuo pipefail
19:34:15 [2025-02-25T19:34:15.367Z] ++ umask
19:34:15 [2025-02-25T19:34:15.367Z] + '[' 0022 = 0000 ']'
19:34:15 [2025-02-25T19:34:15.367Z] + cd /home/jenkins/agent/workspace/test-override
19:34:15 [2025-02-25T19:34:15.367Z] + cosa kola testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-E6rtn/kola-testiso-x86_64
19:34:15 [2025-02-25T19:34:15.367Z] kola -p qemu testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-E6rtn/kola-testiso-x86_64
19:34:15 [2025-02-25T19:34:15.367Z] Ignoring verification of signature on metal image
19:34:15 [2025-02-25T19:34:15.367Z] Running test: iso-as-disk.bios
19:34:41 [2025-02-25T19:34:41.835Z] PASS: iso-as-disk.bios (18.45s)
19:34:41 [2025-02-25T19:34:41.835Z] Running test: iso-as-disk.uefi
19:35:08 [2025-02-25T19:35:08.289Z] PASS: iso-as-disk.uefi (22.337s)
19:35:08 [2025-02-25T19:35:08.289Z] Running test: iso-as-disk.uefi-secure
19:35:34 [2025-02-25T19:35:34.738Z] PASS: iso-as-disk.uefi-secure (23.129s)
19:35:34 [2025-02-25T19:35:34.738Z] Running test: iso-as-disk.4k.uefi
19:36:01 [2025-02-25T19:36:01.185Z] PASS: iso-as-disk.4k.uefi (22.246s)
19:36:01 [2025-02-25T19:36:01.186Z] Running test: iso-install.bios
19:40:37 [2025-02-25T19:40:37.583Z] PASS: iso-install.bios (4m14.578s)
19:40:37 [2025-02-25T19:40:37.583Z] Running test: iso-live-login.bios
19:40:59 [2025-02-25T19:40:59.426Z] The file: journal.txt does not exist
19:40:59 [2025-02-25T19:40:59.426Z] PASS: iso-live-login.bios (30.362s)
19:40:59 [2025-02-25T19:40:59.426Z] Running test: iso-live-login.uefi
19:41:31 [2025-02-25T19:41:31.413Z] The file: journal.txt does not exist
19:41:31 [2025-02-25T19:41:31.413Z] PASS: iso-live-login.uefi (26.074s)
19:41:31 [2025-02-25T19:41:31.413Z] Running test: iso-live-login.uefi-secure
19:42:03 [2025-02-25T19:42:03.395Z] The file: journal.txt does not exist
19:42:03 [2025-02-25T19:42:03.395Z] PASS: iso-live-login.uefi-secure (27.148s)
19:42:03 [2025-02-25T19:42:03.395Z] Running test: iso-live-login.4k.uefi
19:42:29 [2025-02-25T19:42:29.879Z] The file: journal.txt does not exist
19:42:30 [2025-02-25T19:42:30.798Z] PASS: iso-live-login.4k.uefi (26.381s)
19:42:30 [2025-02-25T19:42:30.799Z] Running test: iso-offline-install.bios
19:46:52 [2025-02-25T19:46:52.237Z] PASS: iso-offline-install.bios (4m5.983s)
19:46:52 [2025-02-25T19:46:52.237Z] Running test: iso-offline-install.mpath.bios
19:51:13 [2025-02-25T19:51:13.612Z] PASS: iso-offline-install.mpath.bios (4m11.976s)
19:51:13 [2025-02-25T19:51:13.612Z] Running test: iso-offline-install-fromram.4k.uefi
19:55:35 [2025-02-25T19:55:35.011Z] PASS: iso-offline-install-fromram.4k.uefi (4m10.686s)
19:55:35 [2025-02-25T19:55:35.011Z] Running test: iso-offline-install-iscsi.ibft.uefi
19:55:37 [2025-02-25T19:55:37.568Z] Warning: Cannot announce submounts, client does not support it
19:57:58 [2025-02-25T19:57:58.908Z] PASS: iso-offline-install-iscsi.ibft.uefi (2m12.471s)
19:57:58 [2025-02-25T19:57:58.908Z] Running test: iso-offline-install-iscsi.ibft-with-mpath.bios
20:00:35 [2025-02-25T20:00:35.258Z] PASS: iso-offline-install-iscsi.ibft-with-mpath.bios (2m25.423s)
20:00:35 [2025-02-25T20:00:35.258Z] Running test: iso-offline-install-iscsi.manual.bios
20:02:56 [2025-02-25T20:02:56.851Z] PASS: iso-offline-install-iscsi.manual.bios (2m15.245s)
20:02:56 [2025-02-25T20:02:56.851Z] Running test: miniso-install.bios
20:07:33 [2025-02-25T20:07:33.244Z] PASS: miniso-install.bios (4m22.955s)
20:07:33 [2025-02-25T20:07:33.244Z] Running test: miniso-install.nm.bios
20:12:09 [2025-02-25T20:12:09.627Z] PASS: miniso-install.nm.bios (4m30.057s)
20:12:09 [2025-02-25T20:12:09.627Z] Running test: miniso-install.4k.uefi
20:17:01 [2025-02-25T20:17:01.041Z] PASS: miniso-install.4k.uefi (4m29.488s)
20:17:01 [2025-02-25T20:17:01.042Z] Running test: miniso-install.4k.nm.uefi
20:21:52 [2025-02-25T20:21:52.465Z] PASS: miniso-install.4k.nm.uefi (4m37.705s)
20:21:52 [2025-02-25T20:21:52.465Z] Running test: pxe-offline-install.bios
20:26:13 [2025-02-25T20:26:13.849Z] PASS: pxe-offline-install.bios (4m23.436s)
20:26:13 [2025-02-25T20:26:13.849Z] Running test: pxe-offline-install.4k.uefi
20:31:05 [2025-02-25T20:31:05.273Z] PASS: pxe-offline-install.4k.uefi (4m29.516s)
20:31:05 [2025-02-25T20:31:05.273Z] Running test: pxe-online-install.bios
20:35:41 [2025-02-25T20:35:41.695Z] PASS: pxe-online-install.bios (4m23.969s)
20:35:41 [2025-02-25T20:35:41.695Z] Running test: pxe-online-install.4k.uefi
20:40:18 [2025-02-25T20:40:18.103Z] PASS: pxe-online-install.4k.uefi (4m24.867s)
20:40:18 [2025-02-25T20:40:18.107Z] [Pipeline] }
20:40:18 [2025-02-25T20:40:18.110Z] [Pipeline] // withEnv
20:40:18 [2025-02-25T20:40:18.190Z] [Pipeline] withEnv
20:40:18 [2025-02-25T20:40:18.190Z] [Pipeline] {
20:40:18 [2025-02-25T20:40:18.212Z] [Pipeline] sh
20:40:18 [2025-02-25T20:40:18.810Z] + set -xeuo pipefail
20:40:18 [2025-02-25T20:40:18.810Z] ++ umask
20:40:18 [2025-02-25T20:40:18.810Z] + '[' 0022 = 0000 ']'
20:40:18 [2025-02-25T20:40:18.810Z] + cd /home/jenkins/agent/workspace/test-override
20:40:18 [2025-02-25T20:40:18.810Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-E6rtn -c --xz kola-testiso-x86_64
20:40:30 [2025-02-25T20:40:30.946Z] [Pipeline] }
20:40:30 [2025-02-25T20:40:30.948Z] [Pipeline] // withEnv
20:40:31 [2025-02-25T20:40:31.007Z] [Pipeline] archiveArtifacts
20:40:31 [2025-02-25T20:40:31.009Z] Archiving artifacts
20:40:32 [2025-02-25T20:40:32.237Z] [Pipeline] withEnv
20:40:32 [2025-02-25T20:40:32.239Z] [Pipeline] {
20:40:32 [2025-02-25T20:40:32.249Z] [Pipeline] sh
20:40:32 [2025-02-25T20:40:32.786Z] + set -xeuo pipefail
20:40:32 [2025-02-25T20:40:32.786Z] ++ umask
20:40:32 [2025-02-25T20:40:32.786Z] + '[' 0022 = 0000 ']'
20:40:32 [2025-02-25T20:40:32.786Z] + cd /home/jenkins/agent/workspace/test-override
20:40:32 [2025-02-25T20:40:32.786Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-testiso-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-E6rtn/kola-testiso-x86_64 --output -
20:40:32 [2025-02-25T20:40:32.788Z] [Pipeline] }
20:40:32 [2025-02-25T20:40:32.790Z] [Pipeline] // withEnv
20:40:32 [2025-02-25T20:40:32.840Z] [Pipeline] junit
20:40:32 [2025-02-25T20:40:32.841Z] Recording test results
20:40:32 [2025-02-25T20:40:32.926Z] None of the test reports contained any result
20:40:32 [2025-02-25T20:40:32.926Z] [Pipeline] }
20:40:32 [2025-02-25T20:40:32.928Z] [Pipeline] // stage
20:40:32 [2025-02-25T20:40:32.958Z] [Pipeline] stage
20:40:32 [2025-02-25T20:40:32.959Z] [Pipeline] { (x86_64:Destroy Remote)
20:40:32 [2025-02-25T20:40:32.972Z] [Pipeline] }
20:40:32 [2025-02-25T20:40:32.975Z] [Pipeline] // stage
20:40:33 [2025-02-25T20:40:33.011Z] [Pipeline] }
20:40:33 [2025-02-25T20:40:33.084Z] [Pipeline] // parallel
20:40:33 [2025-02-25T20:40:33.144Z] [Pipeline] }
20:40:33 [2025-02-25T20:40:33.158Z] [Pipeline] // timeout
20:40:33 [2025-02-25T20:40:33.191Z] [Pipeline] }
20:40:33 [2025-02-25T20:40:33.194Z] [Pipeline] // container
20:40:33 [2025-02-25T20:40:33.198Z] [Pipeline] }
20:40:33 [2025-02-25T20:40:33.234Z] [Pipeline] // node
20:40:33 [2025-02-25T20:40:33.277Z] [Pipeline] }
20:40:33 [2025-02-25T20:40:33.299Z] [Pipeline] // podTemplate
20:40:33 [2025-02-25T20:40:33.339Z] [Pipeline] End of Pipeline
20:40:33 [2025-02-25T20:40:33.503Z] Finished: SUCCESS