Console Output

Skipping 337 KB.. Full Log

22:08:51 [2025-01-30T22:08:51.460Z] --- PASS: fcos.users.shells (24.18s)
22:09:09 [2025-01-30T22:09:09.496Z] --- PASS: ext.config.systemd.condition-needs-update (78.83s)
22:09:09 [2025-01-30T22:09:09.496Z] --- PASS: ext.config.networking.hostname.fallback-hostname (26.78s)
22:09:14 [2025-01-30T22:09:14.716Z] --- PASS: fcos.network.listeners (24.03s)
22:09:26 [2025-01-30T22:09:26.877Z] --- PASS: ext.config.reboot (44.69s)
22:09:28 [2025-01-30T22:09:28.231Z] --- PASS: multipath.partition (55.03s)
22:09:32 [2025-01-30T22:09:32.390Z] --- PASS: coreos.ignition.v2.users (24.50s)
22:09:42 [2025-01-30T22:09:42.340Z] === RUN   basic.uefi/ServicesActive
22:09:42 [2025-01-30T22:09:42.340Z] === RUN   basic.uefi/ReadOnly
22:09:42 [2025-01-30T22:09:42.340Z] === RUN   basic.uefi/Useradd
22:09:42 [2025-01-30T22:09:42.340Z] === RUN   basic.uefi/MachineID
22:09:42 [2025-01-30T22:09:42.340Z] === RUN   basic.uefi/FCOSGrowpart
22:09:42 [2025-01-30T22:09:42.594Z] === RUN   basic.uefi/PortSSH
22:09:42 [2025-01-30T22:09:42.594Z] === RUN   basic.uefi/DbusPerms
22:09:46 [2025-01-30T22:09:46.753Z] --- PASS: basic.uefi (38.80s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/ServicesActive (0.13s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/ReadOnly (0.12s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/Useradd (0.21s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/MachineID (0.15s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/FCOSGrowpart (0.15s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/PortSSH (0.12s)
22:09:46 [2025-01-30T22:09:46.753Z]     --- PASS: basic.uefi/DbusPerms (0.35s)
22:09:50 [2025-01-30T22:09:50.029Z] --- PASS: coreos.ignition.groups (24.39s)
22:09:54 [2025-01-30T22:09:54.177Z] --- PASS: ext.config.ignition.kargs (39.25s)
22:09:54 [2025-01-30T22:09:54.431Z] --- PASS: ext.config.ignition.systemd-disable (26.55s)
22:10:20 [2025-01-30T22:10:20.900Z] === RUN   ostree.hotfix/unlock
22:10:20 [2025-01-30T22:10:20.900Z] --- PASS: ext.config.networking.ifname-karg.udev-rule-firstboot-propagation (47.09s)
22:10:26 [2025-01-30T22:10:26.130Z] === RUN   ostree.hotfix/install
22:10:26 [2025-01-30T22:10:26.686Z] === RUN   ostree.hotfix/uninstall
22:10:27 [2025-01-30T22:10:27.603Z] === RUN   ostree.hotfix/persist
22:10:29 [2025-01-30T22:10:29.508Z] --- PASS: ext.config.networking.force-persist-ip (39.15s)
22:10:44 [2025-01-30T22:10:44.331Z] --- PASS: ext.config.ignition.remote (47.56s)
22:10:45 [2025-01-30T22:10:45.685Z] --- PASS: ext.config.ssh.custom-host-key-permissions (26.82s)
22:10:46 [2025-01-30T22:10:46.606Z] === RUN   ostree.hotfix/rollback
22:10:50 [2025-01-30T22:10:50.312Z] === RUN   podman.workflow/run
22:10:51 [2025-01-30T22:10:51.231Z] --- PASS: ext.config.podman.rootless-systemd (57.20s)
22:11:13 [2025-01-30T22:11:13.103Z] --- PASS: ostree.hotfix (83.12s)
22:11:13 [2025-01-30T22:11:13.103Z]     --- PASS: ostree.hotfix/unlock (8.59s)
22:11:13 [2025-01-30T22:11:13.103Z]     --- PASS: ostree.hotfix/install (0.53s)
22:11:13 [2025-01-30T22:11:13.103Z]     --- PASS: ostree.hotfix/uninstall (0.42s)
22:11:13 [2025-01-30T22:11:13.103Z]     --- PASS: ostree.hotfix/persist (18.82s)
22:11:13 [2025-01-30T22:11:13.103Z]     --- PASS: ostree.hotfix/rollback (19.57s)
22:11:27 [2025-01-30T22:11:27.925Z] --- PASS: ext.config.ignition.resource.remote (35.57s)
22:11:30 [2025-01-30T22:11:30.424Z] === RUN   ostree.unlock/unlock
22:11:30 [2025-01-30T22:11:30.424Z] --- PASS: ext.config.disks.lvmdevices (44.57s)
22:11:30 [2025-01-30T22:11:30.677Z] === RUN   ostree.unlock/install
22:11:31 [2025-01-30T22:11:31.232Z] === RUN   ostree.unlock/uninstall
22:11:31 [2025-01-30T22:11:31.802Z] === RUN   ostree.unlock/discard
22:11:53 [2025-01-30T22:11:53.656Z] === RUN   fcos.filesystem/writablefiles
22:11:53 [2025-01-30T22:11:53.656Z] === RUN   fcos.filesystem/writabledirs
22:11:53 [2025-01-30T22:11:53.656Z] === RUN   fcos.filesystem/stickydirs
22:11:53 [2025-01-30T22:11:53.656Z] === RUN   fcos.filesystem/denylist
22:11:53 [2025-01-30T22:11:53.656Z] --- PASS: ostree.unlock (43.91s)
22:11:53 [2025-01-30T22:11:53.656Z]     --- PASS: ostree.unlock/unlock (0.58s)
22:11:53 [2025-01-30T22:11:53.656Z]     --- PASS: ostree.unlock/install (0.56s)
22:11:53 [2025-01-30T22:11:53.656Z]     --- PASS: ostree.unlock/uninstall (0.43s)
22:11:53 [2025-01-30T22:11:53.656Z]     --- PASS: ostree.unlock/discard (18.41s)
22:11:56 [2025-01-30T22:11:56.158Z] --- PASS: fcos.filesystem (25.57s)
22:11:56 [2025-01-30T22:11:56.158Z]     --- PASS: fcos.filesystem/writablefiles (0.83s)
22:11:56 [2025-01-30T22:11:56.158Z]     --- PASS: fcos.filesystem/writabledirs (0.25s)
22:11:56 [2025-01-30T22:11:56.158Z]     --- PASS: fcos.filesystem/stickydirs (0.28s)
22:11:56 [2025-01-30T22:11:56.158Z]     --- PASS: fcos.filesystem/denylist (0.38s)
22:11:56 [2025-01-30T22:11:56.158Z] --- PASS: ext.config.networking.no-default-initramfs-net-propagation.bootif (29.02s)
22:12:18 [2025-01-30T22:12:18.040Z] === RUN   ostree.remote/add
22:12:18 [2025-01-30T22:12:18.040Z] === RUN   ostree.remote/list
22:12:18 [2025-01-30T22:12:18.040Z] === RUN   ostree.remote/show-url
22:12:18 [2025-01-30T22:12:18.040Z] === RUN   ostree.remote/refs
22:12:18 [2025-01-30T22:12:18.040Z] === RUN   ostree.remote/summary
22:12:18 [2025-01-30T22:12:18.040Z] === RUN   ostree.remote/delete
22:12:21 [2025-01-30T22:12:21.289Z] --- PASS: ostree.remote (25.37s)
22:12:21 [2025-01-30T22:12:21.289Z]     --- PASS: ostree.remote/add (0.24s)
22:12:21 [2025-01-30T22:12:21.289Z]     --- PASS: ostree.remote/list (0.12s)
22:12:21 [2025-01-30T22:12:21.289Z]     --- PASS: ostree.remote/show-url (0.20s)
22:12:21 [2025-01-30T22:12:21.289Z]     --- PASS: ostree.remote/refs (0.14s)
22:12:21 [2025-01-30T22:12:21.289Z]     --- PASS: ostree.remote/summary (0.28s)
22:12:21 [2025-01-30T22:12:21.289Z]     --- PASS: ostree.remote/delete (0.44s)
22:12:26 [2025-01-30T22:12:26.535Z] --- PASS: ext.config.containers.quadlet (30.50s)
22:12:48 [2025-01-30T22:12:48.402Z] --- PASS: coreos.ignition.mount.partitions (54.58s)
22:12:50 [2025-01-30T22:12:50.915Z] --- PASS: coreos.ignition.sethostname (24.27s)
22:12:55 [2025-01-30T22:12:55.057Z] --- PASS: ext.config.docker.basic (33.28s)
22:13:21 [2025-01-30T22:13:21.545Z] --- PASS: coreos.ignition.instantiated.enable-unit (25.15s)
22:13:25 [2025-01-30T22:13:25.708Z] --- PASS: podman.network-single (163.54s)
22:13:57 [2025-01-30T22:13:57.708Z] --- PASS: ext.config.ntp.timesyncd.dhcp-propagation (62.96s)
22:13:57 [2025-01-30T22:13:57.708Z] --- PASS: ext.config.ntp.chrony.dhcp-propagation (67.80s)
22:14:12 [2025-01-30T22:14:12.548Z] --- PASS: ext.config.networking.nmstate.state (44.92s)
22:14:30 [2025-01-30T22:14:30.592Z] --- PASS: ext.config.swap.zram-generator (36.33s)
22:14:34 [2025-01-30T22:14:34.738Z] --- PASS: ext.config.ignition.stable-boot (38.36s)
22:14:39 [2025-01-30T22:14:39.981Z] --- PASS: ext.config.ignition.delete-config (80.12s)
22:15:18 [2025-01-30T22:15:18.610Z] --- PASS: rhcos.selinux.boolean.persist (43.08s)
22:15:18 [2025-01-30T22:15:18.610Z] --- PASS: ext.config.clhm.ignition-warnings (35.51s)
22:15:18 [2025-01-30T22:15:18.610Z] --- PASS: ext.config.toolbox (67.16s)
22:15:18 [2025-01-30T22:15:18.610Z] --- PASS: ext.config.selinux.enforcing (43.65s)
22:15:40 [2025-01-30T22:15:40.482Z] --- PASS: ext.config.rpm-ostree-countme (26.77s)
22:15:47 [2025-01-30T22:15:47.008Z] === RUN   basic/PortSSH
22:15:47 [2025-01-30T22:15:47.008Z] === RUN   basic/DbusPerms
22:15:47 [2025-01-30T22:15:47.008Z] === RUN   basic/ServicesActive
22:15:47 [2025-01-30T22:15:47.263Z] === RUN   basic/ReadOnly
22:15:47 [2025-01-30T22:15:47.263Z] === RUN   basic/Useradd
22:15:47 [2025-01-30T22:15:47.532Z] === RUN   basic/MachineID
22:15:47 [2025-01-30T22:15:47.532Z] === RUN   basic/FCOSGrowpart
22:15:51 [2025-01-30T22:15:51.689Z] --- PASS: basic (35.81s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/PortSSH (0.11s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/DbusPerms (0.33s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/ServicesActive (0.12s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/ReadOnly (0.12s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/Useradd (0.20s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/MachineID (0.11s)
22:15:51 [2025-01-30T22:15:51.689Z]     --- PASS: basic/FCOSGrowpart (0.14s)
22:15:56 [2025-01-30T22:15:56.909Z] === RUN   podman.workflow/exec
22:15:56 [2025-01-30T22:15:56.909Z] --- PASS: ext.config.networking.bridge-static-via-kargs (38.98s)
22:15:56 [2025-01-30T22:15:56.909Z] === RUN   podman.workflow/stop
22:16:09 [2025-01-30T22:16:09.055Z] === RUN   podman.workflow/remove
22:16:09 [2025-01-30T22:16:09.055Z] === RUN   podman.workflow/delete
22:16:12 [2025-01-30T22:16:12.317Z] --- PASS: podman.workflow (343.09s)
22:16:12 [2025-01-30T22:16:12.317Z]     --- PASS: podman.workflow/run (306.54s)
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: Trying to pull quay.io/fedora/fedora:latest...
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: Getting image source signatures
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: Copying blob sha256:a52c777f25d4afed9d7958da2f249de731ed6e4479ead4f00621589d0398610c
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: Copying config sha256:a432b057a522737c229d2aac9b029f55bf2a44eb3f423e4e4ece2acb8a304652
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: Writing manifest to image destination
22:16:12 [2025-01-30T22:16:12.317Z]     --- PASS: podman.workflow/exec (0.34s)
22:16:12 [2025-01-30T22:16:12.317Z]     --- PASS: podman.workflow/stop (10.66s)
22:16:12 [2025-01-30T22:16:12.317Z]     --- PASS: podman.workflow/remove (0.58s)
22:16:12 [2025-01-30T22:16:12.317Z]     --- PASS: podman.workflow/delete (0.69s)
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: grep: quay.io/fedora/fedora:latest: No such file or directory
22:16:12 [2025-01-30T22:16:12.317Z]             cluster.go:151: bash: line 2: Deleted:: command not found
22:16:27 [2025-01-30T22:16:27.119Z] --- PASS: ext.config.var-mount.luks (67.94s)
22:16:35 [2025-01-30T22:16:35.200Z] --- PASS: ext.config.var-mount.scsi-id (43.36s)
22:16:37 [2025-01-30T22:16:37.711Z] --- PASS: rpmostree.status (25.14s)
22:16:39 [2025-01-30T22:16:39.585Z] --- PASS: coreos.ignition.once (42.88s)
22:16:42 [2025-01-30T22:16:42.090Z] --- PASS: ext.config.networking.rd-net-timeout-carrier (62.26s)
22:16:42 [2025-01-30T22:16:42.090Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-x86_64
22:16:42 [2025-01-30T22:16:42.093Z] [Pipeline] }
22:16:42 [2025-01-30T22:16:42.106Z] [Pipeline] // withEnv
22:16:42 [2025-01-30T22:16:42.160Z] [Pipeline] withEnv
22:16:42 [2025-01-30T22:16:42.161Z] [Pipeline] {
22:16:42 [2025-01-30T22:16:42.237Z] [Pipeline] sh
22:16:42 [2025-01-30T22:16:42.835Z] + set -xeuo pipefail
22:16:42 [2025-01-30T22:16:42.836Z] ++ umask
22:16:42 [2025-01-30T22:16:42.836Z] + '[' 0022 = 0000 ']'
22:16:42 [2025-01-30T22:16:42.836Z] + cd /home/jenkins/agent/workspace/test-override
22:16:42 [2025-01-30T22:16:42.836Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-reprovision-x86_64 --on-warn-failure-exit-77 --arch=x86_64 --tag=reprovision
22:16:42 [2025-01-30T22:16:42.836Z] 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-7dC39/kola-reprovision-x86_64
22:16:43 [2025-01-30T22:16:43.088Z] ����  Snoozing kola test pattern "ext.config.rpm-ostree.kernel-replace" until Feb 04 2025
22:16:43 [2025-01-30T22:16:43.088Z]   ���� https://github.com/coreos/fedora-coreos-tracker/issues/1870
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.filesystem-only
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.swap-before-root
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.autosave-xfs
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.luks.autosave-xfs
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.luks.512e
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   coreos.boot-mirror.luks
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   coreos.boot-mirror
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.luks
22:16:43 [2025-01-30T22:16:43.088Z] === RUN   ext.config.root-reprovision.raid1
22:18:19 [2025-01-30T22:18:19.450Z] --- PASS: ext.config.root-reprovision.filesystem-only (81.60s)
22:19:40 [2025-01-30T22:19:40.805Z] === RUN   coreos.boot-mirror.luks/sanity-check
22:20:07 [2025-01-30T22:20:07.321Z] === RUN   coreos.boot-mirror.luks/detach-primary
22:20:39 [2025-01-30T22:20:39.332Z] === RUN   coreos.boot-mirror.luks/verify-fallback
22:21:17 [2025-01-30T22:21:17.959Z] --- PASS: coreos.boot-mirror.luks (190.89s)
22:21:17 [2025-01-30T22:21:17.959Z]     --- PASS: coreos.boot-mirror.luks/sanity-check (1.76s)
22:21:17 [2025-01-30T22:21:17.959Z]     --- PASS: coreos.boot-mirror.luks/detach-primary (30.29s)
22:21:17 [2025-01-30T22:21:17.959Z]     --- PASS: coreos.boot-mirror.luks/verify-fallback (0.83s)
22:23:09 [2025-01-30T22:23:09.353Z] === RUN   coreos.boot-mirror/sanity-check
22:23:09 [2025-01-30T22:23:09.353Z] === RUN   coreos.boot-mirror/detach-primary
22:23:27 [2025-01-30T22:23:27.773Z] === RUN   coreos.boot-mirror/verify-fallback
22:23:34 [2025-01-30T22:23:34.302Z] --- PASS: coreos.boot-mirror (137.95s)
22:23:34 [2025-01-30T22:23:34.302Z]     --- PASS: coreos.boot-mirror/sanity-check (1.96s)
22:23:34 [2025-01-30T22:23:34.302Z]     --- PASS: coreos.boot-mirror/detach-primary (30.17s)
22:23:34 [2025-01-30T22:23:34.302Z]     --- PASS: coreos.boot-mirror/verify-fallback (0.81s)
22:25:40 [2025-01-30T22:25:40.669Z] --- PASS: ext.config.root-reprovision.luks.autosave-xfs (112.91s)
22:27:32 [2025-01-30T22:27:32.048Z] --- PASS: ext.config.root-reprovision.luks (124.58s)
22:29:38 [2025-01-30T22:29:38.474Z] --- PASS: ext.config.root-reprovision.luks.512e (123.77s)
22:31:29 [2025-01-30T22:31:29.880Z] --- PASS: ext.config.root-reprovision.raid1 (105.91s)
22:32:26 [2025-01-30T22:32:26.036Z] --- PASS: ext.config.root-reprovision.autosave-xfs (63.96s)
22:33:47 [2025-01-30T22:33:47.421Z] --- PASS: ext.config.root-reprovision.swap-before-root (81.47s)
22:33:47 [2025-01-30T22:33:47.421Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-reprovision-x86_64
22:33:47 [2025-01-30T22:33:47.424Z] [Pipeline] }
22:33:47 [2025-01-30T22:33:47.428Z] [Pipeline] // withEnv
22:33:47 [2025-01-30T22:33:47.433Z] [Pipeline] }
22:33:47 [2025-01-30T22:33:47.510Z] [Pipeline] // parallel
22:33:47 [2025-01-30T22:33:47.525Z] [Pipeline] withEnv
22:33:47 [2025-01-30T22:33:47.525Z] [Pipeline] {
22:33:47 [2025-01-30T22:33:47.598Z] [Pipeline] sh
22:33:48 [2025-01-30T22:33:48.197Z] + set -xeuo pipefail
22:33:48 [2025-01-30T22:33:48.197Z] ++ umask
22:33:48 [2025-01-30T22:33:48.197Z] + '[' 0022 = 0000 ']'
22:33:48 [2025-01-30T22:33:48.197Z] + cd /home/jenkins/agent/workspace/test-override
22:33:48 [2025-01-30T22:33:48.197Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-upgrade-x86_64
22:33:48 [2025-01-30T22:33:48.199Z] [Pipeline] }
22:33:48 [2025-01-30T22:33:48.201Z] [Pipeline] // withEnv
22:33:48 [2025-01-30T22:33:48.216Z] [Pipeline] withEnv
22:33:48 [2025-01-30T22:33:48.217Z] [Pipeline] {
22:33:48 [2025-01-30T22:33:48.258Z] [Pipeline] sh
22:33:48 [2025-01-30T22:33:48.791Z] + set -xeuo pipefail
22:33:48 [2025-01-30T22:33:48.792Z] ++ umask
22:33:48 [2025-01-30T22:33:48.792Z] + '[' 0022 = 0000 ']'
22:33:48 [2025-01-30T22:33:48.792Z] + cd /home/jenkins/agent/workspace/test-override
22:33:48 [2025-01-30T22:33:48.792Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39 -c --xz kola-upgrade-x86_64
22:33:49 [2025-01-30T22:33:49.046Z] [Pipeline] }
22:33:49 [2025-01-30T22:33:49.049Z] [Pipeline] // withEnv
22:33:49 [2025-01-30T22:33:49.124Z] [Pipeline] archiveArtifacts
22:33:49 [2025-01-30T22:33:49.127Z] Archiving artifacts
22:33:49 [2025-01-30T22:33:49.680Z] [Pipeline] withEnv
22:33:49 [2025-01-30T22:33:49.682Z] [Pipeline] {
22:33:49 [2025-01-30T22:33:49.695Z] [Pipeline] sh
22:33:50 [2025-01-30T22:33:50.264Z] + set -xeuo pipefail
22:33:50 [2025-01-30T22:33:50.288Z] ++ umask
22:33:50 [2025-01-30T22:33:50.288Z] + '[' 0022 = 0000 ']'
22:33:50 [2025-01-30T22:33:50.288Z] + cd /home/jenkins/agent/workspace/test-override
22:33:50 [2025-01-30T22:33:50.288Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-upgrade-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-upgrade-x86_64 --output -
22:33:50 [2025-01-30T22:33:50.290Z] [Pipeline] }
22:33:50 [2025-01-30T22:33:50.293Z] [Pipeline] // withEnv
22:33:50 [2025-01-30T22:33:50.298Z] [Pipeline] junit
22:33:50 [2025-01-30T22:33:50.299Z] Recording test results
22:33:51 [2025-01-30T22:33:51.020Z] None of the test reports contained any result
22:33:51 [2025-01-30T22:33:51.033Z] [Pipeline] withEnv
22:33:51 [2025-01-30T22:33:51.034Z] [Pipeline] {
22:33:51 [2025-01-30T22:33:51.037Z] [Pipeline] sh
22:33:51 [2025-01-30T22:33:51.569Z] + set -xeuo pipefail
22:33:51 [2025-01-30T22:33:51.569Z] ++ umask
22:33:51 [2025-01-30T22:33:51.569Z] + '[' 0022 = 0000 ']'
22:33:51 [2025-01-30T22:33:51.569Z] + cd /home/jenkins/agent/workspace/test-override
22:33:51 [2025-01-30T22:33:51.569Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-x86_64
22:33:51 [2025-01-30T22:33:51.571Z] [Pipeline] }
22:33:51 [2025-01-30T22:33:51.574Z] [Pipeline] // withEnv
22:33:51 [2025-01-30T22:33:51.651Z] [Pipeline] withEnv
22:33:51 [2025-01-30T22:33:51.651Z] [Pipeline] {
22:33:51 [2025-01-30T22:33:51.691Z] [Pipeline] sh
22:33:52 [2025-01-30T22:33:52.220Z] + set -xeuo pipefail
22:33:52 [2025-01-30T22:33:52.220Z] ++ umask
22:33:52 [2025-01-30T22:33:52.220Z] + '[' 0022 = 0000 ']'
22:33:52 [2025-01-30T22:33:52.220Z] + cd /home/jenkins/agent/workspace/test-override
22:33:52 [2025-01-30T22:33:52.220Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39 -c --xz kola-x86_64
22:33:57 [2025-01-30T22:33:57.482Z] [Pipeline] }
22:33:57 [2025-01-30T22:33:57.485Z] [Pipeline] // withEnv
22:33:57 [2025-01-30T22:33:57.493Z] [Pipeline] archiveArtifacts
22:33:57 [2025-01-30T22:33:57.505Z] Archiving artifacts
22:34:00 [2025-01-30T22:34:00.481Z] [Pipeline] withEnv
22:34:00 [2025-01-30T22:34:00.482Z] [Pipeline] {
22:34:00 [2025-01-30T22:34:00.486Z] [Pipeline] sh
22:34:01 [2025-01-30T22:34:01.020Z] + set -xeuo pipefail
22:34:01 [2025-01-30T22:34:01.020Z] ++ umask
22:34:01 [2025-01-30T22:34:01.020Z] + '[' 0022 = 0000 ']'
22:34:01 [2025-01-30T22:34:01.020Z] + cd /home/jenkins/agent/workspace/test-override
22:34:01 [2025-01-30T22:34:01.020Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-x86_64 --output -
22:34:01 [2025-01-30T22:34:01.022Z] [Pipeline] }
22:34:01 [2025-01-30T22:34:01.037Z] [Pipeline] // withEnv
22:34:01 [2025-01-30T22:34:01.090Z] [Pipeline] junit
22:34:01 [2025-01-30T22:34:01.092Z] Recording test results
22:34:01 [2025-01-30T22:34:01.103Z] None of the test reports contained any result
22:34:01 [2025-01-30T22:34:01.104Z] [Pipeline] withEnv
22:34:01 [2025-01-30T22:34:01.105Z] [Pipeline] {
22:34:01 [2025-01-30T22:34:01.108Z] [Pipeline] sh
22:34:01 [2025-01-30T22:34:01.649Z] + set -xeuo pipefail
22:34:01 [2025-01-30T22:34:01.649Z] ++ umask
22:34:01 [2025-01-30T22:34:01.650Z] + '[' 0022 = 0000 ']'
22:34:01 [2025-01-30T22:34:01.650Z] + cd /home/jenkins/agent/workspace/test-override
22:34:01 [2025-01-30T22:34:01.650Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-reprovision-x86_64
22:34:01 [2025-01-30T22:34:01.652Z] [Pipeline] }
22:34:01 [2025-01-30T22:34:01.655Z] [Pipeline] // withEnv
22:34:01 [2025-01-30T22:34:01.745Z] [Pipeline] withEnv
22:34:01 [2025-01-30T22:34:01.746Z] [Pipeline] {
22:34:01 [2025-01-30T22:34:01.784Z] [Pipeline] sh
22:34:02 [2025-01-30T22:34:02.328Z] + set -xeuo pipefail
22:34:02 [2025-01-30T22:34:02.328Z] ++ umask
22:34:02 [2025-01-30T22:34:02.328Z] + '[' 0022 = 0000 ']'
22:34:02 [2025-01-30T22:34:02.328Z] + cd /home/jenkins/agent/workspace/test-override
22:34:02 [2025-01-30T22:34:02.328Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39 -c --xz kola-reprovision-x86_64
22:34:04 [2025-01-30T22:34:04.828Z] [Pipeline] }
22:34:04 [2025-01-30T22:34:04.831Z] [Pipeline] // withEnv
22:34:04 [2025-01-30T22:34:04.836Z] [Pipeline] archiveArtifacts
22:34:04 [2025-01-30T22:34:04.847Z] Archiving artifacts
22:34:05 [2025-01-30T22:34:05.187Z] [Pipeline] withEnv
22:34:05 [2025-01-30T22:34:05.188Z] [Pipeline] {
22:34:05 [2025-01-30T22:34:05.192Z] [Pipeline] sh
22:34:05 [2025-01-30T22:34:05.734Z] + set -xeuo pipefail
22:34:05 [2025-01-30T22:34:05.734Z] ++ umask
22:34:05 [2025-01-30T22:34:05.734Z] + '[' 0022 = 0000 ']'
22:34:05 [2025-01-30T22:34:05.734Z] + cd /home/jenkins/agent/workspace/test-override
22:34:05 [2025-01-30T22:34:05.734Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-reprovision-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-7dC39/kola-reprovision-x86_64 --output -
22:34:05 [2025-01-30T22:34:05.736Z] [Pipeline] }
22:34:05 [2025-01-30T22:34:05.738Z] [Pipeline] // withEnv
22:34:05 [2025-01-30T22:34:05.742Z] [Pipeline] junit
22:34:05 [2025-01-30T22:34:05.744Z] Recording test results
22:34:05 [2025-01-30T22:34:05.812Z] None of the test reports contained any result
22:34:05 [2025-01-30T22:34:05.813Z] [Pipeline] stage
22:34:05 [2025-01-30T22:34:05.813Z] [Pipeline] { (x86_64:Build Metal)
22:34:05 [2025-01-30T22:34:05.826Z] [Pipeline] withEnv
22:34:05 [2025-01-30T22:34:05.826Z] [Pipeline] {
22:34:05 [2025-01-30T22:34:05.828Z] [Pipeline] sh
22:34:06 [2025-01-30T22:34:06.351Z] + set -xeuo pipefail
22:34:06 [2025-01-30T22:34:06.351Z] ++ umask
22:34:06 [2025-01-30T22:34:06.351Z] + '[' 0022 = 0000 ']'
22:34:06 [2025-01-30T22:34:06.351Z] + cosa buildextend-metal
22:34:06 [2025-01-30T22:34:06.351Z] info: Missing CAP_SYS_ADMIN; using virt
22:34:06 [2025-01-30T22:34:06.603Z] Config commit: 2ff20ef773dbdbf2e61fbc30e5bd761b6513f21c
22:34:06 [2025-01-30T22:34:06.603Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
22:34:07 [2025-01-30T22:34:07.521Z] Will build metal
22:34:25 [2025-01-30T22:34:25.530Z] ++ arch
22:34:25 [2025-01-30T22:34:25.530Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-42.20250130.dev.0"' -D 'ostree_ref=""' -D 'ostree_repo=""' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-42.20250130.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2622 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2109 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-xZrc.json
22:34:26 [2025-01-30T22:34:26.882Z] + set +x
22:34:26 [2025-01-30T22:34:26.882Z] 
22:34:26 [2025-01-30T22:34:26.882Z] + 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-xZrc.json
22:34:26 [2025-01-30T22:34:26.882Z] Filesystem      Size  Used Avail Use% Mounted on
22:34:26 [2025-01-30T22:34:26.882Z] /dev/vdb1        30G  8.1G   22G  27% /home/jenkins/agent/workspace/test-override/cache
22:34:26 [2025-01-30T22:34:26.882Z] 
22:34:27 [2025-01-30T22:34:27.802Z] starting /tmp/osbuild-xZrc.jsonPipeline source org.osbuild.curl: 4f122b7b75a9008df1c11f2a23cb518f81424ded83430793f21659e9eff87e45
22:34:27 [2025-01-30T22:34:27.802Z] Build
22:34:27 [2025-01-30T22:34:27.802Z]   root: <host>
22:34:27 [2025-01-30T22:34:27.802Z] 
22:34:27 [2025-01-30T22:34:27.802Z] ���  Duration: 1738276467s
22:34:27 [2025-01-30T22:34:27.802Z] Pipeline raw-metal-image: 931267540bf5947efb12de2dddf6a66313ce60d46e4d25a1cbc35f08ecacd403
22:34:27 [2025-01-30T22:34:27.802Z] Build
22:34:27 [2025-01-30T22:34:27.802Z]   root: <host>
22:34:27 [2025-01-30T22:34:27.802Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
22:34:28 [2025-01-30T22:34:28.358Z] org.osbuild.copy: efa8e7092f6c21c6557078e6913a5b9ae2665bae6c294fb27d96820356bc171f {
22:34:28 [2025-01-30T22:34:28.358Z]   "paths": [
22:34:28 [2025-01-30T22:34:28.358Z]     {
22:34:28 [2025-01-30T22:34:28.358Z]       "from": "input://tree/disk.img",
22:34:28 [2025-01-30T22:34:28.358Z]       "to": "tree:///disk.img"
22:34:28 [2025-01-30T22:34:28.358Z]     }
22:34:28 [2025-01-30T22:34:28.358Z]   ]
22:34:28 [2025-01-30T22:34:28.358Z] }
22:34:28 [2025-01-30T22:34:28.620Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:34:28 [2025-01-30T22:34:28.620Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
22:34:29 [2025-01-30T22:34:29.971Z] 
22:34:29 [2025-01-30T22:34:29.971Z] ���  Duration: 1s
22:34:29 [2025-01-30T22:34:29.971Z] org.osbuild.coreos.platform: 931267540bf5947efb12de2dddf6a66313ce60d46e4d25a1cbc35f08ecacd403 {
22:34:29 [2025-01-30T22:34:29.971Z]   "platform": "metal"
22:34:29 [2025-01-30T22:34:29.971Z] }
22:34:29 [2025-01-30T22:34:29.971Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:34:29 [2025-01-30T22:34:29.971Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/
22:34:30 [2025-01-30T22:34:30.224Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0'
22:34:30 [2025-01-30T22:34:30.224Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/boot
22:34:30 [2025-01-30T22:34:30.477Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:34:30 [2025-01-30T22:34:30.477Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/boot unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/boot unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/var unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/sysroot unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts unmounted
22:34:30 [2025-01-30T22:34:30.477Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-un777vg2/mounts/
22:34:30 [2025-01-30T22:34:30.729Z] 
22:34:30 [2025-01-30T22:34:30.730Z] ���  Duration: 0s
22:34:30 [2025-01-30T22:34:30.730Z] Pipeline metal: e65b99e3dd4f90c2263b0060174d5bfac1566c99511380494f3ad2d749aa9c85
22:34:30 [2025-01-30T22:34:30.730Z] Build
22:34:30 [2025-01-30T22:34:30.730Z]   root: <host>
22:34:30 [2025-01-30T22:34:30.730Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
22:34:30 [2025-01-30T22:34:30.730Z] org.osbuild.copy: e65b99e3dd4f90c2263b0060174d5bfac1566c99511380494f3ad2d749aa9c85 {
22:34:30 [2025-01-30T22:34:30.730Z]   "paths": [
22:34:30 [2025-01-30T22:34:30.730Z]     {
22:34:30 [2025-01-30T22:34:30.730Z]       "from": "input://tree/disk.img",
22:34:30 [2025-01-30T22:34:30.730Z]       "to": "tree:///fedora-coreos-42.20250130.dev.0-metal.x86_64.raw"
22:34:30 [2025-01-30T22:34:30.730Z]     }
22:34:30 [2025-01-30T22:34:30.730Z]   ]
22:34:30 [2025-01-30T22:34:30.730Z] }
22:34:30 [2025-01-30T22:34:30.730Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:34:30 [2025-01-30T22:34:30.982Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw'
22:34:30 [2025-01-30T22:34:30.982Z] 
22:34:30 [2025-01-30T22:34:30.982Z] ���  Duration: 0s
22:34:31 [2025-01-30T22:34:31.235Z] manifest /tmp/osbuild-xZrc.json finished successfully
22:34:31 [2025-01-30T22:34:31.235Z] oci-archive:	bd476a0cc2ae6ffbfdbcdf5abc6e125e9d3541c182c1e959c508c598576c39c6
22:34:31 [2025-01-30T22:34:31.235Z] deployed-tree:	0c3229770039fcf2bc15402cf8d85f482ebcb228c7dfbf8ca80e68877f37b2c3
22:34:31 [2025-01-30T22:34:31.235Z] tree:     	d15699fdc58345c245d52dc7470ea9290c412fda57d000795f30debee69b941f
22:34:31 [2025-01-30T22:34:31.235Z] raw-image:	f4989c7135b18d9c2dab5a31adda66dd88ccfdc9e260772b37ecf06aa8e9ab5b
22:34:31 [2025-01-30T22:34:31.235Z] raw-4k-image:	53c4dd32cc8d0bf3a8602d3bbf5b72db66fac838fb2ee2b9d1c57a45257d6e5c
22:34:31 [2025-01-30T22:34:31.235Z] raw-applehv-image:	5aa56043d00707b3684e0601a1d30ab709d16d759dd82465170d4823e3cd5c9b
22:34:31 [2025-01-30T22:34:31.235Z] applehv:  	780d315b6cca6477b00443858bf643c2ce1a68b39026c3824a4404fd67f2344e
22:34:31 [2025-01-30T22:34:31.235Z] raw-gcp-image:	a211d17cd039208910e5019b90507ef73e17564716ef54aabc22620ab3bbb32c
22:34:31 [2025-01-30T22:34:31.235Z] raw-gcp-image-tar:	a312d2bbfa300eb09312d1ac69a6f22dce64b57e153ec1761db449898573d4e9
22:34:31 [2025-01-30T22:34:31.235Z] gcp:      	8187b706eeb28bef52b9929fa4f8e40fbd7f27eefda46a8bc559ce5dcc496553
22:34:31 [2025-01-30T22:34:31.235Z] raw-hyperv-image:	09a931ce639c6a15aed12c914062ad5e02019eea2b9420bc8fba2f597da9c033
22:34:31 [2025-01-30T22:34:31.235Z] hyperv:   	c471a00449a8342a096c48462ee70d0f497514eb97557cd8de0fc0a2d5a4deea
22:34:31 [2025-01-30T22:34:31.235Z] raw-metal-image:	931267540bf5947efb12de2dddf6a66313ce60d46e4d25a1cbc35f08ecacd403
22:34:31 [2025-01-30T22:34:31.235Z] metal:    	e65b99e3dd4f90c2263b0060174d5bfac1566c99511380494f3ad2d749aa9c85
22:34:31 [2025-01-30T22:34:31.235Z] raw-metal4k-image:	3e445716bc0b2cb6a3534e07fb977204b56e14017acc673feea167ceff0c9f31
22:34:31 [2025-01-30T22:34:31.235Z] metal4k:  	318db7c54b3f00e89e2987ca74bc25dfc03ed88e62d10533b43f21c8bd51b32c
22:34:31 [2025-01-30T22:34:31.235Z] raw-qemu-image:	15bb909483b377e5f97ed9ed9864475c024a48d90e96f9aae9c238839ce5093f
22:34:31 [2025-01-30T22:34:31.235Z] qemu:     	ce8800c5ccaa267d53b53bb3dc723c2e0f20af5617e5b05c2d3bdd4ff6745dd7
22:34:31 [2025-01-30T22:34:31.235Z] live:     	ab785420a1b7917655e895e15c23674c898411fd95e2f84eba157cef72bc0036
22:34:31 [2025-01-30T22:34:31.235Z] + set +x
22:34:37 [2025-01-30T22:34:37.741Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.f9Z2ywZZSr/metal/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw': Operation not permitted
22:34:37 [2025-01-30T22:34:37.741Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.f9Z2ywZZSr/metal': Operation not permitted
22:34:41 [2025-01-30T22:34:41.882Z] /home/jenkins/agent/workspace/test-override/builds/42.20250130.dev.0/x86_64/meta.json wrote with version stamp 1738276481608866697
22:34:41 [2025-01-30T22:34:41.882Z] Successfully generated: fedora-coreos-42.20250130.dev.0-metal.x86_64.raw
22:34:41 [2025-01-30T22:34:41.884Z] [Pipeline] }
22:34:41 [2025-01-30T22:34:41.887Z] [Pipeline] // withEnv
22:34:41 [2025-01-30T22:34:41.893Z] [Pipeline] withEnv
22:34:41 [2025-01-30T22:34:41.894Z] [Pipeline] {
22:34:41 [2025-01-30T22:34:41.897Z] [Pipeline] sh
22:34:42 [2025-01-30T22:34:42.423Z] + set -xeuo pipefail
22:34:42 [2025-01-30T22:34:42.423Z] ++ umask
22:34:42 [2025-01-30T22:34:42.423Z] + '[' 0022 = 0000 ']'
22:34:42 [2025-01-30T22:34:42.423Z] + cosa buildextend-metal4k
22:34:42 [2025-01-30T22:34:42.423Z] info: Missing CAP_SYS_ADMIN; using virt
22:34:42 [2025-01-30T22:34:42.680Z] Config commit: 2ff20ef773dbdbf2e61fbc30e5bd761b6513f21c
22:34:42 [2025-01-30T22:34:42.680Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
22:34:43 [2025-01-30T22:34:43.617Z] Will build metal4k
22:35:01 [2025-01-30T22:35:01.615Z] ++ arch
22:35:01 [2025-01-30T22:35:01.615Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-42.20250130.dev.0"' -D 'ostree_ref=""' -D 'ostree_repo=""' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-42.20250130.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2622 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2109 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-Nsn8.json
22:35:01 [2025-01-30T22:35:01.868Z] + set +x
22:35:01 [2025-01-30T22:35:01.868Z] + 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-Nsn8.json
22:35:01 [2025-01-30T22:35:01.868Z] 
22:35:01 [2025-01-30T22:35:01.868Z] Filesystem      Size  Used Avail Use% Mounted on
22:35:01 [2025-01-30T22:35:01.868Z] /dev/vdb1        30G  8.1G   22G  27% /home/jenkins/agent/workspace/test-override/cache
22:35:01 [2025-01-30T22:35:01.868Z] 
22:35:02 [2025-01-30T22:35:02.121Z] starting /tmp/osbuild-Nsn8.jsonPipeline source org.osbuild.curl: 4f122b7b75a9008df1c11f2a23cb518f81424ded83430793f21659e9eff87e45
22:35:02 [2025-01-30T22:35:02.121Z] Build
22:35:02 [2025-01-30T22:35:02.121Z]   root: <host>
22:35:02 [2025-01-30T22:35:02.121Z] 
22:35:02 [2025-01-30T22:35:02.121Z] ���  Duration: 1738276502s
22:35:02 [2025-01-30T22:35:02.374Z] Pipeline raw-4k-image: 53c4dd32cc8d0bf3a8602d3bbf5b72db66fac838fb2ee2b9d1c57a45257d6e5c
22:35:02 [2025-01-30T22:35:02.374Z] Build
22:35:02 [2025-01-30T22:35:02.374Z]   root: <host>
22:35:02 [2025-01-30T22:35:02.374Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
22:35:02 [2025-01-30T22:35:02.374Z] org.osbuild.truncate: 97db3d0c9ceff2e1e02747e0ef810bddaf2a57a8d1b32a56f4e6bf7d3e2ba8c8 {
22:35:02 [2025-01-30T22:35:02.374Z]   "filename": "disk.img",
22:35:02 [2025-01-30T22:35:02.374Z]   "size": "2749366272"
22:35:02 [2025-01-30T22:35:02.374Z] }
22:35:02 [2025-01-30T22:35:02.374Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:02 [2025-01-30T22:35:02.627Z] 
22:35:02 [2025-01-30T22:35:02.627Z] ���  Duration: 0s
22:35:02 [2025-01-30T22:35:02.627Z] org.osbuild.sfdisk: 797b4602cc626ef589ad0ffdfaa73c4e51b401bea68fe7a9287875217b94b4ff {
22:35:02 [2025-01-30T22:35:02.627Z]   "uuid": "00000000-0000-4000-a000-000000000001",
22:35:02 [2025-01-30T22:35:02.627Z]   "label": "gpt",
22:35:02 [2025-01-30T22:35:02.627Z]   "partitions": [
22:35:02 [2025-01-30T22:35:02.627Z]     {
22:35:02 [2025-01-30T22:35:02.627Z]       "start": 256,
22:35:02 [2025-01-30T22:35:02.627Z]       "partnum": 1,
22:35:02 [2025-01-30T22:35:02.627Z]       "size": 256,
22:35:02 [2025-01-30T22:35:02.627Z]       "type": "21686148-6449-6E6F-744E-656564454649",
22:35:02 [2025-01-30T22:35:02.627Z]       "bootable": true,
22:35:02 [2025-01-30T22:35:02.627Z]       "name": "BIOS-BOOT"
22:35:02 [2025-01-30T22:35:02.627Z]     },
22:35:02 [2025-01-30T22:35:02.627Z]     {
22:35:02 [2025-01-30T22:35:02.627Z]       "start": 512,
22:35:02 [2025-01-30T22:35:02.627Z]       "partnum": 2,
22:35:02 [2025-01-30T22:35:02.627Z]       "size": 32512,
22:35:02 [2025-01-30T22:35:02.627Z]       "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
22:35:02 [2025-01-30T22:35:02.627Z]       "name": "EFI-SYSTEM"
22:35:02 [2025-01-30T22:35:02.627Z]     },
22:35:02 [2025-01-30T22:35:02.627Z]     {
22:35:02 [2025-01-30T22:35:02.627Z]       "start": 33024,
22:35:02 [2025-01-30T22:35:02.627Z]       "partnum": 3,
22:35:02 [2025-01-30T22:35:02.627Z]       "size": 98304,
22:35:02 [2025-01-30T22:35:02.627Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
22:35:02 [2025-01-30T22:35:02.627Z]       "name": "boot"
22:35:02 [2025-01-30T22:35:02.627Z]     },
22:35:02 [2025-01-30T22:35:02.627Z]     {
22:35:02 [2025-01-30T22:35:02.627Z]       "start": 131328,
22:35:02 [2025-01-30T22:35:02.627Z]       "partnum": 4,
22:35:02 [2025-01-30T22:35:02.627Z]       "size": 539648,
22:35:02 [2025-01-30T22:35:02.627Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
22:35:02 [2025-01-30T22:35:02.627Z]       "name": "root"
22:35:02 [2025-01-30T22:35:02.627Z]     }
22:35:02 [2025-01-30T22:35:02.627Z]   ]
22:35:02 [2025-01-30T22:35:02.627Z] }
22:35:02 [2025-01-30T22:35:02.627Z] device/device (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:02 [2025-01-30T22:35:02.881Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:02 [2025-01-30T22:35:02.881Z] label: gpt
22:35:02 [2025-01-30T22:35:02.881Z] label-id: 00000000-0000-4000-a000-000000000001
22:35:02 [2025-01-30T22:35:02.881Z] /dev/loop0p1: start="256", size="256", type="21686148-6449-6E6F-744E-656564454649", name="BIOS-BOOT", bootable
22:35:02 [2025-01-30T22:35:02.881Z] /dev/loop0p2: start="512", size="32512", type="C12A7328-F81F-11D2-BA4B-00A0C93EC93B", name="EFI-SYSTEM"
22:35:02 [2025-01-30T22:35:02.881Z] /dev/loop0p3: start="33024", size="98304", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="boot"
22:35:02 [2025-01-30T22:35:02.881Z] /dev/loop0p4: start="131328", size="539648", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="root"
22:35:02 [2025-01-30T22:35:02.881Z] {
22:35:02 [2025-01-30T22:35:02.881Z]    "partitiontable": {
22:35:02 [2025-01-30T22:35:02.881Z]       "label": "gpt",
22:35:02 [2025-01-30T22:35:02.881Z]       "id": "00000000-0000-4000-A000-000000000001",
22:35:02 [2025-01-30T22:35:02.881Z]       "device": "/dev/loop0",
22:35:02 [2025-01-30T22:35:02.881Z]       "unit": "sectors",
22:35:02 [2025-01-30T22:35:02.881Z]       "firstlba": 256,
22:35:02 [2025-01-30T22:35:02.881Z]       "lastlba": 671226,
22:35:02 [2025-01-30T22:35:02.881Z]       "sectorsize": 4096,
22:35:02 [2025-01-30T22:35:02.881Z]       "partitions": [
22:35:02 [2025-01-30T22:35:02.881Z]          {
22:35:02 [2025-01-30T22:35:02.881Z]             "node": "/dev/loop0p1",
22:35:02 [2025-01-30T22:35:02.881Z]             "start": 256,
22:35:02 [2025-01-30T22:35:02.881Z]             "size": 256,
22:35:02 [2025-01-30T22:35:02.881Z]             "type": "21686148-6449-6E6F-744E-656564454649",
22:35:02 [2025-01-30T22:35:02.881Z]             "uuid": "5158E6BD-71C8-4C9A-8236-9B73E6624190",
22:35:02 [2025-01-30T22:35:02.881Z]             "name": "BIOS-BOOT"
22:35:02 [2025-01-30T22:35:02.881Z]          },{
22:35:02 [2025-01-30T22:35:02.881Z]             "node": "/dev/loop0p2",
22:35:02 [2025-01-30T22:35:02.881Z]             "start": 512,
22:35:02 [2025-01-30T22:35:02.881Z]             "size": 32512,
22:35:02 [2025-01-30T22:35:02.881Z]             "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
22:35:02 [2025-01-30T22:35:02.881Z]             "uuid": "C45873F7-C78F-4E50-93C2-74F1D7D3DE89",
22:35:02 [2025-01-30T22:35:02.881Z]             "name": "EFI-SYSTEM"
22:35:02 [2025-01-30T22:35:02.881Z]          },{
22:35:02 [2025-01-30T22:35:02.881Z]             "node": "/dev/loop0p3",
22:35:02 [2025-01-30T22:35:02.881Z]             "start": 33024,
22:35:02 [2025-01-30T22:35:02.881Z]             "size": 98304,
22:35:02 [2025-01-30T22:35:02.881Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
22:35:02 [2025-01-30T22:35:02.881Z]             "uuid": "61450FDF-96D9-4CA3-A1C1-3627363DAC3D",
22:35:02 [2025-01-30T22:35:02.881Z]             "name": "boot"
22:35:02 [2025-01-30T22:35:02.881Z]          },{
22:35:02 [2025-01-30T22:35:02.881Z]             "node": "/dev/loop0p4",
22:35:02 [2025-01-30T22:35:02.881Z]             "start": 131328,
22:35:02 [2025-01-30T22:35:02.881Z]             "size": 539648,
22:35:02 [2025-01-30T22:35:02.881Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
22:35:02 [2025-01-30T22:35:02.881Z]             "uuid": "783AF2E6-9EAC-4BF3-B07B-BC2FF79D0BEB",
22:35:02 [2025-01-30T22:35:02.881Z]             "name": "root"
22:35:02 [2025-01-30T22:35:02.881Z]          }
22:35:02 [2025-01-30T22:35:02.881Z]       ]
22:35:02 [2025-01-30T22:35:02.881Z]    }
22:35:02 [2025-01-30T22:35:02.881Z] }
22:35:03 [2025-01-30T22:35:03.133Z] 
22:35:03 [2025-01-30T22:35:03.133Z] ���  Duration: 0s
22:35:03 [2025-01-30T22:35:03.133Z] org.osbuild.mkfs.fat: f76467757f8ac969a8fb4f69ece79cd60c0691657890693b0fd6a603343e7c3b {
22:35:03 [2025-01-30T22:35:03.133Z]   "label": "EFI-SYSTEM",
22:35:03 [2025-01-30T22:35:03.133Z]   "volid": "7B7795E7"
22:35:03 [2025-01-30T22:35:03.133Z] }
22:35:03 [2025-01-30T22:35:03.133Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
22:35:03 [2025-01-30T22:35:03.133Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:03 [2025-01-30T22:35:03.387Z] mkfs.fat 4.2 (2021-01-31)
22:35:03 [2025-01-30T22:35:03.387Z] 
22:35:03 [2025-01-30T22:35:03.387Z] ���  Duration: 0s
22:35:03 [2025-01-30T22:35:03.387Z] org.osbuild.mkfs.ext4: 5e20c38e22a5e1e257e40d7c02805e55ade604e384987acbd96c242044b80ef3 {
22:35:03 [2025-01-30T22:35:03.387Z]   "uuid": "96d15588-3596-4b3c-adca-a2ff7279ea63",
22:35:03 [2025-01-30T22:35:03.387Z]   "label": "boot",
22:35:03 [2025-01-30T22:35:03.387Z]   "metadata_csum_seed": true
22:35:03 [2025-01-30T22:35:03.387Z] }
22:35:03 [2025-01-30T22:35:03.387Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
22:35:03 [2025-01-30T22:35:03.639Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:03 [2025-01-30T22:35:03.639Z] mke2fs 1.47.1 (20-May-2024)
22:35:03 [2025-01-30T22:35:03.639Z] Discarding device blocks:     0/98304           done                            
22:35:03 [2025-01-30T22:35:03.639Z] Creating filesystem with 98304 4k blocks and 98304 inodes
22:35:03 [2025-01-30T22:35:03.639Z] Filesystem UUID: 96d15588-3596-4b3c-adca-a2ff7279ea63
22:35:03 [2025-01-30T22:35:03.639Z] Superblock backups stored on blocks: 
22:35:03 [2025-01-30T22:35:03.639Z] 	32768
22:35:03 [2025-01-30T22:35:03.639Z] 
22:35:03 [2025-01-30T22:35:03.639Z] Allocating group tables: 0/3   done                            
22:35:03 [2025-01-30T22:35:03.639Z] Writing inode tables: 0/3   done                            
22:35:03 [2025-01-30T22:35:03.639Z] Creating journal (4096 blocks): done
22:35:03 [2025-01-30T22:35:03.892Z] Writing superblocks and filesystem accounting information: 0/3   done
22:35:03 [2025-01-30T22:35:03.892Z] 
22:35:03 [2025-01-30T22:35:03.892Z] 
22:35:03 [2025-01-30T22:35:03.892Z] ���  Duration: 0s
22:35:03 [2025-01-30T22:35:03.892Z] org.osbuild.mkfs.xfs: 87523cb2bbf3b950e4000db193abe39ddc605fc439d10b2b884bac0bb3332912 {
22:35:03 [2025-01-30T22:35:03.892Z]   "uuid": "910678ff-f77e-4a7d-8d53-86f2ac47a823",
22:35:03 [2025-01-30T22:35:03.892Z]   "label": "root"
22:35:03 [2025-01-30T22:35:03.892Z] }
22:35:03 [2025-01-30T22:35:03.892Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
22:35:04 [2025-01-30T22:35:04.154Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:04 [2025-01-30T22:35:04.155Z] meta-data=/dev/loop0             isize=512    agcount=4, agsize=134912 blks
22:35:04 [2025-01-30T22:35:04.155Z]          =                       sectsz=4096  attr=2, projid32bit=1
22:35:04 [2025-01-30T22:35:04.155Z]          =                       crc=1        finobt=1, sparse=1, rmapbt=1
22:35:04 [2025-01-30T22:35:04.155Z]          =                       reflink=1    bigtime=1 inobtcount=1 nrext64=1
22:35:04 [2025-01-30T22:35:04.155Z] data     =                       bsize=4096   blocks=539648, imaxpct=25
22:35:04 [2025-01-30T22:35:04.155Z]          =                       sunit=0      swidth=0 blks
22:35:04 [2025-01-30T22:35:04.155Z] naming   =version 2              bsize=4096   ascii-ci=0, ftype=1
22:35:04 [2025-01-30T22:35:04.155Z] log      =internal log           bsize=4096   blocks=16384, version=2
22:35:04 [2025-01-30T22:35:04.155Z]          =                       sectsz=4096  sunit=1 blks, lazy-count=1
22:35:04 [2025-01-30T22:35:04.155Z] realtime =none                   extsz=4096   blocks=0, rtextents=0
22:35:04 [2025-01-30T22:35:04.407Z] Discarding blocks...Done.
22:35:04 [2025-01-30T22:35:04.407Z] 
22:35:04 [2025-01-30T22:35:04.407Z] ���  Duration: 0s
22:35:04 [2025-01-30T22:35:04.407Z] org.osbuild.mkdir: b6f174eb479b536f98eaf3f2c0fd5852c19d7aa1e6ed5f0164652ad4874460fc {
22:35:04 [2025-01-30T22:35:04.407Z]   "paths": [
22:35:04 [2025-01-30T22:35:04.407Z]     {
22:35:04 [2025-01-30T22:35:04.407Z]       "path": "mount://root/boot",
22:35:04 [2025-01-30T22:35:04.407Z]       "mode": 493
22:35:04 [2025-01-30T22:35:04.407Z]     },
22:35:04 [2025-01-30T22:35:04.407Z]     {
22:35:04 [2025-01-30T22:35:04.407Z]       "path": "mount://boot/efi",
22:35:04 [2025-01-30T22:35:04.407Z]       "mode": 493
22:35:04 [2025-01-30T22:35:04.407Z]     }
22:35:04 [2025-01-30T22:35:04.407Z]   ]
22:35:04 [2025-01-30T22:35:04.407Z] }
22:35:04 [2025-01-30T22:35:04.661Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:04 [2025-01-30T22:35:04.661Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-gx3doo8h/mounts/root-mount-point
22:35:05 [2025-01-30T22:35:05.299Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-gx3doo8h/mounts/boot-mount-point
22:35:05 [2025-01-30T22:35:05.299Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:05 [2025-01-30T22:35:05.299Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-gx3doo8h/mounts/boot-mount-point unmounted
22:35:05 [2025-01-30T22:35:05.299Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-gx3doo8h/mounts/root-mount-point unmounted
22:35:05 [2025-01-30T22:35:05.299Z] 
22:35:05 [2025-01-30T22:35:05.299Z] ���  Duration: 0s
22:35:05 [2025-01-30T22:35:05.299Z] org.osbuild.selinux: 5a3654eec886ccb5c1bd4b0b9dbfc6f0e6131fbba6b3abf4ca731670344ad2d0 {
22:35:05 [2025-01-30T22:35:05.299Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
22:35:05 [2025-01-30T22:35:05.299Z]   "target": "mount://root/"
22:35:05 [2025-01-30T22:35:05.299Z] }
22:35:05 [2025-01-30T22:35:05.552Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:05 [2025-01-30T22:35:05.552Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-j8kskqyb/mounts/
22:35:05 [2025-01-30T22:35:05.552Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:06 [2025-01-30T22:35:06.113Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.bin:  line 1 error due to: Non-ASCII characters found
22:35:06 [2025-01-30T22:35:06.369Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.homedirs.bin:  line 1 error due to: Non-ASCII characters found
22:35:06 [2025-01-30T22:35:06.369Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-j8kskqyb/mounts/ unmounted
22:35:06 [2025-01-30T22:35:06.622Z] 
22:35:06 [2025-01-30T22:35:06.622Z] ���  Duration: 1s
22:35:06 [2025-01-30T22:35:06.622Z] org.osbuild.selinux: 1f1be8987edf251435495db56a6056080dd99e83341567bb8d44e5409ebd5098 {
22:35:06 [2025-01-30T22:35:06.622Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
22:35:06 [2025-01-30T22:35:06.622Z]   "target": "mount://root/boot/"
22:35:06 [2025-01-30T22:35:06.622Z] }
22:35:06 [2025-01-30T22:35:06.622Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:06 [2025-01-30T22:35:06.874Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-308vjh9r/mounts/
22:35:06 [2025-01-30T22:35:06.874Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-308vjh9r/mounts/boot
22:35:06 [2025-01-30T22:35:06.874Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:07 [2025-01-30T22:35:07.127Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.bin:  line 1 error due to: Non-ASCII characters found
22:35:07 [2025-01-30T22:35:07.127Z] setfiles: /run/osbuild/inputs/tree/etc/selinux/targeted/contexts/files/file_contexts.homedirs.bin:  line 1 error due to: Non-ASCII characters found
22:35:07 [2025-01-30T22:35:07.127Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-308vjh9r/mounts/boot unmounted
22:35:07 [2025-01-30T22:35:07.127Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-308vjh9r/mounts/ unmounted
22:35:07 [2025-01-30T22:35:07.127Z] 
22:35:07 [2025-01-30T22:35:07.127Z] ���  Duration: 0s
22:35:07 [2025-01-30T22:35:07.127Z] org.osbuild.copy: 607713069397bfd6cb6cc746b6d3003cfbb179e1a735d7fe7edd45b6b8d85c38 {
22:35:07 [2025-01-30T22:35:07.127Z]   "paths": [
22:35:07 [2025-01-30T22:35:07.127Z]     {
22:35:07 [2025-01-30T22:35:07.127Z]       "from": "input://tree/",
22:35:07 [2025-01-30T22:35:07.127Z]       "to": "mount://root/"
22:35:07 [2025-01-30T22:35:07.127Z]     }
22:35:07 [2025-01-30T22:35:07.127Z]   ]
22:35:07 [2025-01-30T22:35:07.127Z] }
22:35:07 [2025-01-30T22:35:07.682Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:07 [2025-01-30T22:35:07.682Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-hiq4r6el/mounts/
22:35:07 [2025-01-30T22:35:07.682Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-hiq4r6el/mounts/boot
22:35:07 [2025-01-30T22:35:07.682Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-hiq4r6el/mounts/boot/efi
22:35:07 [2025-01-30T22:35:07.934Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:07 [2025-01-30T22:35:07.934Z] copying '/run/osbuild/inputs/tree/.' -> '/run/osbuild/mounts/.'
22:35:12 [2025-01-30T22:35:12.074Z] 
22:35:12 [2025-01-30T22:35:12.074Z] Filesystem      Size  Used Avail Use% Mounted on
22:35:12 [2025-01-30T22:35:12.074Z] /dev/vdb1        30G  8.2G   22G  28% /home/jenkins/agent/workspace/test-override/cache
22:35:12 [2025-01-30T22:35:12.074Z] 
22:35:21 [2025-01-30T22:35:21.988Z] 
22:35:21 [2025-01-30T22:35:21.988Z] Filesystem      Size  Used Avail Use% Mounted on
22:35:21 [2025-01-30T22:35:21.988Z] /dev/vdb1        30G  9.1G   21G  31% /home/jenkins/agent/workspace/test-override/cache
22:35:21 [2025-01-30T22:35:21.988Z] 
22:35:31 [2025-01-30T22:35:31.899Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-hiq4r6el/mounts/boot/efi unmounted
22:35:31 [2025-01-30T22:35:31.899Z] 
22:35:31 [2025-01-30T22:35:31.899Z] Filesystem      Size  Used Avail Use% Mounted on
22:35:31 [2025-01-30T22:35:31.899Z] /dev/vdb1        30G  9.8G   21G  33% /home/jenkins/agent/workspace/test-override/cache
22:35:31 [2025-01-30T22:35:31.899Z] 
22:35:31 [2025-01-30T22:35:31.899Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-hiq4r6el/mounts/boot unmounted
22:35:32 [2025-01-30T22:35:32.463Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-hiq4r6el/mounts/ unmounted
22:35:32 [2025-01-30T22:35:32.463Z] 
22:35:32 [2025-01-30T22:35:32.463Z] ���  Duration: 25s
22:35:32 [2025-01-30T22:35:32.463Z] org.osbuild.bootupd: 6474ef3851b298b2646f5bcf6a21345a9f8f747c909f6669d8b84decb913d7bf {
22:35:32 [2025-01-30T22:35:32.464Z]   "static-configs": true,
22:35:32 [2025-01-30T22:35:32.464Z]   "deployment": {
22:35:32 [2025-01-30T22:35:32.464Z]     "default": true
22:35:32 [2025-01-30T22:35:32.464Z]   }
22:35:32 [2025-01-30T22:35:32.464Z] }
22:35:32 [2025-01-30T22:35:32.464Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:32 [2025-01-30T22:35:32.717Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-7fvrx03m/mounts/
22:35:32 [2025-01-30T22:35:32.717Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-7fvrx03m/mounts/boot
22:35:32 [2025-01-30T22:35:32.717Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-7fvrx03m/mounts/boot/efi
22:35:32 [2025-01-30T22:35:32.969Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:32 [2025-01-30T22:35:32.969Z] Skip installing component BIOS without target device
22:35:33 [2025-01-30T22:35:33.222Z] Installed 40_coreos-ignition.cfg
22:35:33 [2025-01-30T22:35:33.222Z] Installed 70_coreos-user.cfg
22:35:33 [2025-01-30T22:35:33.222Z] Installed: grub.cfg
22:35:33 [2025-01-30T22:35:33.222Z] Installed: "fedora/grub.cfg"
22:35:33 [2025-01-30T22:35:33.222Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-7fvrx03m/mounts/boot/efi unmounted
22:35:33 [2025-01-30T22:35:33.222Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-7fvrx03m/mounts/boot unmounted
22:35:33 [2025-01-30T22:35:33.222Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-7fvrx03m/mounts/ unmounted
22:35:33 [2025-01-30T22:35:33.222Z] 
22:35:33 [2025-01-30T22:35:33.222Z] ���  Duration: 0s
22:35:33 [2025-01-30T22:35:33.222Z] org.osbuild.chattr: 53c4dd32cc8d0bf3a8602d3bbf5b72db66fac838fb2ee2b9d1c57a45257d6e5c {
22:35:33 [2025-01-30T22:35:33.222Z]   "items": {
22:35:33 [2025-01-30T22:35:33.222Z]     "mount://root/": {
22:35:33 [2025-01-30T22:35:33.222Z]       "immutable": true
22:35:33 [2025-01-30T22:35:33.222Z]     }
22:35:33 [2025-01-30T22:35:33.222Z]   }
22:35:33 [2025-01-30T22:35:33.222Z] }
22:35:33 [2025-01-30T22:35:33.475Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:33 [2025-01-30T22:35:33.475Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts/
22:35:33 [2025-01-30T22:35:33.475Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0'
22:35:33 [2025-01-30T22:35:33.727Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts/boot unmounted
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts/var unmounted
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts/sysroot unmounted
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts unmounted
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts unmounted
22:35:33 [2025-01-30T22:35:33.727Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts unmounted
22:35:33 [2025-01-30T22:35:33.979Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-cenmrker/mounts/
22:35:33 [2025-01-30T22:35:33.980Z] 
22:35:33 [2025-01-30T22:35:33.980Z] ���  Duration: 0s
22:35:33 [2025-01-30T22:35:33.980Z] Pipeline raw-metal4k-image: 3e445716bc0b2cb6a3534e07fb977204b56e14017acc673feea167ceff0c9f31
22:35:33 [2025-01-30T22:35:33.980Z] Build
22:35:33 [2025-01-30T22:35:33.980Z]   root: <host>
22:35:33 [2025-01-30T22:35:33.980Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
22:35:33 [2025-01-30T22:35:33.980Z] org.osbuild.copy: b5d2af6910499c70d0502332f7dbda869742d7cf51facc7c75412cfc4cb22e3b {
22:35:33 [2025-01-30T22:35:33.980Z]   "paths": [
22:35:33 [2025-01-30T22:35:33.980Z]     {
22:35:33 [2025-01-30T22:35:33.980Z]       "from": "input://tree/disk.img",
22:35:33 [2025-01-30T22:35:33.980Z]       "to": "tree:///disk.img"
22:35:33 [2025-01-30T22:35:33.980Z]     }
22:35:33 [2025-01-30T22:35:33.980Z]   ]
22:35:33 [2025-01-30T22:35:33.980Z] }
22:35:34 [2025-01-30T22:35:34.232Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:34 [2025-01-30T22:35:34.232Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
22:35:34 [2025-01-30T22:35:34.232Z] 
22:35:34 [2025-01-30T22:35:34.232Z] ���  Duration: 0s
22:35:34 [2025-01-30T22:35:34.232Z] org.osbuild.coreos.platform: 3e445716bc0b2cb6a3534e07fb977204b56e14017acc673feea167ceff0c9f31 {
22:35:34 [2025-01-30T22:35:34.232Z]   "platform": "metal"
22:35:34 [2025-01-30T22:35:34.232Z] }
22:35:34 [2025-01-30T22:35:34.485Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
22:35:34 [2025-01-30T22:35:34.485Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/
22:35:34 [2025-01-30T22:35:34.485Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0'
22:35:34 [2025-01-30T22:35:34.738Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/boot
22:35:34 [2025-01-30T22:35:34.738Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:34 [2025-01-30T22:35:34.991Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/boot unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/boot unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/var unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/sysroot unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts unmounted
22:35:34 [2025-01-30T22:35:34.992Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-0mofyhnc/mounts/
22:35:34 [2025-01-30T22:35:34.992Z] 
22:35:34 [2025-01-30T22:35:34.992Z] ���  Duration: 0s
22:35:34 [2025-01-30T22:35:34.992Z] Pipeline metal4k: 318db7c54b3f00e89e2987ca74bc25dfc03ed88e62d10533b43f21c8bd51b32c
22:35:34 [2025-01-30T22:35:34.992Z] Build
22:35:34 [2025-01-30T22:35:34.992Z]   root: <host>
22:35:34 [2025-01-30T22:35:34.992Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
22:35:34 [2025-01-30T22:35:34.992Z] org.osbuild.copy: 318db7c54b3f00e89e2987ca74bc25dfc03ed88e62d10533b43f21c8bd51b32c {
22:35:34 [2025-01-30T22:35:34.992Z]   "paths": [
22:35:34 [2025-01-30T22:35:34.992Z]     {
22:35:34 [2025-01-30T22:35:34.992Z]       "from": "input://tree/disk.img",
22:35:34 [2025-01-30T22:35:34.992Z]       "to": "tree:///fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw"
22:35:34 [2025-01-30T22:35:34.992Z]     }
22:35:34 [2025-01-30T22:35:34.992Z]   ]
22:35:34 [2025-01-30T22:35:34.992Z] }
22:35:35 [2025-01-30T22:35:35.244Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
22:35:35 [2025-01-30T22:35:35.244Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw'
22:35:35 [2025-01-30T22:35:35.497Z] 
22:35:35 [2025-01-30T22:35:35.497Z] ���  Duration: 0s
22:35:35 [2025-01-30T22:35:35.497Z] manifest /tmp/osbuild-Nsn8.json finished successfully
22:35:35 [2025-01-30T22:35:35.749Z] oci-archive:	bd476a0cc2ae6ffbfdbcdf5abc6e125e9d3541c182c1e959c508c598576c39c6
22:35:35 [2025-01-30T22:35:35.749Z] deployed-tree:	0c3229770039fcf2bc15402cf8d85f482ebcb228c7dfbf8ca80e68877f37b2c3
22:35:35 [2025-01-30T22:35:35.749Z] tree:     	d15699fdc58345c245d52dc7470ea9290c412fda57d000795f30debee69b941f
22:35:35 [2025-01-30T22:35:35.749Z] raw-image:	f4989c7135b18d9c2dab5a31adda66dd88ccfdc9e260772b37ecf06aa8e9ab5b
22:35:35 [2025-01-30T22:35:35.749Z] raw-4k-image:	53c4dd32cc8d0bf3a8602d3bbf5b72db66fac838fb2ee2b9d1c57a45257d6e5c
22:35:35 [2025-01-30T22:35:35.749Z] raw-applehv-image:	5aa56043d00707b3684e0601a1d30ab709d16d759dd82465170d4823e3cd5c9b
22:35:35 [2025-01-30T22:35:35.749Z] applehv:  	780d315b6cca6477b00443858bf643c2ce1a68b39026c3824a4404fd67f2344e
22:35:35 [2025-01-30T22:35:35.749Z] raw-gcp-image:	a211d17cd039208910e5019b90507ef73e17564716ef54aabc22620ab3bbb32c
22:35:35 [2025-01-30T22:35:35.749Z] raw-gcp-image-tar:	a312d2bbfa300eb09312d1ac69a6f22dce64b57e153ec1761db449898573d4e9
22:35:35 [2025-01-30T22:35:35.749Z] gcp:      	8187b706eeb28bef52b9929fa4f8e40fbd7f27eefda46a8bc559ce5dcc496553
22:35:35 [2025-01-30T22:35:35.749Z] raw-hyperv-image:	09a931ce639c6a15aed12c914062ad5e02019eea2b9420bc8fba2f597da9c033
22:35:35 [2025-01-30T22:35:35.749Z] hyperv:   	c471a00449a8342a096c48462ee70d0f497514eb97557cd8de0fc0a2d5a4deea
22:35:35 [2025-01-30T22:35:35.749Z] raw-metal-image:	931267540bf5947efb12de2dddf6a66313ce60d46e4d25a1cbc35f08ecacd403
22:35:35 [2025-01-30T22:35:35.749Z] metal:    	e65b99e3dd4f90c2263b0060174d5bfac1566c99511380494f3ad2d749aa9c85
22:35:35 [2025-01-30T22:35:35.749Z] raw-metal4k-image:	3e445716bc0b2cb6a3534e07fb977204b56e14017acc673feea167ceff0c9f31
22:35:35 [2025-01-30T22:35:35.749Z] metal4k:  	318db7c54b3f00e89e2987ca74bc25dfc03ed88e62d10533b43f21c8bd51b32c
22:35:35 [2025-01-30T22:35:35.749Z] raw-qemu-image:	15bb909483b377e5f97ed9ed9864475c024a48d90e96f9aae9c238839ce5093f
22:35:35 [2025-01-30T22:35:35.749Z] qemu:     	ce8800c5ccaa267d53b53bb3dc723c2e0f20af5617e5b05c2d3bdd4ff6745dd7
22:35:35 [2025-01-30T22:35:35.749Z] live:     	ab785420a1b7917655e895e15c23674c898411fd95e2f84eba157cef72bc0036
22:35:35 [2025-01-30T22:35:35.749Z] + set +x
22:35:39 [2025-01-30T22:35:39.893Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.ift8llz0fD/metal4k/fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw': Operation not permitted
22:35:39 [2025-01-30T22:35:39.893Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.ift8llz0fD/metal4k': Operation not permitted
22:35:47 [2025-01-30T22:35:47.967Z] /home/jenkins/agent/workspace/test-override/builds/42.20250130.dev.0/x86_64/meta.json wrote with version stamp 1738276546445442088
22:35:47 [2025-01-30T22:35:47.967Z] Successfully generated: fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw
22:35:47 [2025-01-30T22:35:47.969Z] [Pipeline] }
22:35:47 [2025-01-30T22:35:47.972Z] [Pipeline] // withEnv
22:35:47 [2025-01-30T22:35:47.979Z] [Pipeline] }
22:35:47 [2025-01-30T22:35:47.983Z] [Pipeline] // stage
22:35:47 [2025-01-30T22:35:47.995Z] [Pipeline] stage
22:35:47 [2025-01-30T22:35:47.996Z] [Pipeline] { (x86_64:Build Live)
22:35:48 [2025-01-30T22:35:48.046Z] [Pipeline] withEnv
22:35:48 [2025-01-30T22:35:48.046Z] [Pipeline] {
22:35:48 [2025-01-30T22:35:48.051Z] [Pipeline] sh
22:35:48 [2025-01-30T22:35:48.578Z] + set -xeuo pipefail
22:35:48 [2025-01-30T22:35:48.578Z] ++ umask
22:35:48 [2025-01-30T22:35:48.578Z] + '[' 0022 = 0000 ']'
22:35:48 [2025-01-30T22:35:48.578Z] + cosa buildextend-live --fast
22:35:48 [2025-01-30T22:35:48.578Z] Targeting build: 42.20250130.dev.0
22:35:48 [2025-01-30T22:35:48.831Z] 2025-01-30 22:35:48,635 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '65f95ade71e77f9054e7aa6575712758e08b702c324a912a5778cc0fedd27636', '/usr/lib/modules']
22:35:48 [2025-01-30T22:35:48.831Z] 2025-01-30 22:35:48,645 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.rc0.20250130git72deda0abee6.11.fc42.x86_64/vmlinuz', '65f95ade71e77f9054e7aa6575712758e08b702c324a912a5778cc0fedd27636', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
22:35:48 [2025-01-30T22:35:48.831Z] 2025-01-30 22:35:48,698 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.rc0.20250130git72deda0abee6.11.fc42.x86_64/initramfs.img', '65f95ade71e77f9054e7aa6575712758e08b702c324a912a5778cc0fedd27636', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
22:35:49 [2025-01-30T22:35:49.083Z] 2025-01-30 22:35:48,901 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '65f95ade71e77f9054e7aa6575712758e08b702c324a912a5778cc0fedd27636', '/usr/share/coreos-installer/example-config.yaml']
22:35:49 [2025-01-30T22:35:49.083Z] 2025-01-30 22:35:48,917 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '65f95ade71e77f9054e7aa6575712758e08b702c324a912a5778cc0fedd27636', '/tmp/tmpktukgl71']
22:35:49 [2025-01-30T22:35:49.083Z] Generating osmet file for 512b metal image
22:35:49 [2025-01-30T22:35:49.083Z] 2025-01-30 22:35:48,933 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20250130.dev.0', '--checksum', '8e606d1984c973edd1c4ac047a3eed68fa66d6676fc3256c0d2fd197dd167eff', '--output', '/var/tmp/coreos-installer-output', '--fast']
22:36:07 [2025-01-30T22:36:07.108Z] + RUST_BACKTRACE=full
22:36:07 [2025-01-30T22:36:07.108Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20250130.dev.0' --checksum 8e606d1984c973edd1c4ac047a3eed68fa66d6676fc3256c0d2fd197dd167eff --output /var/tmp/coreos-installer-output --fast
22:36:12 [2025-01-30T22:36:12.347Z] Total OSTree objects scanned from /root: 17844 (17838 mapped, 6 empty)
22:36:12 [2025-01-30T22:36:12.347Z] Total OSTree objects found in /boot: 313
22:36:12 [2025-01-30T22:36:12.347Z] Duplicate extents dropped: 0
22:36:12 [2025-01-30T22:36:12.347Z] Overlapping extents clamped: 0
22:36:12 [2025-01-30T22:36:12.347Z] Total /root extents: 17839
22:36:12 [2025-01-30T22:36:12.347Z] Duplicate extents dropped: 0
22:36:12 [2025-01-30T22:36:12.347Z] Overlapping extents clamped: 0
22:36:12 [2025-01-30T22:36:12.347Z] Total /boot extents: 318
22:36:12 [2025-01-30T22:36:12.347Z] Packing image
22:36:27 [2025-01-30T22:36:27.159Z] Total bytes skipped: 1660995584
22:36:27 [2025-01-30T22:36:27.159Z] Total bytes written: 1088370688
22:36:27 [2025-01-30T22:36:27.159Z] Total bytes written (compressed): 25701604
22:36:27 [2025-01-30T22:36:27.159Z] Verifying that repacked image matches digest
22:36:35 [2025-01-30T22:36:35.217Z] Packing successful!
22:36:35 [2025-01-30T22:36:35.217Z] + '[' -f /var/tmp/coreos-installer-output ']'
22:36:35 [2025-01-30T22:36:35.217Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
22:36:36 [2025-01-30T22:36:36.145Z] Generating osmet file for 4k metal image
22:36:36 [2025-01-30T22:36:36.145Z] 2025-01-30 22:36:36,002 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20250130.dev.0', '--checksum', 'e291e0e302ccddc243a24cef98379649a55facfb0318edec9f10b0b9dbf2d135', '--output', '/var/tmp/coreos-installer-output', '--fast']
22:36:54 [2025-01-30T22:36:54.178Z] + RUST_BACKTRACE=full
22:36:54 [2025-01-30T22:36:54.178Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20250130.dev.0' --checksum e291e0e302ccddc243a24cef98379649a55facfb0318edec9f10b0b9dbf2d135 --output /var/tmp/coreos-installer-output --fast
22:36:54 [2025-01-30T22:36:54.178Z] Total OSTree objects scanned from /root: 17844 (17838 mapped, 6 empty)
22:36:54 [2025-01-30T22:36:54.178Z] Total OSTree objects found in /boot: 3
22:36:54 [2025-01-30T22:36:54.178Z] Duplicate extents dropped: 0
22:36:54 [2025-01-30T22:36:54.178Z] Overlapping extents clamped: 0
22:36:54 [2025-01-30T22:36:54.178Z] Total /root extents: 17838
22:36:54 [2025-01-30T22:36:54.178Z] Duplicate extents dropped: 0
22:36:54 [2025-01-30T22:36:54.178Z] Overlapping extents clamped: 0
22:36:54 [2025-01-30T22:36:54.178Z] Total /boot extents: 5
22:36:54 [2025-01-30T22:36:54.178Z] Packing image
22:37:06 [2025-01-30T22:37:06.323Z] Total bytes skipped: 1650147328
22:37:06 [2025-01-30T22:37:06.323Z] Total bytes written: 1099218944
22:37:06 [2025-01-30T22:37:06.323Z] Total bytes written (compressed): 25476176
22:37:06 [2025-01-30T22:37:06.323Z] Verifying that repacked image matches digest
22:37:12 [2025-01-30T22:37:12.863Z] Packing successful!
22:37:12 [2025-01-30T22:37:12.863Z] + '[' -f /var/tmp/coreos-installer-output ']'
22:37:12 [2025-01-30T22:37:12.863Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
22:37:14 [2025-01-30T22:37:14.739Z] Compressing squashfs with lz4
22:37:14 [2025-01-30T22:37:14.739Z] 2025-01-30 22:37:14,358 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
22:37:14 [2025-01-30T22:37:14.739Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
22:37:14 [2025-01-30T22:37:14.739Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
22:37:14 [2025-01-30T22:37:14.739Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4
22:37:14 [2025-01-30T22:37:14.739Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/image.squashfs
22:37:14 [2025-01-30T22:37:14.739Z] + coreos_gf_run_mount builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:14 [2025-01-30T22:37:14.739Z] + local mntarg=mount
22:37:14 [2025-01-30T22:37:14.739Z] + '[' builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw = ro ']'
22:37:14 [2025-01-30T22:37:14.739Z] + coreos_gf_run builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:14 [2025-01-30T22:37:14.739Z] + '[' -n '' ']'
22:37:14 [2025-01-30T22:37:14.739Z] + coreos_gf_launch builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:14 [2025-01-30T22:37:14.739Z] + '[' -n '' ']'
22:37:14 [2025-01-30T22:37:14.739Z] ++ guestfish --listen -a builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:14 [2025-01-30T22:37:14.739Z] + eval 'GUESTFISH_PID=11715; export GUESTFISH_PID'
22:37:14 [2025-01-30T22:37:14.739Z] ++ GUESTFISH_PID=11715
22:37:14 [2025-01-30T22:37:14.739Z] ++ export GUESTFISH_PID
22:37:14 [2025-01-30T22:37:14.739Z] + '[' -z 11715 ']'
22:37:14 [2025-01-30T22:37:14.739Z] ++ kola ncpu
22:37:14 [2025-01-30T22:37:14.739Z] + coreos_gf set-smp 6
22:37:14 [2025-01-30T22:37:14.739Z] + guestfish --remote -- set-smp 6
22:37:14 [2025-01-30T22:37:14.739Z] + coreos_gf run
22:37:14 [2025-01-30T22:37:14.739Z] + guestfish --remote -- run
22:37:16 [2025-01-30T22:37:16.613Z] + GUESTFISH_RUNNING=1
22:37:16 [2025-01-30T22:37:16.613Z] ++ coreos_gf findfs-label root
22:37:16 [2025-01-30T22:37:16.613Z] ++ guestfish --remote -- findfs-label root
22:37:16 [2025-01-30T22:37:16.613Z] + root=/dev/sda4
22:37:16 [2025-01-30T22:37:16.613Z] + coreos_gf mount /dev/sda4 /
22:37:16 [2025-01-30T22:37:16.613Z] + guestfish --remote -- mount /dev/sda4 /
22:37:17 [2025-01-30T22:37:17.168Z] + local boot
22:37:17 [2025-01-30T22:37:17.168Z] ++ coreos_gf findfs-label boot
22:37:17 [2025-01-30T22:37:17.168Z] ++ guestfish --remote -- findfs-label boot
22:37:17 [2025-01-30T22:37:17.168Z] + boot=/dev/sda3
22:37:17 [2025-01-30T22:37:17.168Z] + coreos_gf mount /dev/sda3 /boot
22:37:17 [2025-01-30T22:37:17.168Z] + guestfish --remote -- mount /dev/sda3 /boot
22:37:17 [2025-01-30T22:37:17.168Z] + local partitions
22:37:17 [2025-01-30T22:37:17.168Z] + local label
22:37:17 [2025-01-30T22:37:17.168Z] ++ coreos_gf list-partitions
22:37:17 [2025-01-30T22:37:17.168Z] ++ guestfish --remote -- list-partitions
22:37:17 [2025-01-30T22:37:17.168Z] + partitions='/dev/sda1
22:37:17 [2025-01-30T22:37:17.168Z] /dev/sda2
22:37:17 [2025-01-30T22:37:17.168Z] /dev/sda3
22:37:17 [2025-01-30T22:37:17.168Z] /dev/sda4'
22:37:17 [2025-01-30T22:37:17.168Z] + for pt in $partitions
22:37:17 [2025-01-30T22:37:17.168Z] ++ coreos_gf vfs-label /dev/sda1
22:37:17 [2025-01-30T22:37:17.168Z] ++ guestfish --remote -- vfs-label /dev/sda1
22:37:17 [2025-01-30T22:37:17.420Z] + label=
22:37:17 [2025-01-30T22:37:17.420Z] + '[' '' == EFI-SYSTEM ']'
22:37:17 [2025-01-30T22:37:17.420Z] + for pt in $partitions
22:37:17 [2025-01-30T22:37:17.420Z] ++ coreos_gf vfs-label /dev/sda2
22:37:17 [2025-01-30T22:37:17.420Z] ++ guestfish --remote -- vfs-label /dev/sda2
22:37:17 [2025-01-30T22:37:17.420Z] + label=EFI-SYSTEM
22:37:17 [2025-01-30T22:37:17.420Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
22:37:17 [2025-01-30T22:37:17.420Z] + coreos_gf mount /dev/sda2 /boot/efi
22:37:17 [2025-01-30T22:37:17.420Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
22:37:17 [2025-01-30T22:37:17.420Z] + for pt in $partitions
22:37:17 [2025-01-30T22:37:17.420Z] ++ coreos_gf vfs-label /dev/sda3
22:37:17 [2025-01-30T22:37:17.420Z] ++ guestfish --remote -- vfs-label /dev/sda3
22:37:17 [2025-01-30T22:37:17.420Z] + label=boot
22:37:17 [2025-01-30T22:37:17.420Z] + '[' boot == EFI-SYSTEM ']'
22:37:17 [2025-01-30T22:37:17.420Z] + for pt in $partitions
22:37:17 [2025-01-30T22:37:17.420Z] ++ coreos_gf vfs-label /dev/sda4
22:37:17 [2025-01-30T22:37:17.420Z] ++ guestfish --remote -- vfs-label /dev/sda4
22:37:17 [2025-01-30T22:37:17.420Z] + label=root
22:37:17 [2025-01-30T22:37:17.420Z] + '[' root == EFI-SYSTEM ']'
22:37:17 [2025-01-30T22:37:17.420Z] ++ coreos_gf ls /ostree/deploy
22:37:17 [2025-01-30T22:37:17.420Z] ++ guestfish --remote -- ls /ostree/deploy
22:37:17 [2025-01-30T22:37:17.420Z] + stateroot=/ostree/deploy/fedora-coreos
22:37:17 [2025-01-30T22:37:17.420Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
22:37:17 [2025-01-30T22:37:17.420Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
22:37:17 [2025-01-30T22:37:17.420Z] ++ grep -v .origin
22:37:17 [2025-01-30T22:37:17.420Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0
22:37:17 [2025-01-30T22:37:17.420Z] + export stateroot deploydir
22:37:17 [2025-01-30T22:37:17.420Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/config
22:37:17 [2025-01-30T22:37:17.420Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/config
22:37:17 [2025-01-30T22:37:17.420Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/config
22:37:17 [2025-01-30T22:37:17.421Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/config.new /ostree/repo/config
22:37:17 [2025-01-30T22:37:17.421Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/config.new /ostree/repo/config
22:37:17 [2025-01-30T22:37:17.673Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
22:37:17 [2025-01-30T22:37:17.673Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
22:37:17 [2025-01-30T22:37:17.673Z] + kernel_binary=/boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64
22:37:17 [2025-01-30T22:37:17.673Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
22:37:17 [2025-01-30T22:37:17.673Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
22:37:17 [2025-01-30T22:37:17.673Z] + kernel_hmac=/boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/.vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64.hmac
22:37:17 [2025-01-30T22:37:17.673Z] ++ basename /boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/.vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64.hmac
22:37:17 [2025-01-30T22:37:17.673Z] + coreos_gf ln /boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/.vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64.hmac
22:37:17 [2025-01-30T22:37:17.673Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/.vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64.hmac
22:37:17 [2025-01-30T22:37:17.673Z] ++ basename /boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64
22:37:17 [2025-01-30T22:37:17.673Z] + coreos_gf ln /boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64 /boot/vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64
22:37:17 [2025-01-30T22:37:17.673Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-f1fa8f54e25e198f6a105c7e1b790796e72047783576d477a2fb8b1e58ea5221/vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64 /boot/vmlinuz-6.14.0-0.rc0.20250130git72deda0abee6.11.fc42.x86_64
22:37:17 [2025-01-30T22:37:17.673Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/image.squashfs compress:lz4
22:37:17 [2025-01-30T22:37:17.673Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/image.squashfs compress:lz4
22:37:25 [2025-01-30T22:37:25.739Z] + coreos_gf_shutdown
22:37:25 [2025-01-30T22:37:25.739Z] + coreos_gf umount-all
22:37:25 [2025-01-30T22:37:25.739Z] + guestfish --remote -- umount-all
22:37:25 [2025-01-30T22:37:25.739Z] + coreos_gf exit
22:37:25 [2025-01-30T22:37:25.739Z] + guestfish --remote -- exit
22:37:25 [2025-01-30T22:37:25.739Z] + GUESTFISH_RUNNING=
22:37:25 [2025-01-30T22:37:25.739Z] + GUESTFISH_PID=
22:37:25 [2025-01-30T22:37:25.739Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
22:37:25 [2025-01-30T22:37:25.739Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.4IhvL4 -rf
22:37:25 [2025-01-30T22:37:25.739Z] + _coreos_gf_cleanup
22:37:25 [2025-01-30T22:37:25.739Z] + guestfish --remote -- exit
22:37:25 [2025-01-30T22:37:25.739Z] + :
22:37:30 [2025-01-30T22:37:30.982Z] 2025-01-30 22:37:30,313 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw']
22:37:30 [2025-01-30T22:37:30.982Z] + coreos_gf_run_mount builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:30 [2025-01-30T22:37:30.982Z] + local mntarg=mount
22:37:30 [2025-01-30T22:37:30.982Z] + '[' builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw = ro ']'
22:37:30 [2025-01-30T22:37:30.982Z] + coreos_gf_run builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:30 [2025-01-30T22:37:30.982Z] + '[' -n '' ']'
22:37:30 [2025-01-30T22:37:30.982Z] + coreos_gf_launch builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:30 [2025-01-30T22:37:30.982Z] + '[' -n '' ']'
22:37:30 [2025-01-30T22:37:30.982Z] ++ guestfish --listen -a builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
22:37:30 [2025-01-30T22:37:30.982Z] + eval 'GUESTFISH_PID=11858; export GUESTFISH_PID'
22:37:30 [2025-01-30T22:37:30.982Z] ++ GUESTFISH_PID=11858
22:37:30 [2025-01-30T22:37:30.982Z] ++ export GUESTFISH_PID
22:37:30 [2025-01-30T22:37:30.982Z] + '[' -z 11858 ']'
22:37:30 [2025-01-30T22:37:30.982Z] ++ kola ncpu
22:37:30 [2025-01-30T22:37:30.982Z] + coreos_gf set-smp 6
22:37:30 [2025-01-30T22:37:30.982Z] + guestfish --remote -- set-smp 6
22:37:30 [2025-01-30T22:37:30.982Z] + coreos_gf run
22:37:30 [2025-01-30T22:37:30.982Z] + guestfish --remote -- run
22:37:32 [2025-01-30T22:37:32.346Z] + GUESTFISH_RUNNING=1
22:37:32 [2025-01-30T22:37:32.346Z] ++ coreos_gf findfs-label root
22:37:32 [2025-01-30T22:37:32.346Z] ++ guestfish --remote -- findfs-label root
22:37:32 [2025-01-30T22:37:32.346Z] + root=/dev/sda4
22:37:32 [2025-01-30T22:37:32.346Z] + coreos_gf mount /dev/sda4 /
22:37:32 [2025-01-30T22:37:32.346Z] + guestfish --remote -- mount /dev/sda4 /
22:37:32 [2025-01-30T22:37:32.900Z] + local boot
22:37:32 [2025-01-30T22:37:32.900Z] ++ coreos_gf findfs-label boot
22:37:32 [2025-01-30T22:37:32.900Z] ++ guestfish --remote -- findfs-label boot
22:37:32 [2025-01-30T22:37:32.900Z] + boot=/dev/sda3
22:37:32 [2025-01-30T22:37:32.900Z] + coreos_gf mount /dev/sda3 /boot
22:37:32 [2025-01-30T22:37:32.900Z] + guestfish --remote -- mount /dev/sda3 /boot
22:37:32 [2025-01-30T22:37:32.900Z] + local partitions
22:37:32 [2025-01-30T22:37:32.900Z] + local label
22:37:32 [2025-01-30T22:37:32.900Z] ++ coreos_gf list-partitions
22:37:32 [2025-01-30T22:37:32.900Z] ++ guestfish --remote -- list-partitions
22:37:32 [2025-01-30T22:37:32.901Z] + partitions='/dev/sda1
22:37:32 [2025-01-30T22:37:32.901Z] /dev/sda2
22:37:32 [2025-01-30T22:37:32.901Z] /dev/sda3
22:37:32 [2025-01-30T22:37:32.901Z] /dev/sda4'
22:37:32 [2025-01-30T22:37:32.901Z] + for pt in $partitions
22:37:32 [2025-01-30T22:37:32.901Z] ++ coreos_gf vfs-label /dev/sda1
22:37:32 [2025-01-30T22:37:32.901Z] ++ guestfish --remote -- vfs-label /dev/sda1
22:37:32 [2025-01-30T22:37:32.901Z] + label=
22:37:32 [2025-01-30T22:37:32.901Z] + '[' '' == EFI-SYSTEM ']'
22:37:32 [2025-01-30T22:37:32.901Z] + for pt in $partitions
22:37:32 [2025-01-30T22:37:32.901Z] ++ coreos_gf vfs-label /dev/sda2
22:37:32 [2025-01-30T22:37:32.901Z] ++ guestfish --remote -- vfs-label /dev/sda2
22:37:33 [2025-01-30T22:37:33.153Z] + label=EFI-SYSTEM
22:37:33 [2025-01-30T22:37:33.153Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
22:37:33 [2025-01-30T22:37:33.153Z] + coreos_gf mount /dev/sda2 /boot/efi
22:37:33 [2025-01-30T22:37:33.153Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
22:37:33 [2025-01-30T22:37:33.153Z] + for pt in $partitions
22:37:33 [2025-01-30T22:37:33.153Z] ++ coreos_gf vfs-label /dev/sda3
22:37:33 [2025-01-30T22:37:33.153Z] ++ guestfish --remote -- vfs-label /dev/sda3
22:37:33 [2025-01-30T22:37:33.153Z] + label=boot
22:37:33 [2025-01-30T22:37:33.153Z] + '[' boot == EFI-SYSTEM ']'
22:37:33 [2025-01-30T22:37:33.153Z] + for pt in $partitions
22:37:33 [2025-01-30T22:37:33.153Z] ++ coreos_gf vfs-label /dev/sda4
22:37:33 [2025-01-30T22:37:33.153Z] ++ guestfish --remote -- vfs-label /dev/sda4
22:37:33 [2025-01-30T22:37:33.153Z] + label=root
22:37:33 [2025-01-30T22:37:33.153Z] + '[' root == EFI-SYSTEM ']'
22:37:33 [2025-01-30T22:37:33.153Z] ++ coreos_gf ls /ostree/deploy
22:37:33 [2025-01-30T22:37:33.153Z] ++ guestfish --remote -- ls /ostree/deploy
22:37:33 [2025-01-30T22:37:33.153Z] + stateroot=/ostree/deploy/fedora-coreos
22:37:33 [2025-01-30T22:37:33.153Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
22:37:33 [2025-01-30T22:37:33.153Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
22:37:33 [2025-01-30T22:37:33.153Z] ++ grep -v .origin
22:37:33 [2025-01-30T22:37:33.153Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.0
22:37:33 [2025-01-30T22:37:33.153Z] + export stateroot deploydir
22:37:33 [2025-01-30T22:37:33.153Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
22:37:33 [2025-01-30T22:37:33.153Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
22:37:33 [2025-01-30T22:37:33.153Z] + sed -e '/^options/!d' -e 's/^options\s*//'
22:37:33 [2025-01-30T22:37:33.153Z] + coreos_gf_shutdown
22:37:33 [2025-01-30T22:37:33.153Z] + coreos_gf umount-all
22:37:33 [2025-01-30T22:37:33.153Z] + guestfish --remote -- umount-all
22:37:33 [2025-01-30T22:37:33.406Z] + coreos_gf exit
22:37:33 [2025-01-30T22:37:33.406Z] + guestfish --remote -- exit
22:37:33 [2025-01-30T22:37:33.406Z] + GUESTFISH_RUNNING=
22:37:33 [2025-01-30T22:37:33.406Z] + GUESTFISH_PID=
22:37:33 [2025-01-30T22:37:33.406Z] + _coreos_gf_cleanup
22:37:33 [2025-01-30T22:37:33.406Z] + guestfish --remote -- exit
22:37:33 [2025-01-30T22:37:33.406Z] + :
22:37:33 [2025-01-30T22:37:33.406Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20250130.dev.0
22:37:33 [2025-01-30T22:37:33.406Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
22:37:33 [2025-01-30T22:37:33.660Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
22:37:33 [2025-01-30T22:37:33.660Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
22:37:33 [2025-01-30T22:37:33.660Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
22:37:33 [2025-01-30T22:37:33.660Z] 2025-01-30 22:37:33,511 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '65f95ade71e77f9054e7aa6575712758e08b702c324a912a5778cc0fedd27636', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
22:37:34 [2025-01-30T22:37:34.215Z] 2025-01-30 22:37:34,160 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpcq95q_y8.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
22:37:36 [2025-01-30T22:37:36.086Z] 2025-01-30 22:37:36,060 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250130.dev.0', '-volset', 'fedora-coreos-42.20250130.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-42.20250130.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
22:37:36 [2025-01-30T22:37:36.087Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
22:37:36 [2025-01-30T22:37:36.087Z] genisoimage 1.1.11 (Linux)
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
22:37:36 [2025-01-30T22:37:36.087Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Initial Padblock                        Start Block 0
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Initial Padblock                        Block(s)    16
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Primary Volume Descriptor               Start Block 16
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Primary Volume Descriptor               Block(s)    1
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Eltorito Volume Descriptor              Start Block 17
22:37:36 [2025-01-30T22:37:36.087Z] Size of boot image is 4 sectors -> No emulation
22:37:36 [2025-01-30T22:37:36.087Z] Size of boot image is 13104 sectors -> No emulation
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Eltorito Volume Descriptor              Block(s)    1
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Joliet Volume Descriptor                Start Block 18
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Joliet Volume Descriptor                Block(s)    1
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   End Volume Descriptor                   Start Block 19
22:37:36 [2025-01-30T22:37:36.087Z] Done with: End Volume Descriptor                   Block(s)    1
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Version block                           Start Block 20
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Version block                           Block(s)    1
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Path table                              Start Block 21
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Path table                              Block(s)    4
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Joliet path table                       Start Block 25
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Joliet path table                       Block(s)    4
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Directory tree                          Start Block 29
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Directory tree                          Block(s)    7
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Joliet directory tree                   Start Block 36
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Joliet directory tree                   Block(s)    7
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Directory tree cleanup                  Start Block 43
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Directory tree cleanup                  Block(s)    0
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   Extension record                        Start Block 43
22:37:36 [2025-01-30T22:37:36.087Z] Done with: Extension record                        Block(s)    1
22:37:36 [2025-01-30T22:37:36.087Z] Writing:   The File(s)                             Start Block 44
22:37:36 [2025-01-30T22:37:36.087Z]   0.91% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.087Z]   1.83% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   2.74% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   3.66% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   4.57% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   5.49% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   6.40% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   7.32% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   8.23% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]   9.15% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  10.06% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  10.98% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  11.89% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  12.81% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  13.72% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  14.64% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  15.55% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  16.47% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  17.38% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  18.30% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  19.21% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  20.13% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  21.04% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  21.96% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  22.87% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  23.79% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  24.70% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  25.62% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  26.53% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  27.45% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  28.36% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  29.28% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.339Z]  30.19% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  31.11% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  32.02% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  32.94% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  33.85% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  34.77% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  35.68% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  36.60% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  37.51% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  38.43% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  39.34% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  40.26% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  41.17% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  42.09% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  43.00% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  43.92% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  44.83% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  45.75% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  46.66% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  47.57% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  48.49% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  49.40% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  50.32% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  51.23% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  52.15% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.592Z]  53.06% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  53.98% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  54.89% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  55.81% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  56.72% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  57.64% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  58.55% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  59.47% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  60.38% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  61.30% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  62.21% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  63.13% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  64.04% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  64.96% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  65.87% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  66.79% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  67.70% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  68.62% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  69.53% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  70.45% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  71.36% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  72.28% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  73.19% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:36 [2025-01-30T22:37:36.844Z]  74.10% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  75.02% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  75.93% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  76.85% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  77.76% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  78.68% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  79.59% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  80.51% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  81.42% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  82.34% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  83.25% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  84.17% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  85.08% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  86.00% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  86.91% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  87.83% done, estimate finish Thu Jan 30 22:37:36 2025
22:37:37 [2025-01-30T22:37:37.096Z]  88.74% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  89.66% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  90.57% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  91.49% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  92.40% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  93.32% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  94.23% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  95.15% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  96.06% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.096Z]  96.98% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.349Z]  97.89% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.349Z]  98.81% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.349Z]  99.72% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.349Z] Total translation table size: 2048
22:37:37 [2025-01-30T22:37:37.349Z] Total rockridge attributes bytes: 3006
22:37:37 [2025-01-30T22:37:37.349Z] Total directory bytes: 12288
22:37:37 [2025-01-30T22:37:37.349Z] Path table size(bytes): 96
22:37:37 [2025-01-30T22:37:37.349Z] Done with: The File(s)                             Block(s)    546329
22:37:37 [2025-01-30T22:37:37.349Z] Writing:   Ending Padblock                         Start Block 546373
22:37:37 [2025-01-30T22:37:37.349Z] Done with: Ending Padblock                         Block(s)    150
22:37:37 [2025-01-30T22:37:37.349Z] Max brk space used 1c000
22:37:37 [2025-01-30T22:37:37.349Z] 546523 extents written (1067 MB)
22:37:37 [2025-01-30T22:37:37.349Z] 2025-01-30 22:37:37,135 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso']
22:37:37 [2025-01-30T22:37:37.349Z] isohybrid: Warning: more than 1024 cylinders: 1068
22:37:37 [2025-01-30T22:37:37.349Z] isohybrid: Not all BIOSes will be able to boot this device
22:37:37 [2025-01-30T22:37:37.904Z] 2025-01-30 22:37:37,699 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250130.dev.0', '-volset', 'fedora-coreos-42.20250130.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-42.20250130.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
22:37:37 [2025-01-30T22:37:37.904Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
22:37:37 [2025-01-30T22:37:37.904Z] genisoimage 1.1.11 (Linux)
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
22:37:37 [2025-01-30T22:37:37.904Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Initial Padblock                        Start Block 0
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Initial Padblock                        Block(s)    16
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Primary Volume Descriptor               Start Block 16
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Primary Volume Descriptor               Block(s)    1
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Eltorito Volume Descriptor              Start Block 17
22:37:37 [2025-01-30T22:37:37.904Z] Size of boot image is 4 sectors -> No emulation
22:37:37 [2025-01-30T22:37:37.904Z] Size of boot image is 13104 sectors -> No emulation
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Eltorito Volume Descriptor              Block(s)    1
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Joliet Volume Descriptor                Start Block 18
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Joliet Volume Descriptor                Block(s)    1
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   End Volume Descriptor                   Start Block 19
22:37:37 [2025-01-30T22:37:37.904Z] Done with: End Volume Descriptor                   Block(s)    1
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Version block                           Start Block 20
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Version block                           Block(s)    1
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Path table                              Start Block 21
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Path table                              Block(s)    4
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Joliet path table                       Start Block 25
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Joliet path table                       Block(s)    4
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Directory tree                          Start Block 29
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Directory tree                          Block(s)    7
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Joliet directory tree                   Start Block 36
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Joliet directory tree                   Block(s)    7
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Directory tree cleanup                  Start Block 43
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Directory tree cleanup                  Block(s)    0
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Extension record                        Start Block 43
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Extension record                        Block(s)    1
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   The File(s)                             Start Block 44
22:37:37 [2025-01-30T22:37:37.904Z]   8.40% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  16.78% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  25.18% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  33.55% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  41.95% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  50.33% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  58.73% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  67.10% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  75.50% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  83.88% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z]  92.28% done, estimate finish Thu Jan 30 22:37:37 2025
22:37:37 [2025-01-30T22:37:37.904Z] Total translation table size: 2048
22:37:37 [2025-01-30T22:37:37.904Z] Total rockridge attributes bytes: 2842
22:37:37 [2025-01-30T22:37:37.904Z] Total directory bytes: 12288
22:37:37 [2025-01-30T22:37:37.904Z] Path table size(bytes): 96
22:37:37 [2025-01-30T22:37:37.904Z] Done with: The File(s)                             Block(s)    59417
22:37:37 [2025-01-30T22:37:37.904Z] Writing:   Ending Padblock                         Start Block 59461
22:37:37 [2025-01-30T22:37:37.904Z] Done with: Ending Padblock                         Block(s)    150
22:37:37 [2025-01-30T22:37:37.904Z] Max brk space used 1b000
22:37:37 [2025-01-30T22:37:37.904Z] 59611 extents written (116 MB)
22:37:37 [2025-01-30T22:37:37.904Z] 2025-01-30 22:37:37,802 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal']
22:37:37 [2025-01-30T22:37:37.904Z] 2025-01-30 22:37:37,843 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal', '--consume']
22:37:55 [2025-01-30T22:37:55.918Z] + RUST_BACKTRACE=full
22:37:55 [2025-01-30T22:37:55.918Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/86968340ad11e3113b1ff290ec1a36f837f8268d3f82c3a633e83b3545ead1ad.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-42.20250130.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal --consume
22:37:55 [2025-01-30T22:37:55.918Z] Packing minimal ISO
22:37:55 [2025-01-30T22:37:55.918Z] Matched 17 files of 17
22:37:55 [2025-01-30T22:37:55.918Z] Total bytes skipped: 121665435
22:37:55 [2025-01-30T22:37:55.918Z] Total bytes written: 1017957
22:37:55 [2025-01-30T22:37:55.918Z] Total bytes written (compressed): 2872
22:37:55 [2025-01-30T22:37:55.918Z] Verifying that packed image matches digest
22:37:55 [2025-01-30T22:37:55.918Z] Packing successful!
22:37:55 [2025-01-30T22:37:55.918Z] + '[' -f /var/tmp/coreos-installer-output ']'
22:37:58 [2025-01-30T22:37:58.415Z] Updated: builds/42.20250130.dev.0/x86_64/meta.json
22:37:58 [2025-01-30T22:37:58.417Z] [Pipeline] }
22:37:58 [2025-01-30T22:37:58.419Z] [Pipeline] // withEnv
22:37:58 [2025-01-30T22:37:58.436Z] [Pipeline] withEnv
22:37:58 [2025-01-30T22:37:58.436Z] [Pipeline] {
22:37:58 [2025-01-30T22:37:58.439Z] [Pipeline] sh
22:37:59 [2025-01-30T22:37:59.020Z] + set -xeuo pipefail
22:37:59 [2025-01-30T22:37:59.020Z] ++ umask
22:37:59 [2025-01-30T22:37:59.020Z] + '[' 0022 = 0000 ']'
22:37:59 [2025-01-30T22:37:59.020Z] + cosa shell -- env XZ_DEFAULTS=--memlimit=4G cosa compress --artifact=metal
22:37:59 [2025-01-30T22:37:59.020Z] Targeting build: 42.20250130.dev.0
22:37:59 [2025-01-30T22:37:59.273Z] Compressing: builds/42.20250130.dev.0/x86_64
22:37:59 [2025-01-30T22:37:59.273Z] 2025-01-30 22:37:59,054 INFO - Running command: ['xz', '-c9', '-T6', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw']
22:42:35 [2025-01-30T22:42:35.759Z] Compressed: fedora-coreos-42.20250130.dev.0-metal.x86_64.raw.xz
22:42:35 [2025-01-30T22:42:35.760Z] Skipped compressing artifacts: ostree oci-manifest live-iso live-kernel live-initramfs live-rootfs
22:42:35 [2025-01-30T22:42:35.760Z] Updated: builds/42.20250130.dev.0/x86_64/meta.json
22:42:35 [2025-01-30T22:42:35.762Z] [Pipeline] }
22:42:35 [2025-01-30T22:42:35.765Z] [Pipeline] // withEnv
22:42:35 [2025-01-30T22:42:35.781Z] [Pipeline] }
22:42:35 [2025-01-30T22:42:35.786Z] [Pipeline] // stage
22:42:35 [2025-01-30T22:42:35.791Z] [Pipeline] stage
22:42:35 [2025-01-30T22:42:35.791Z] [Pipeline] { (x86_64:kola:testiso)
22:42:35 [2025-01-30T22:42:35.838Z] [Pipeline] withEnv
22:42:35 [2025-01-30T22:42:35.838Z] [Pipeline] {
22:42:35 [2025-01-30T22:42:35.850Z] [Pipeline] sh
22:42:36 [2025-01-30T22:42:36.436Z] + set -euo pipefail
22:42:36 [2025-01-30T22:42:36.436Z] ++ umask
22:42:36 [2025-01-30T22:42:36.436Z] + '[' 0022 = 0000 ']'
22:42:36 [2025-01-30T22:42:36.436Z] + uuidgen
22:42:36 [2025-01-30T22:42:36.436Z] + cut -f1 -d-
22:42:36 [2025-01-30T22:42:36.440Z] [Pipeline] }
22:42:36 [2025-01-30T22:42:36.442Z] [Pipeline] // withEnv
22:42:36 [2025-01-30T22:42:36.455Z] [Pipeline] withEnv
22:42:36 [2025-01-30T22:42:36.456Z] [Pipeline] {
22:42:36 [2025-01-30T22:42:36.458Z] [Pipeline] sh
22:42:36 [2025-01-30T22:42:36.987Z] + set -euo pipefail
22:42:36 [2025-01-30T22:42:36.987Z] ++ umask
22:42:36 [2025-01-30T22:42:36.987Z] + '[' 0022 = 0000 ']'
22:42:36 [2025-01-30T22:42:36.987Z] + cd /home/jenkins/agent/workspace/test-override
22:42:36 [2025-01-30T22:42:36.987Z] + cosa shell -- mktemp -d /home/jenkins/agent/workspace/test-override/tmp/kola-XXXXX
22:42:36 [2025-01-30T22:42:36.990Z] [Pipeline] }
22:42:36 [2025-01-30T22:42:36.993Z] [Pipeline] // withEnv
22:42:37 [2025-01-30T22:42:37.006Z] [Pipeline] withEnv
22:42:37 [2025-01-30T22:42:37.006Z] [Pipeline] {
22:42:37 [2025-01-30T22:42:37.009Z] [Pipeline] sh
22:42:37 [2025-01-30T22:42:37.540Z] + set -xeuo pipefail
22:42:37 [2025-01-30T22:42:37.540Z] ++ umask
22:42:37 [2025-01-30T22:42:37.540Z] + '[' 0022 = 0000 ']'
22:42:37 [2025-01-30T22:42:37.540Z] + cd /home/jenkins/agent/workspace/test-override
22:42:37 [2025-01-30T22:42:37.540Z] + cosa kola testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-ZcByX/kola-testiso-x86_64
22:42:37 [2025-01-30T22:42:37.540Z] kola -p qemu testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-ZcByX/kola-testiso-x86_64
22:42:37 [2025-01-30T22:42:37.540Z] ����  Snoozing kola test pattern "ext.config.rpm-ostree.kernel-replace" until Feb 04 2025
22:42:37 [2025-01-30T22:42:37.540Z]   ���� https://github.com/coreos/fedora-coreos-tracker/issues/1870
22:42:37 [2025-01-30T22:42:37.540Z] Ignoring verification of signature on metal image
22:42:37 [2025-01-30T22:42:37.540Z] Running test: iso-as-disk.bios
22:43:04 [2025-01-30T22:43:04.008Z] PASS: iso-as-disk.bios (18.515s)
22:43:04 [2025-01-30T22:43:04.009Z] Running test: iso-as-disk.uefi
22:43:30 [2025-01-30T22:43:30.459Z] PASS: iso-as-disk.uefi (22.225s)
22:43:30 [2025-01-30T22:43:30.459Z] Running test: iso-as-disk.uefi-secure
22:43:56 [2025-01-30T22:43:56.919Z] PASS: iso-as-disk.uefi-secure (22.943s)
22:43:56 [2025-01-30T22:43:56.919Z] Running test: iso-as-disk.4k.uefi
22:44:23 [2025-01-30T22:44:23.369Z] PASS: iso-as-disk.4k.uefi (22.274s)
22:44:23 [2025-01-30T22:44:23.369Z] Running test: iso-install.bios
22:48:59 [2025-01-30T22:48:59.845Z] PASS: iso-install.bios (4m14.125s)
22:48:59 [2025-01-30T22:48:59.845Z] Running test: iso-live-login.bios
22:49:21 [2025-01-30T22:49:21.698Z] The file: journal.txt does not exist
22:49:21 [2025-01-30T22:49:21.698Z] PASS: iso-live-login.bios (29.512s)
22:49:21 [2025-01-30T22:49:21.698Z] Running test: iso-live-login.uefi
22:49:48 [2025-01-30T22:49:48.175Z] The file: journal.txt does not exist
22:49:50 [2025-01-30T22:49:50.051Z] PASS: iso-live-login.uefi (26.189s)
22:49:50 [2025-01-30T22:49:50.051Z] Running test: iso-live-login.uefi-secure
22:50:22 [2025-01-30T22:50:22.039Z] The file: journal.txt does not exist
22:50:22 [2025-01-30T22:50:22.040Z] PASS: iso-live-login.uefi-secure (26.75s)
22:50:22 [2025-01-30T22:50:22.040Z] Running test: iso-live-login.4k.uefi
22:50:54 [2025-01-30T22:50:54.024Z] The file: journal.txt does not exist
22:50:54 [2025-01-30T22:50:54.024Z] PASS: iso-live-login.4k.uefi (26.395s)
22:50:54 [2025-01-30T22:50:54.024Z] Running test: iso-offline-install.bios
22:55:15 [2025-01-30T22:55:15.508Z] PASS: iso-offline-install.bios (4m5.02s)
22:55:15 [2025-01-30T22:55:15.508Z] Running test: iso-offline-install.mpath.bios
22:59:37 [2025-01-30T22:59:37.003Z] PASS: iso-offline-install.mpath.bios (4m10.848s)
22:59:37 [2025-01-30T22:59:37.003Z] Running test: iso-offline-install-fromram.4k.uefi
23:03:58 [2025-01-30T23:03:58.456Z] PASS: iso-offline-install-fromram.4k.uefi (4m6.878s)
23:03:58 [2025-01-30T23:03:58.456Z] Running test: iso-offline-install-iscsi.ibft.uefi
23:07:49 [2025-01-30T23:07:49.896Z] PASS: iso-offline-install-iscsi.ibft.uefi (3m46.687s)
23:07:49 [2025-01-30T23:07:49.896Z] Running test: iso-offline-install-iscsi.ibft-with-mpath.bios
23:11:41 [2025-01-30T23:11:41.295Z] PASS: iso-offline-install-iscsi.ibft-with-mpath.bios (3m54.727s)
23:11:41 [2025-01-30T23:11:41.295Z] Running test: iso-offline-install-iscsi.manual.bios
23:15:47 [2025-01-30T23:15:47.709Z] PASS: iso-offline-install-iscsi.manual.bios (3m52.641s)
23:15:47 [2025-01-30T23:15:47.709Z] Running test: miniso-install.bios
23:20:24 [2025-01-30T23:20:24.116Z] PASS: miniso-install.bios (4m24.451s)
23:20:24 [2025-01-30T23:20:24.116Z] Running test: miniso-install.nm.bios
23:25:15 [2025-01-30T23:25:15.904Z] PASS: miniso-install.nm.bios (4m32.368s)
23:25:15 [2025-01-30T23:25:15.904Z] Running test: miniso-install.4k.uefi
23:29:52 [2025-01-30T23:29:52.406Z] PASS: miniso-install.4k.uefi (4m30.479s)
23:29:52 [2025-01-30T23:29:52.406Z] Running test: miniso-install.4k.nm.uefi
23:34:44 [2025-01-30T23:34:44.343Z] PASS: miniso-install.4k.nm.uefi (4m32.388s)
23:34:44 [2025-01-30T23:34:44.343Z] Running test: pxe-offline-install.bios
23:39:05 [2025-01-30T23:39:05.800Z] PASS: pxe-offline-install.bios (4m20.259s)
23:39:05 [2025-01-30T23:39:05.800Z] Running test: pxe-offline-install.4k.uefi
23:43:42 [2025-01-30T23:43:42.232Z] PASS: pxe-offline-install.4k.uefi (4m25.736s)
23:43:42 [2025-01-30T23:43:42.232Z] Running test: pxe-online-install.bios
23:48:18 [2025-01-30T23:48:18.656Z] PASS: pxe-online-install.bios (4m25.21s)
23:48:18 [2025-01-30T23:48:18.656Z] Running test: pxe-online-install.4k.uefi
23:52:55 [2025-01-30T23:52:55.113Z] PASS: pxe-online-install.4k.uefi (4m19.298s)
23:52:55 [2025-01-30T23:52:55.121Z] [Pipeline] }
23:52:55 [2025-01-30T23:52:55.124Z] [Pipeline] // withEnv
23:52:55 [2025-01-30T23:52:55.138Z] [Pipeline] withEnv
23:52:55 [2025-01-30T23:52:55.139Z] [Pipeline] {
23:52:55 [2025-01-30T23:52:55.143Z] [Pipeline] sh
23:52:55 [2025-01-30T23:52:55.729Z] + set -xeuo pipefail
23:52:55 [2025-01-30T23:52:55.729Z] ++ umask
23:52:55 [2025-01-30T23:52:55.729Z] + '[' 0022 = 0000 ']'
23:52:55 [2025-01-30T23:52:55.729Z] + cd /home/jenkins/agent/workspace/test-override
23:52:55 [2025-01-30T23:52:55.729Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-ZcByX -c --xz kola-testiso-x86_64
23:53:07 [2025-01-30T23:53:07.866Z] [Pipeline] }
23:53:07 [2025-01-30T23:53:07.869Z] [Pipeline] // withEnv
23:53:07 [2025-01-30T23:53:07.876Z] [Pipeline] archiveArtifacts
23:53:07 [2025-01-30T23:53:07.878Z] Archiving artifacts
23:53:09 [2025-01-30T23:53:09.031Z] [Pipeline] withEnv
23:53:09 [2025-01-30T23:53:09.033Z] [Pipeline] {
23:53:09 [2025-01-30T23:53:09.035Z] [Pipeline] sh
23:53:09 [2025-01-30T23:53:09.569Z] + set -xeuo pipefail
23:53:09 [2025-01-30T23:53:09.569Z] ++ umask
23:53:09 [2025-01-30T23:53:09.569Z] + '[' 0022 = 0000 ']'
23:53:09 [2025-01-30T23:53:09.569Z] + cd /home/jenkins/agent/workspace/test-override
23:53:09 [2025-01-30T23:53:09.569Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-testiso-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-ZcByX/kola-testiso-x86_64 --output -
23:53:09 [2025-01-30T23:53:09.570Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.573Z] [Pipeline] // withEnv
23:53:09 [2025-01-30T23:53:09.581Z] [Pipeline] junit
23:53:09 [2025-01-30T23:53:09.582Z] Recording test results
23:53:09 [2025-01-30T23:53:09.648Z] None of the test reports contained any result
23:53:09 [2025-01-30T23:53:09.649Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.711Z] [Pipeline] // stage
23:53:09 [2025-01-30T23:53:09.716Z] [Pipeline] stage
23:53:09 [2025-01-30T23:53:09.716Z] [Pipeline] { (x86_64:Destroy Remote)
23:53:09 [2025-01-30T23:53:09.720Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.723Z] [Pipeline] // stage
23:53:09 [2025-01-30T23:53:09.726Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.729Z] [Pipeline] // parallel
23:53:09 [2025-01-30T23:53:09.762Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.766Z] [Pipeline] // timeout
23:53:09 [2025-01-30T23:53:09.769Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.794Z] [Pipeline] // container
23:53:09 [2025-01-30T23:53:09.811Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.816Z] [Pipeline] // node
23:53:09 [2025-01-30T23:53:09.819Z] [Pipeline] }
23:53:09 [2025-01-30T23:53:09.840Z] [Pipeline] // podTemplate
23:53:09 [2025-01-30T23:53:09.856Z] [Pipeline] End of Pipeline
23:53:09 [2025-01-30T23:53:09.960Z] Finished: SUCCESS