Console Output

Skipping 285 KB.. Full Log

15:59:51 [2025-01-28T15:59:51.815Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.initrd.expected-contents (4.69s)
15:59:51 [2025-01-28T15:59:51.815Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.files.system-generators (1.67s)
15:59:51 [2025-01-28T15:59:51.815Z]     --- PASS: non-exclusive-test-bucket-0/ext.config.security.coreos-update-ca-trust (1.69s)
15:59:58 [2025-01-28T15:59:58.327Z] --- PASS: ext.config.networking.prefer-ignition-networking (41.20s)
15:59:58 [2025-01-28T15:59:58.327Z] === RUN   rootfs.uuid/RandomUUID
16:00:01 [2025-01-28T16:00:01.585Z] --- PASS: rootfs.uuid (34.92s)
16:00:01 [2025-01-28T16:00:01.585Z]     --- PASS: rootfs.uuid/RandomUUID (0.16s)
16:00:13 [2025-01-28T16:00:13.731Z] --- PASS: ext.config.ntp.chrony.dhcp-propagation (76.50s)
16:00:17 [2025-01-28T16:00:17.878Z] --- PASS: coreos.ignition.once (42.48s)
16:00:30 [2025-01-28T16:00:30.019Z] --- PASS: coreos.ignition.instantiated.enable-unit (37.10s)
16:00:39 [2025-01-28T16:00:39.938Z] --- PASS: ext.config.networking.force-persist-ip (41.35s)
16:00:39 [2025-01-28T16:00:39.938Z] === RUN   basic.nvme/PortSSH
16:00:39 [2025-01-28T16:00:39.938Z] === RUN   basic.nvme/DbusPerms
16:00:39 [2025-01-28T16:00:39.938Z] === RUN   basic.nvme/ServicesActive
16:00:39 [2025-01-28T16:00:39.938Z] === RUN   basic.nvme/ReadOnly
16:00:39 [2025-01-28T16:00:39.938Z] === RUN   basic.nvme/Useradd
16:00:40 [2025-01-28T16:00:40.190Z] === RUN   basic.nvme/MachineID
16:00:40 [2025-01-28T16:00:40.190Z] === RUN   basic.nvme/FCOSGrowpart
16:00:42 [2025-01-28T16:00:42.689Z] --- PASS: ext.config.networking.mtu-on-bond-kargs (41.21s)
16:00:43 [2025-01-28T16:00:43.608Z] --- PASS: basic.nvme (25.93s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/PortSSH (0.12s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/DbusPerms (0.36s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/ServicesActive (0.13s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/ReadOnly (0.11s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/Useradd (0.21s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/MachineID (0.11s)
16:00:43 [2025-01-28T16:00:43.608Z]     --- PASS: basic.nvme/FCOSGrowpart (0.14s)
16:01:05 [2025-01-28T16:01:05.454Z] === RUN   ostree.unlock/unlock
16:01:05 [2025-01-28T16:01:05.454Z] === RUN   ostree.unlock/install
16:01:05 [2025-01-28T16:01:05.454Z] === RUN   ostree.unlock/uninstall
16:01:05 [2025-01-28T16:01:05.454Z] === RUN   ostree.unlock/discard
16:01:20 [2025-01-28T16:01:20.261Z] --- PASS: coreos.ignition.v2.users (34.97s)
16:01:28 [2025-01-28T16:01:28.324Z] --- PASS: ostree.unlock (44.30s)
16:01:28 [2025-01-28T16:01:28.324Z]     --- PASS: ostree.unlock/unlock (0.60s)
16:01:28 [2025-01-28T16:01:28.324Z]     --- PASS: ostree.unlock/install (0.62s)
16:01:28 [2025-01-28T16:01:28.324Z]     --- PASS: ostree.unlock/uninstall (0.42s)
16:01:28 [2025-01-28T16:01:28.324Z]     --- PASS: ostree.unlock/discard (18.51s)
16:01:30 [2025-01-28T16:01:30.824Z] --- PASS: ext.config.docker.basic (52.14s)
16:01:42 [2025-01-28T16:01:42.961Z] --- PASS: ext.config.butane.grub-users (74.05s)
16:01:55 [2025-01-28T16:01:55.094Z] --- PASS: coreos.ignition.symlink (23.93s)
16:02:00 [2025-01-28T16:02:00.312Z] --- PASS: ext.config.networking.team-dhcp-via-ignition (41.33s)
16:02:02 [2025-01-28T16:02:02.811Z] --- PASS: ext.config.swap.zram-generator (35.64s)
16:02:10 [2025-01-28T16:02:10.863Z] --- PASS: ext.config.firewall.iptables-legacy (27.65s)
16:02:17 [2025-01-28T16:02:17.375Z] --- PASS: kdump.crash.ssh (124.55s)
16:02:17 [2025-01-28T16:02:17.375Z]         cluster.go:151: Running as unit: run-rfd6d4f2da4c44918bc7bca322ade496f.service; invocation ID: 1432dfb6622546ecbc6e5eed8f5c9371
16:02:23 [2025-01-28T16:02:23.890Z] --- PASS: ext.config.boot.bootupd-validate (28.27s)
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/FCOSGrowpart
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/PortSSH
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/DbusPerms
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/ServicesActive
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/ReadOnly
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/Useradd
16:02:38 [2025-01-28T16:02:38.722Z] === RUN   basic.uefi-secure/MachineID
16:02:38 [2025-01-28T16:02:38.722Z] --- PASS: ext.config.ssh.custom-host-key-permissions (38.40s)
16:02:41 [2025-01-28T16:02:41.226Z] --- PASS: coreos.ignition.groups (24.37s)
16:02:41 [2025-01-28T16:02:41.479Z] --- PASS: basic.uefi-secure (38.98s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/FCOSGrowpart (0.14s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/PortSSH (0.12s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/DbusPerms (0.35s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/ServicesActive (0.14s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/ReadOnly (0.11s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/Useradd (0.20s)
16:02:41 [2025-01-28T16:02:41.479Z]     --- PASS: basic.uefi-secure/MachineID (0.12s)
16:03:03 [2025-01-28T16:03:03.326Z] --- PASS: ext.config.networking.hostname.fallback-hostname (38.71s)
16:03:18 [2025-01-28T16:03:18.142Z] --- PASS: ext.config.ignition.systemd-unmasking (38.55s)
16:03:20 [2025-01-28T16:03:20.018Z] --- PASS: ext.config.ignition.systemd-enable-units (38.49s)
16:03:46 [2025-01-28T16:03:46.495Z] --- PASS: ext.config.networking.nameserver (29.47s)
16:03:53 [2025-01-28T16:03:53.009Z] --- PASS: ext.config.ntp.timesyncd.dhcp-propagation (71.69s)
16:03:58 [2025-01-28T16:03:58.245Z] --- PASS: coreos.misc.disk.varlibcontainers (56.49s)
16:03:58 [2025-01-28T16:03:58.245Z]         cluster.go:151: Created symlink '/etc/systemd/system/var-lib-containers.mount.wants/systemd-mkfs@dev-disk-by-id-virtio-disk1.service' ��� '/etc/systemd/system/systemd-mkfs@dev-disk-by-id-virtio-disk1.service'.
16:03:58 [2025-01-28T16:03:58.245Z]         cluster.go:151: Created symlink '/etc/systemd/system/local-fs.target.wants/var-lib-containers.mount' ��� '/etc/systemd/system/var-lib-containers.mount'.
16:04:02 [2025-01-28T16:04:02.391Z] --- PASS: coreos.selinux.boolean (42.16s)
16:04:05 [2025-01-28T16:04:05.639Z] --- PASS: ext.config.kdump.crash (114.74s)
16:04:32 [2025-01-28T16:04:32.092Z] --- PASS: ext.config.reboot (44.53s)
16:04:37 [2025-01-28T16:04:37.314Z] --- PASS: ext.config.ignition.stable-boot (38.61s)
16:04:38 [2025-01-28T16:04:38.233Z] === RUN   rpmostree.install-uninstall/install
16:04:53 [2025-01-28T16:04:53.049Z] === RUN   ostree.hotfix/unlock
16:04:58 [2025-01-28T16:04:58.269Z] --- PASS: multipath.day1 (55.39s)
16:05:00 [2025-01-28T16:05:00.774Z] === RUN   ostree.hotfix/install
16:05:01 [2025-01-28T16:05:01.704Z] === RUN   ostree.hotfix/uninstall
16:05:02 [2025-01-28T16:05:02.261Z] === RUN   ostree.hotfix/persist
16:05:05 [2025-01-28T16:05:05.510Z] --- PASS: multipath.day2 (72.78s)
16:05:12 [2025-01-28T16:05:12.021Z] --- PASS: fcos.network.listeners (34.11s)
16:05:21 [2025-01-28T16:05:21.936Z] === RUN   ostree.hotfix/rollback
16:05:24 [2025-01-28T16:05:24.437Z] === RUN   rpmostree.install-uninstall/uninstall
16:05:39 [2025-01-28T16:05:39.240Z] --- PASS: ext.config.networking.no-default-initramfs-net-propagation.bootif (39.33s)
16:05:43 [2025-01-28T16:05:43.395Z] --- PASS: ostree.hotfix (72.28s)
16:05:43 [2025-01-28T16:05:43.395Z]     --- PASS: ostree.hotfix/unlock (8.70s)
16:05:43 [2025-01-28T16:05:43.395Z]     --- PASS: ostree.hotfix/install (0.50s)
16:05:43 [2025-01-28T16:05:43.395Z]     --- PASS: ostree.hotfix/uninstall (0.41s)
16:05:43 [2025-01-28T16:05:43.395Z]     --- PASS: ostree.hotfix/persist (18.38s)
16:05:43 [2025-01-28T16:05:43.395Z]     --- PASS: ostree.hotfix/rollback (18.90s)
16:05:49 [2025-01-28T16:05:49.902Z] --- PASS: ext.config.var-mount.scsi-id (43.78s)
16:05:59 [2025-01-28T16:05:59.819Z] --- PASS: ext.config.ignition.remote (48.32s)
16:06:06 [2025-01-28T16:06:06.330Z] --- PASS: rpmostree.install-uninstall (120.30s)
16:06:06 [2025-01-28T16:06:06.330Z]     --- PASS: rpmostree.install-uninstall/install (46.30s)
16:06:06 [2025-01-28T16:06:06.330Z]     --- PASS: rpmostree.install-uninstall/uninstall (37.60s)
16:06:11 [2025-01-28T16:06:11.553Z] --- PASS: fcos.users.shells (34.24s)
16:06:21 [2025-01-28T16:06:21.462Z] === RUN   ostree.remote/add
16:06:21 [2025-01-28T16:06:21.462Z] === RUN   ostree.remote/list
16:06:21 [2025-01-28T16:06:21.462Z] === RUN   ostree.remote/show-url
16:06:21 [2025-01-28T16:06:21.462Z] === RUN   ostree.remote/refs
16:06:21 [2025-01-28T16:06:21.462Z] === RUN   ostree.remote/summary
16:06:21 [2025-01-28T16:06:21.462Z] === RUN   ostree.remote/delete
16:06:22 [2025-01-28T16:06:22.382Z] --- PASS: ext.config.networking.kargs-rd-net (39.04s)
16:06:24 [2025-01-28T16:06:24.880Z] --- PASS: ostree.remote (35.28s)
16:06:24 [2025-01-28T16:06:24.880Z]     --- PASS: ostree.remote/add (0.24s)
16:06:24 [2025-01-28T16:06:24.880Z]     --- PASS: ostree.remote/list (0.11s)
16:06:24 [2025-01-28T16:06:24.880Z]     --- PASS: ostree.remote/show-url (0.21s)
16:06:24 [2025-01-28T16:06:24.880Z]     --- PASS: ostree.remote/refs (0.15s)
16:06:24 [2025-01-28T16:06:24.880Z]     --- PASS: ostree.remote/summary (0.27s)
16:06:24 [2025-01-28T16:06:24.880Z]     --- PASS: ostree.remote/delete (0.45s)
16:06:24 [2025-01-28T16:06:24.880Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-x86_64
16:06:24 [2025-01-28T16:06:24.882Z] [Pipeline] }
16:06:24 [2025-01-28T16:06:24.886Z] [Pipeline] // withEnv
16:06:24 [2025-01-28T16:06:24.892Z] [Pipeline] withEnv
16:06:24 [2025-01-28T16:06:24.892Z] [Pipeline] {
16:06:24 [2025-01-28T16:06:24.958Z] [Pipeline] sh
16:06:25 [2025-01-28T16:06:25.557Z] + set -xeuo pipefail
16:06:25 [2025-01-28T16:06:25.558Z] ++ umask
16:06:25 [2025-01-28T16:06:25.558Z] + '[' 0022 = 0000 ']'
16:06:25 [2025-01-28T16:06:25.558Z] + cd /home/jenkins/agent/workspace/test-override
16:06:25 [2025-01-28T16:06:25.558Z] + cosa kola run --rerun --allow-rerun-success=tags=needs-internet --build=latest --output-dir=/home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-reprovision-x86_64 --on-warn-failure-exit-77 --arch=x86_64 --tag=reprovision
16:06:25 [2025-01-28T16:06:25.558Z] 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-0lgGb/kola-reprovision-x86_64
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.raid1
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.swap-before-root
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   coreos.boot-mirror.luks
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.rpm-ostree.kernel-replace
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.luks.autosave-xfs
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.autosave-xfs
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.luks
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   coreos.boot-mirror
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.filesystem-only
16:06:25 [2025-01-28T16:06:25.812Z] === RUN   ext.config.root-reprovision.luks.512e
16:08:17 [2025-01-28T16:08:17.131Z] --- PASS: ext.config.root-reprovision.raid1 (109.34s)
16:10:23 [2025-01-28T16:10:23.461Z] --- PASS: ext.config.root-reprovision.luks (124.87s)
16:12:29 [2025-01-28T16:12:29.817Z] --- PASS: ext.config.root-reprovision.luks.512e (124.49s)
16:13:51 [2025-01-28T16:13:51.159Z] --- PASS: ext.config.root-reprovision.filesystem-only (81.49s)
16:15:57 [2025-01-28T16:15:57.500Z] === RUN   coreos.boot-mirror/sanity-check
16:15:57 [2025-01-28T16:15:57.500Z] === RUN   coreos.boot-mirror/detach-primary
16:16:19 [2025-01-28T16:16:19.756Z] === RUN   coreos.boot-mirror/verify-fallback
16:16:23 [2025-01-28T16:16:23.903Z] --- PASS: coreos.boot-mirror (157.20s)
16:16:23 [2025-01-28T16:16:23.903Z]     --- PASS: coreos.boot-mirror/sanity-check (1.88s)
16:16:23 [2025-01-28T16:16:23.903Z]     --- PASS: coreos.boot-mirror/detach-primary (29.59s)
16:16:23 [2025-01-28T16:16:23.903Z]     --- PASS: coreos.boot-mirror/verify-fallback (0.83s)
16:17:31 [2025-01-28T16:17:31.479Z] --- PASS: ext.config.root-reprovision.autosave-xfs (63.70s)
16:19:37 [2025-01-28T16:19:37.819Z] --- PASS: ext.config.root-reprovision.luks.autosave-xfs (124.57s)
16:27:14 [2025-01-28T16:27:14.333Z] --- PASS: ext.config.rpm-ostree.kernel-replace (462.12s)
16:28:50 [2025-01-28T16:28:50.661Z] === RUN   coreos.boot-mirror.luks/sanity-check
16:29:17 [2025-01-28T16:29:17.116Z] === RUN   coreos.boot-mirror.luks/detach-primary
16:29:43 [2025-01-28T16:29:43.570Z] === RUN   coreos.boot-mirror.luks/verify-fallback
16:30:22 [2025-01-28T16:30:22.193Z] --- PASS: coreos.boot-mirror.luks (185.33s)
16:30:22 [2025-01-28T16:30:22.193Z]     --- PASS: coreos.boot-mirror.luks/sanity-check (1.69s)
16:30:22 [2025-01-28T16:30:22.193Z]     --- PASS: coreos.boot-mirror.luks/detach-primary (29.75s)
16:30:22 [2025-01-28T16:30:22.193Z]     --- PASS: coreos.boot-mirror.luks/verify-fallback (0.84s)
16:31:43 [2025-01-28T16:31:43.524Z] --- PASS: ext.config.root-reprovision.swap-before-root (81.44s)
16:31:43 [2025-01-28T16:31:43.524Z] PASS, output in /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-reprovision-x86_64
16:31:43 [2025-01-28T16:31:43.527Z] [Pipeline] }
16:31:43 [2025-01-28T16:31:43.530Z] [Pipeline] // withEnv
16:31:43 [2025-01-28T16:31:43.535Z] [Pipeline] }
16:31:43 [2025-01-28T16:31:43.598Z] [Pipeline] // parallel
16:31:43 [2025-01-28T16:31:43.612Z] [Pipeline] withEnv
16:31:43 [2025-01-28T16:31:43.612Z] [Pipeline] {
16:31:43 [2025-01-28T16:31:43.615Z] [Pipeline] sh
16:31:44 [2025-01-28T16:31:44.202Z] + set -xeuo pipefail
16:31:44 [2025-01-28T16:31:44.203Z] ++ umask
16:31:44 [2025-01-28T16:31:44.203Z] + '[' 0022 = 0000 ']'
16:31:44 [2025-01-28T16:31:44.203Z] + cd /home/jenkins/agent/workspace/test-override
16:31:44 [2025-01-28T16:31:44.203Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-upgrade-x86_64
16:31:44 [2025-01-28T16:31:44.204Z] [Pipeline] }
16:31:44 [2025-01-28T16:31:44.208Z] [Pipeline] // withEnv
16:31:44 [2025-01-28T16:31:44.245Z] [Pipeline] withEnv
16:31:44 [2025-01-28T16:31:44.246Z] [Pipeline] {
16:31:44 [2025-01-28T16:31:44.273Z] [Pipeline] sh
16:31:44 [2025-01-28T16:31:44.811Z] + set -xeuo pipefail
16:31:44 [2025-01-28T16:31:44.811Z] ++ umask
16:31:44 [2025-01-28T16:31:44.811Z] + '[' 0022 = 0000 ']'
16:31:44 [2025-01-28T16:31:44.811Z] + cd /home/jenkins/agent/workspace/test-override
16:31:44 [2025-01-28T16:31:44.811Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb -c --xz kola-upgrade-x86_64
16:31:45 [2025-01-28T16:31:45.067Z] [Pipeline] }
16:31:45 [2025-01-28T16:31:45.070Z] [Pipeline] // withEnv
16:31:45 [2025-01-28T16:31:45.143Z] [Pipeline] archiveArtifacts
16:31:45 [2025-01-28T16:31:45.145Z] Archiving artifacts
16:31:45 [2025-01-28T16:31:45.780Z] [Pipeline] withEnv
16:31:45 [2025-01-28T16:31:45.781Z] [Pipeline] {
16:31:45 [2025-01-28T16:31:45.785Z] [Pipeline] sh
16:31:46 [2025-01-28T16:31:46.317Z] + set -xeuo pipefail
16:31:46 [2025-01-28T16:31:46.317Z] ++ umask
16:31:46 [2025-01-28T16:31:46.317Z] + '[' 0022 = 0000 ']'
16:31:46 [2025-01-28T16:31:46.317Z] + cd /home/jenkins/agent/workspace/test-override
16:31:46 [2025-01-28T16:31:46.317Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-upgrade-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-upgrade-x86_64 --output -
16:31:46 [2025-01-28T16:31:46.319Z] [Pipeline] }
16:31:46 [2025-01-28T16:31:46.323Z] [Pipeline] // withEnv
16:31:46 [2025-01-28T16:31:46.371Z] [Pipeline] junit
16:31:46 [2025-01-28T16:31:46.372Z] Recording test results
16:31:47 [2025-01-28T16:31:47.062Z] None of the test reports contained any result
16:31:47 [2025-01-28T16:31:47.070Z] [Pipeline] withEnv
16:31:47 [2025-01-28T16:31:47.071Z] [Pipeline] {
16:31:47 [2025-01-28T16:31:47.090Z] [Pipeline] sh
16:31:47 [2025-01-28T16:31:47.620Z] + set -xeuo pipefail
16:31:47 [2025-01-28T16:31:47.620Z] ++ umask
16:31:47 [2025-01-28T16:31:47.620Z] + '[' 0022 = 0000 ']'
16:31:47 [2025-01-28T16:31:47.620Z] + cd /home/jenkins/agent/workspace/test-override
16:31:47 [2025-01-28T16:31:47.620Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-x86_64
16:31:47 [2025-01-28T16:31:47.622Z] [Pipeline] }
16:31:47 [2025-01-28T16:31:47.625Z] [Pipeline] // withEnv
16:31:47 [2025-01-28T16:31:47.631Z] [Pipeline] withEnv
16:31:47 [2025-01-28T16:31:47.631Z] [Pipeline] {
16:31:47 [2025-01-28T16:31:47.674Z] [Pipeline] sh
16:31:48 [2025-01-28T16:31:48.202Z] + set -xeuo pipefail
16:31:48 [2025-01-28T16:31:48.202Z] ++ umask
16:31:48 [2025-01-28T16:31:48.202Z] + '[' 0022 = 0000 ']'
16:31:48 [2025-01-28T16:31:48.202Z] + cd /home/jenkins/agent/workspace/test-override
16:31:48 [2025-01-28T16:31:48.202Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb -c --xz kola-x86_64
16:31:53 [2025-01-28T16:31:53.441Z] [Pipeline] }
16:31:53 [2025-01-28T16:31:53.446Z] [Pipeline] // withEnv
16:31:53 [2025-01-28T16:31:53.508Z] [Pipeline] archiveArtifacts
16:31:53 [2025-01-28T16:31:53.510Z] Archiving artifacts
16:31:56 [2025-01-28T16:31:56.326Z] [Pipeline] withEnv
16:31:56 [2025-01-28T16:31:56.327Z] [Pipeline] {
16:31:56 [2025-01-28T16:31:56.330Z] [Pipeline] sh
16:31:56 [2025-01-28T16:31:56.903Z] + set -xeuo pipefail
16:31:56 [2025-01-28T16:31:56.903Z] ++ umask
16:31:56 [2025-01-28T16:31:56.903Z] + '[' 0022 = 0000 ']'
16:31:56 [2025-01-28T16:31:56.903Z] + cd /home/jenkins/agent/workspace/test-override
16:31:56 [2025-01-28T16:31:56.903Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-x86_64 --output -
16:31:56 [2025-01-28T16:31:56.906Z] [Pipeline] }
16:31:56 [2025-01-28T16:31:56.908Z] [Pipeline] // withEnv
16:31:56 [2025-01-28T16:31:56.960Z] [Pipeline] junit
16:31:56 [2025-01-28T16:31:56.961Z] Recording test results
16:31:57 [2025-01-28T16:31:57.148Z] None of the test reports contained any result
16:31:57 [2025-01-28T16:31:57.150Z] [Pipeline] withEnv
16:31:57 [2025-01-28T16:31:57.150Z] [Pipeline] {
16:31:57 [2025-01-28T16:31:57.154Z] [Pipeline] sh
16:31:57 [2025-01-28T16:31:57.698Z] + set -xeuo pipefail
16:31:57 [2025-01-28T16:31:57.698Z] ++ umask
16:31:57 [2025-01-28T16:31:57.698Z] + '[' 0022 = 0000 ']'
16:31:57 [2025-01-28T16:31:57.698Z] + cd /home/jenkins/agent/workspace/test-override
16:31:57 [2025-01-28T16:31:57.698Z] + cosa shell -- test -d /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-reprovision-x86_64
16:31:57 [2025-01-28T16:31:57.701Z] [Pipeline] }
16:31:57 [2025-01-28T16:31:57.704Z] [Pipeline] // withEnv
16:31:57 [2025-01-28T16:31:57.709Z] [Pipeline] withEnv
16:31:57 [2025-01-28T16:31:57.709Z] [Pipeline] {
16:31:57 [2025-01-28T16:31:57.725Z] [Pipeline] sh
16:31:58 [2025-01-28T16:31:58.272Z] + set -xeuo pipefail
16:31:58 [2025-01-28T16:31:58.272Z] ++ umask
16:31:58 [2025-01-28T16:31:58.272Z] + '[' 0022 = 0000 ']'
16:31:58 [2025-01-28T16:31:58.272Z] + cd /home/jenkins/agent/workspace/test-override
16:31:58 [2025-01-28T16:31:58.272Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb -c --xz kola-reprovision-x86_64
16:32:01 [2025-01-28T16:32:01.533Z] [Pipeline] }
16:32:01 [2025-01-28T16:32:01.537Z] [Pipeline] // withEnv
16:32:01 [2025-01-28T16:32:01.572Z] [Pipeline] archiveArtifacts
16:32:01 [2025-01-28T16:32:01.574Z] Archiving artifacts
16:32:01 [2025-01-28T16:32:01.919Z] [Pipeline] withEnv
16:32:01 [2025-01-28T16:32:01.920Z] [Pipeline] {
16:32:01 [2025-01-28T16:32:01.923Z] [Pipeline] sh
16:32:02 [2025-01-28T16:32:02.451Z] + set -xeuo pipefail
16:32:02 [2025-01-28T16:32:02.451Z] ++ umask
16:32:02 [2025-01-28T16:32:02.451Z] + '[' 0022 = 0000 ']'
16:32:02 [2025-01-28T16:32:02.451Z] + cd /home/jenkins/agent/workspace/test-override
16:32:02 [2025-01-28T16:32:02.451Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-reprovision-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-0lgGb/kola-reprovision-x86_64 --output -
16:32:02 [2025-01-28T16:32:02.453Z] [Pipeline] }
16:32:02 [2025-01-28T16:32:02.472Z] [Pipeline] // withEnv
16:32:02 [2025-01-28T16:32:02.530Z] [Pipeline] junit
16:32:02 [2025-01-28T16:32:02.531Z] Recording test results
16:32:02 [2025-01-28T16:32:02.548Z] None of the test reports contained any result
16:32:02 [2025-01-28T16:32:02.549Z] [Pipeline] stage
16:32:02 [2025-01-28T16:32:02.550Z] [Pipeline] { (x86_64:Build Metal)
16:32:02 [2025-01-28T16:32:02.553Z] [Pipeline] withEnv
16:32:02 [2025-01-28T16:32:02.554Z] [Pipeline] {
16:32:02 [2025-01-28T16:32:02.569Z] [Pipeline] sh
16:32:03 [2025-01-28T16:32:03.096Z] + set -xeuo pipefail
16:32:03 [2025-01-28T16:32:03.096Z] ++ umask
16:32:03 [2025-01-28T16:32:03.096Z] + '[' 0022 = 0000 ']'
16:32:03 [2025-01-28T16:32:03.096Z] + cosa buildextend-metal
16:32:03 [2025-01-28T16:32:03.096Z] info: Missing CAP_SYS_ADMIN; using virt
16:32:03 [2025-01-28T16:32:03.351Z] Config commit: 514b99890c95a0ce7daa3a07e57814db88e08ec8
16:32:03 [2025-01-28T16:32:03.351Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
16:32:04 [2025-01-28T16:32:04.280Z] Will build metal
16:32:22 [2025-01-28T16:32:22.289Z] ++ arch
16:32:22 [2025-01-28T16:32:22.289Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-41.20250128.dev.0"' -D 'ostree_ref="fedora/x86_64/coreos/testing-devel"' -D 'ostree_repo="file:///home/jenkins/agent/workspace/test-override/tmp/repo"' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-41.20250128.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2651 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2138 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-Tqua.json
16:32:23 [2025-01-28T16:32:23.207Z] ostree init --mode=archive --repo=/tmp/tmpw4qy4xfz
16:32:23 [2025-01-28T16:32:23.207Z] ostree remote add tmpremote file:///home/jenkins/agent/workspace/test-override/tmp/repo --no-gpg-verify --repo=/tmp/tmpw4qy4xfz
16:32:23 [2025-01-28T16:32:23.207Z] ostree pull --commit-metadata-only --mirror tmpremote fedora/x86_64/coreos/testing-devel --repo=/tmp/tmpw4qy4xfz
16:32:23 [2025-01-28T16:32:23.207Z] + set +x
16:32:23 [2025-01-28T16:32:23.207Z] + 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-Tqua.json
16:32:23 [2025-01-28T16:32:23.207Z] 
16:32:23 [2025-01-28T16:32:23.207Z] Filesystem      Size  Used Avail Use% Mounted on
16:32:23 [2025-01-28T16:32:23.207Z] /dev/vdb1        30G  9.1G   21G  31% /home/jenkins/agent/workspace/test-override/cache
16:32:23 [2025-01-28T16:32:23.207Z] 
16:32:23 [2025-01-28T16:32:23.461Z] starting /tmp/osbuild-Tqua.jsonPipeline source org.osbuild.curl: b236ddb1c2b35b99a95c6b0c4f6335264d6e71a3de2d35a396a576729ca5389b
16:32:23 [2025-01-28T16:32:23.461Z] Build
16:32:23 [2025-01-28T16:32:23.461Z]   root: <host>
16:32:23 [2025-01-28T16:32:23.461Z] 
16:32:23 [2025-01-28T16:32:23.461Z] ���  Duration: 1738081942s
16:32:23 [2025-01-28T16:32:23.461Z] Pipeline source org.osbuild.ostree: 45502b6cfb0d7862820c221e2123fb809b4e29f8193e7629334aa5a22af91d04
16:32:23 [2025-01-28T16:32:23.461Z] Build
16:32:23 [2025-01-28T16:32:23.461Z]   root: <host>
16:32:23 [2025-01-28T16:32:23.713Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree init --mode=archive --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
16:32:23 [2025-01-28T16:32:23.713Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree config set repo.locking true --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
16:32:23 [2025-01-28T16:32:23.713Z] 
16:32:23 [2025-01-28T16:32:23.713Z] ���  Duration: 1738081942s
16:32:23 [2025-01-28T16:32:23.713Z] Pipeline raw-metal-image: b141bf52f6cf12b1e6186d42ddb719881c342bad9f4f7d46818226185069e0f9
16:32:23 [2025-01-28T16:32:23.713Z] Build
16:32:23 [2025-01-28T16:32:23.713Z]   root: <host>
16:32:23 [2025-01-28T16:32:23.713Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
16:32:23 [2025-01-28T16:32:23.713Z] org.osbuild.copy: 39d96883666f7b10b851ae7f0b8841bec1eff48859f0500faa0a358786c54a10 {
16:32:23 [2025-01-28T16:32:23.713Z]   "paths": [
16:32:23 [2025-01-28T16:32:23.713Z]     {
16:32:23 [2025-01-28T16:32:23.713Z]       "from": "input://tree/disk.img",
16:32:23 [2025-01-28T16:32:23.713Z]       "to": "tree:///disk.img"
16:32:23 [2025-01-28T16:32:23.713Z]     }
16:32:23 [2025-01-28T16:32:23.713Z]   ]
16:32:23 [2025-01-28T16:32:23.713Z] }
16:32:23 [2025-01-28T16:32:23.966Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:32:24 [2025-01-28T16:32:24.219Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
16:32:26 [2025-01-28T16:32:26.093Z] 
16:32:26 [2025-01-28T16:32:26.093Z] ���  Duration: 2s
16:32:26 [2025-01-28T16:32:26.093Z] org.osbuild.coreos.platform: b141bf52f6cf12b1e6186d42ddb719881c342bad9f4f7d46818226185069e0f9 {
16:32:26 [2025-01-28T16:32:26.093Z]   "platform": "metal"
16:32:26 [2025-01-28T16:32:26.093Z] }
16:32:26 [2025-01-28T16:32:26.345Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:32:26 [2025-01-28T16:32:26.345Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/
16:32:28 [2025-01-28T16:32:28.220Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0'
16:32:28 [2025-01-28T16:32:28.220Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/boot
16:32:28 [2025-01-28T16:32:28.220Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:32:28 [2025-01-28T16:32:28.472Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/boot unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/boot unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/var unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/sysroot unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts unmounted
16:32:28 [2025-01-28T16:32:28.472Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-st505vri/mounts/
16:32:28 [2025-01-28T16:32:28.472Z] 
16:32:28 [2025-01-28T16:32:28.472Z] ���  Duration: 2s
16:32:28 [2025-01-28T16:32:28.472Z] Pipeline metal: c2dcf7c301e3f43ea4d5351d9600bb9f5bc1b3e5747bab5a4ced9f6489240fa9
16:32:28 [2025-01-28T16:32:28.472Z] Build
16:32:28 [2025-01-28T16:32:28.472Z]   root: <host>
16:32:28 [2025-01-28T16:32:28.472Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
16:32:28 [2025-01-28T16:32:28.472Z] org.osbuild.copy: c2dcf7c301e3f43ea4d5351d9600bb9f5bc1b3e5747bab5a4ced9f6489240fa9 {
16:32:28 [2025-01-28T16:32:28.472Z]   "paths": [
16:32:28 [2025-01-28T16:32:28.472Z]     {
16:32:28 [2025-01-28T16:32:28.472Z]       "from": "input://tree/disk.img",
16:32:28 [2025-01-28T16:32:28.472Z]       "to": "tree:///fedora-coreos-41.20250128.dev.0-metal.x86_64.raw"
16:32:28 [2025-01-28T16:32:28.472Z]     }
16:32:28 [2025-01-28T16:32:28.472Z]   ]
16:32:28 [2025-01-28T16:32:28.472Z] }
16:32:28 [2025-01-28T16:32:28.724Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:32:28 [2025-01-28T16:32:28.724Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw'
16:32:28 [2025-01-28T16:32:28.977Z] 
16:32:28 [2025-01-28T16:32:28.977Z] ���  Duration: 0s
16:32:28 [2025-01-28T16:32:28.977Z] manifest /tmp/osbuild-Tqua.json finished successfully
16:32:28 [2025-01-28T16:32:28.977Z] oci-archive:	b0a09262525a08e631b2194b41f3785f97dfc448007f192406fe759d8fe6094c
16:32:28 [2025-01-28T16:32:28.977Z] deployed-tree:	431063e4dbe2ae1a46f434c0aef732e15adf9a7cd3d5ed3ae51559b4cb1bd7dc
16:32:28 [2025-01-28T16:32:28.977Z] tree:     	df4a8fb58536548d036e1d18c626d4071c7c75b2b5b3d146a910622f83b73dba
16:32:28 [2025-01-28T16:32:28.977Z] raw-image:	bf68d05f82dda462074040c245ff4cafe20823ae6dc74726afb07ec1307aeae9
16:32:28 [2025-01-28T16:32:28.977Z] raw-4k-image:	724489db1b4dbec92004f44b0c00ab4ba4d7ca6c8e22ec14353572a7846aedfc
16:32:28 [2025-01-28T16:32:28.977Z] raw-applehv-image:	c4b492334d47c4d918d4a8384b76a68a60d19352f055ad8b02adb3d108d5516f
16:32:28 [2025-01-28T16:32:28.977Z] applehv:  	130070b45037447a6d44e1c04cb875d7903d04e81b5dc8800d98ab2b1998ff98
16:32:28 [2025-01-28T16:32:28.977Z] raw-gcp-image:	f0e8f2148805997436d6f8d3007f52724fd052f06fa326843ab444852ea1a719
16:32:28 [2025-01-28T16:32:28.977Z] raw-gcp-image-tar:	77db4b2d0fcd21c45ec46d329d1caf19bedf31525e435a0f5f27097ea5c8808b
16:32:28 [2025-01-28T16:32:28.977Z] gcp:      	00cb7971fd8d11571d1d8cd4523505a2e29b95519dfb3cd49cd0771d8db52d2a
16:32:28 [2025-01-28T16:32:28.977Z] raw-hyperv-image:	57f0fd019f15a861b3ba7c9013f40a7544717d0e86703ae7c15b03885ecb660c
16:32:28 [2025-01-28T16:32:28.977Z] hyperv:   	a7f20228c45f98ff8f36dcc7d87cc7660d2c5d71e4a4fbf8b0a6354c9287b381
16:32:28 [2025-01-28T16:32:28.977Z] raw-metal-image:	b141bf52f6cf12b1e6186d42ddb719881c342bad9f4f7d46818226185069e0f9
16:32:28 [2025-01-28T16:32:28.977Z] metal:    	c2dcf7c301e3f43ea4d5351d9600bb9f5bc1b3e5747bab5a4ced9f6489240fa9
16:32:28 [2025-01-28T16:32:28.977Z] raw-metal4k-image:	a0c2aa1f87824ede780e6e38e8aa4173bd38db079b6826c3077846b26ac4bb0f
16:32:28 [2025-01-28T16:32:28.977Z] metal4k:  	b7b6acafcf3a48484b83a25493a536d54d197fcea3a759be28153c1c66880173
16:32:28 [2025-01-28T16:32:28.977Z] raw-qemu-image:	c6db0eb91306099cee61e3e51eb394a6e86dd6f4445ffe195f7106d25514b577
16:32:28 [2025-01-28T16:32:28.977Z] qemu:     	8f4aeff110788ccde6466955712636835013642ae650fddaa8da4e47ee481673
16:32:28 [2025-01-28T16:32:28.977Z] live:     	bb3e96dea4bf68988c104754e5285991657a6d141a0ed1ad7c563ed94220c16b
16:32:28 [2025-01-28T16:32:28.977Z] + set +x
16:32:35 [2025-01-28T16:32:35.486Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.xdgXL9A7Gu/metal/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw': Operation not permitted
16:32:35 [2025-01-28T16:32:35.486Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal/tmp.xdgXL9A7Gu/metal': Operation not permitted
16:32:39 [2025-01-28T16:32:39.628Z] /home/jenkins/agent/workspace/test-override/builds/41.20250128.dev.0/x86_64/meta.json wrote with version stamp 1738081959545514871
16:32:39 [2025-01-28T16:32:39.628Z] Successfully generated: fedora-coreos-41.20250128.dev.0-metal.x86_64.raw
16:32:39 [2025-01-28T16:32:39.630Z] [Pipeline] }
16:32:39 [2025-01-28T16:32:39.635Z] [Pipeline] // withEnv
16:32:39 [2025-01-28T16:32:39.705Z] [Pipeline] withEnv
16:32:39 [2025-01-28T16:32:39.706Z] [Pipeline] {
16:32:39 [2025-01-28T16:32:39.709Z] [Pipeline] sh
16:32:40 [2025-01-28T16:32:40.251Z] + set -xeuo pipefail
16:32:40 [2025-01-28T16:32:40.251Z] ++ umask
16:32:40 [2025-01-28T16:32:40.251Z] + '[' 0022 = 0000 ']'
16:32:40 [2025-01-28T16:32:40.251Z] + cosa buildextend-metal4k
16:32:40 [2025-01-28T16:32:40.251Z] info: Missing CAP_SYS_ADMIN; using virt
16:32:40 [2025-01-28T16:32:40.504Z] Config commit: 514b99890c95a0ce7daa3a07e57814db88e08ec8
16:32:40 [2025-01-28T16:32:40.504Z] Using manifest: /home/jenkins/agent/workspace/test-override/src/config/manifest.yaml
16:32:41 [2025-01-28T16:32:41.422Z] Will build metal4k
16:32:59 [2025-01-28T16:32:59.431Z] ++ arch
16:32:59 [2025-01-28T16:32:59.431Z] + osbuild-mpp -D 'arch="x86_64"' -D 'artifact_name_prefix="fedora-coreos-41.20250128.dev.0"' -D 'ostree_ref="fedora/x86_64/coreos/testing-devel"' -D 'ostree_repo="file:///home/jenkins/agent/workspace/test-override/tmp/repo"' -D 'ociarchive="/home/jenkins/agent/workspace/test-override/builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-ostree.x86_64.ociarchive"' -D 'osname="fedora-coreos"' -D 'container_imgref="ostree-image-signed:oci-archive:/fedora-coreos-41.20250128.dev.0-ostree.x86_64.ociarchive"' -D 'container_repo=""' -D 'container_tag=""' -D 'extra_kargs="mitigations=auto,nosmt"' -D metal_image_size_mb=2651 -D cloud_image_size_mb=10240 -D rootfs_size_mb=2138 /usr/lib/coreos-assembler/osbuild-manifests/coreos.osbuild.x86_64.mpp.yaml /tmp/osbuild-jnk4.json
16:33:00 [2025-01-28T16:33:00.352Z] ostree init --mode=archive --repo=/tmp/tmpk9mcaaoy
16:33:00 [2025-01-28T16:33:00.352Z] ostree remote add tmpremote file:///home/jenkins/agent/workspace/test-override/tmp/repo --no-gpg-verify --repo=/tmp/tmpk9mcaaoy
16:33:00 [2025-01-28T16:33:00.352Z] ostree pull --commit-metadata-only --mirror tmpremote fedora/x86_64/coreos/testing-devel --repo=/tmp/tmpk9mcaaoy
16:33:00 [2025-01-28T16:33:00.352Z] + set +x
16:33:00 [2025-01-28T16:33:00.352Z] 
16:33:00 [2025-01-28T16:33:00.352Z] + 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-jnk4.json
16:33:00 [2025-01-28T16:33:00.352Z] Filesystem      Size  Used Avail Use% Mounted on
16:33:00 [2025-01-28T16:33:00.352Z] /dev/vdb1        30G  9.1G   21G  31% /home/jenkins/agent/workspace/test-override/cache
16:33:00 [2025-01-28T16:33:00.352Z] 
16:33:00 [2025-01-28T16:33:00.605Z] starting /tmp/osbuild-jnk4.jsonPipeline source org.osbuild.curl: b236ddb1c2b35b99a95c6b0c4f6335264d6e71a3de2d35a396a576729ca5389b
16:33:00 [2025-01-28T16:33:00.605Z] Build
16:33:00 [2025-01-28T16:33:00.605Z]   root: <host>
16:33:00 [2025-01-28T16:33:00.859Z] 
16:33:00 [2025-01-28T16:33:00.859Z] ���  Duration: 1738081980s
16:33:00 [2025-01-28T16:33:00.859Z] Pipeline source org.osbuild.ostree: 45502b6cfb0d7862820c221e2123fb809b4e29f8193e7629334aa5a22af91d04
16:33:00 [2025-01-28T16:33:00.859Z] Build
16:33:00 [2025-01-28T16:33:00.859Z]   root: <host>
16:33:00 [2025-01-28T16:33:00.859Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree init --mode=archive --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
16:33:00 [2025-01-28T16:33:00.859Z] source/org.osbuild.ostree (org.osbuild.ostree): ostree config set repo.locking true --repo=/home/jenkins/agent/workspace/test-override/cache/osbuild/store/sources/org.osbuild.ostree/repo
16:33:00 [2025-01-28T16:33:00.859Z] 
16:33:00 [2025-01-28T16:33:00.859Z] ���  Duration: 1738081980s
16:33:01 [2025-01-28T16:33:01.111Z] Pipeline raw-4k-image: 724489db1b4dbec92004f44b0c00ab4ba4d7ca6c8e22ec14353572a7846aedfc
16:33:01 [2025-01-28T16:33:01.111Z] Build
16:33:01 [2025-01-28T16:33:01.111Z]   root: <host>
16:33:01 [2025-01-28T16:33:01.111Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
16:33:01 [2025-01-28T16:33:01.111Z] org.osbuild.truncate: bea24f5e70641a79b806a056cb0e128e84a0406a6d6508d0cf0aa6395bfe6aea {
16:33:01 [2025-01-28T16:33:01.111Z]   "filename": "disk.img",
16:33:01 [2025-01-28T16:33:01.111Z]   "size": "2779774976"
16:33:01 [2025-01-28T16:33:01.111Z] }
16:33:01 [2025-01-28T16:33:01.111Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:01 [2025-01-28T16:33:01.365Z] 
16:33:01 [2025-01-28T16:33:01.365Z] ���  Duration: 0s
16:33:01 [2025-01-28T16:33:01.365Z] org.osbuild.sfdisk: 77ee5604435ebc0f158ac7dcd88765327ceb1821c103ff7f51c7c0f7316539af {
16:33:01 [2025-01-28T16:33:01.365Z]   "uuid": "00000000-0000-4000-a000-000000000001",
16:33:01 [2025-01-28T16:33:01.365Z]   "label": "gpt",
16:33:01 [2025-01-28T16:33:01.365Z]   "partitions": [
16:33:01 [2025-01-28T16:33:01.365Z]     {
16:33:01 [2025-01-28T16:33:01.365Z]       "start": 256,
16:33:01 [2025-01-28T16:33:01.365Z]       "partnum": 1,
16:33:01 [2025-01-28T16:33:01.365Z]       "size": 256,
16:33:01 [2025-01-28T16:33:01.365Z]       "type": "21686148-6449-6E6F-744E-656564454649",
16:33:01 [2025-01-28T16:33:01.365Z]       "bootable": true,
16:33:01 [2025-01-28T16:33:01.365Z]       "name": "BIOS-BOOT"
16:33:01 [2025-01-28T16:33:01.365Z]     },
16:33:01 [2025-01-28T16:33:01.365Z]     {
16:33:01 [2025-01-28T16:33:01.365Z]       "start": 512,
16:33:01 [2025-01-28T16:33:01.365Z]       "partnum": 2,
16:33:01 [2025-01-28T16:33:01.365Z]       "size": 32512,
16:33:01 [2025-01-28T16:33:01.365Z]       "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
16:33:01 [2025-01-28T16:33:01.365Z]       "name": "EFI-SYSTEM"
16:33:01 [2025-01-28T16:33:01.365Z]     },
16:33:01 [2025-01-28T16:33:01.365Z]     {
16:33:01 [2025-01-28T16:33:01.365Z]       "start": 33024,
16:33:01 [2025-01-28T16:33:01.365Z]       "partnum": 3,
16:33:01 [2025-01-28T16:33:01.365Z]       "size": 98304,
16:33:01 [2025-01-28T16:33:01.365Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
16:33:01 [2025-01-28T16:33:01.365Z]       "name": "boot"
16:33:01 [2025-01-28T16:33:01.365Z]     },
16:33:01 [2025-01-28T16:33:01.365Z]     {
16:33:01 [2025-01-28T16:33:01.365Z]       "start": 131328,
16:33:01 [2025-01-28T16:33:01.365Z]       "partnum": 4,
16:33:01 [2025-01-28T16:33:01.365Z]       "size": 547072,
16:33:01 [2025-01-28T16:33:01.365Z]       "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
16:33:01 [2025-01-28T16:33:01.365Z]       "name": "root"
16:33:01 [2025-01-28T16:33:01.365Z]     }
16:33:01 [2025-01-28T16:33:01.365Z]   ]
16:33:01 [2025-01-28T16:33:01.365Z] }
16:33:01 [2025-01-28T16:33:01.365Z] device/device (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:01 [2025-01-28T16:33:01.617Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:01 [2025-01-28T16:33:01.617Z] label: gpt
16:33:01 [2025-01-28T16:33:01.617Z] label-id: 00000000-0000-4000-a000-000000000001
16:33:01 [2025-01-28T16:33:01.617Z] /dev/loop0p1: start="256", size="256", type="21686148-6449-6E6F-744E-656564454649", name="BIOS-BOOT", bootable
16:33:01 [2025-01-28T16:33:01.618Z] /dev/loop0p2: start="512", size="32512", type="C12A7328-F81F-11D2-BA4B-00A0C93EC93B", name="EFI-SYSTEM"
16:33:01 [2025-01-28T16:33:01.618Z] /dev/loop0p3: start="33024", size="98304", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="boot"
16:33:01 [2025-01-28T16:33:01.618Z] /dev/loop0p4: start="131328", size="547072", type="0FC63DAF-8483-4772-8E79-3D69D8477DE4", name="root"
16:33:01 [2025-01-28T16:33:01.618Z] {
16:33:01 [2025-01-28T16:33:01.618Z]    "partitiontable": {
16:33:01 [2025-01-28T16:33:01.618Z]       "label": "gpt",
16:33:01 [2025-01-28T16:33:01.618Z]       "id": "00000000-0000-4000-A000-000000000001",
16:33:01 [2025-01-28T16:33:01.618Z]       "device": "/dev/loop0",
16:33:01 [2025-01-28T16:33:01.618Z]       "unit": "sectors",
16:33:01 [2025-01-28T16:33:01.618Z]       "firstlba": 256,
16:33:01 [2025-01-28T16:33:01.618Z]       "lastlba": 678650,
16:33:01 [2025-01-28T16:33:01.618Z]       "sectorsize": 4096,
16:33:01 [2025-01-28T16:33:01.618Z]       "partitions": [
16:33:01 [2025-01-28T16:33:01.618Z]          {
16:33:01 [2025-01-28T16:33:01.618Z]             "node": "/dev/loop0p1",
16:33:01 [2025-01-28T16:33:01.618Z]             "start": 256,
16:33:01 [2025-01-28T16:33:01.618Z]             "size": 256,
16:33:01 [2025-01-28T16:33:01.618Z]             "type": "21686148-6449-6E6F-744E-656564454649",
16:33:01 [2025-01-28T16:33:01.618Z]             "uuid": "12F6A5AC-2D26-4A70-9F86-C974135660DA",
16:33:01 [2025-01-28T16:33:01.618Z]             "name": "BIOS-BOOT"
16:33:01 [2025-01-28T16:33:01.618Z]          },{
16:33:01 [2025-01-28T16:33:01.618Z]             "node": "/dev/loop0p2",
16:33:01 [2025-01-28T16:33:01.618Z]             "start": 512,
16:33:01 [2025-01-28T16:33:01.618Z]             "size": 32512,
16:33:01 [2025-01-28T16:33:01.618Z]             "type": "C12A7328-F81F-11D2-BA4B-00A0C93EC93B",
16:33:01 [2025-01-28T16:33:01.618Z]             "uuid": "5EED57AE-7B6F-4B99-A118-3079FC7C1F67",
16:33:01 [2025-01-28T16:33:01.618Z]             "name": "EFI-SYSTEM"
16:33:01 [2025-01-28T16:33:01.618Z]          },{
16:33:01 [2025-01-28T16:33:01.618Z]             "node": "/dev/loop0p3",
16:33:01 [2025-01-28T16:33:01.618Z]             "start": 33024,
16:33:01 [2025-01-28T16:33:01.618Z]             "size": 98304,
16:33:01 [2025-01-28T16:33:01.618Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
16:33:01 [2025-01-28T16:33:01.618Z]             "uuid": "827D0BF9-37D2-425B-93A0-4464DCE3151D",
16:33:01 [2025-01-28T16:33:01.618Z]             "name": "boot"
16:33:01 [2025-01-28T16:33:01.618Z]          },{
16:33:01 [2025-01-28T16:33:01.618Z]             "node": "/dev/loop0p4",
16:33:01 [2025-01-28T16:33:01.618Z]             "start": 131328,
16:33:01 [2025-01-28T16:33:01.618Z]             "size": 547072,
16:33:01 [2025-01-28T16:33:01.618Z]             "type": "0FC63DAF-8483-4772-8E79-3D69D8477DE4",
16:33:01 [2025-01-28T16:33:01.618Z]             "uuid": "68F8D679-BCF0-439B-B958-9C31407EC327",
16:33:01 [2025-01-28T16:33:01.618Z]             "name": "root"
16:33:01 [2025-01-28T16:33:01.618Z]          }
16:33:01 [2025-01-28T16:33:01.618Z]       ]
16:33:01 [2025-01-28T16:33:01.618Z]    }
16:33:01 [2025-01-28T16:33:01.618Z] }
16:33:01 [2025-01-28T16:33:01.870Z] 
16:33:01 [2025-01-28T16:33:01.870Z] ���  Duration: 0s
16:33:01 [2025-01-28T16:33:01.870Z] org.osbuild.mkfs.fat: 156887d1e8e17cfe12ceb3dd8023f46156ba839c06b71330fdf0168a4060ff3e {
16:33:01 [2025-01-28T16:33:01.870Z]   "label": "EFI-SYSTEM",
16:33:01 [2025-01-28T16:33:01.870Z]   "volid": "7B7795E7"
16:33:01 [2025-01-28T16:33:01.870Z] }
16:33:01 [2025-01-28T16:33:01.870Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
16:33:01 [2025-01-28T16:33:01.870Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:02 [2025-01-28T16:33:02.123Z] mkfs.fat 4.2 (2021-01-31)
16:33:02 [2025-01-28T16:33:02.123Z] 
16:33:02 [2025-01-28T16:33:02.123Z] ���  Duration: 0s
16:33:02 [2025-01-28T16:33:02.123Z] org.osbuild.mkfs.ext4: a4158d48b6a130f0546e6b87af4354a87883797f528d6fdd1cd7f6eff253a967 {
16:33:02 [2025-01-28T16:33:02.123Z]   "uuid": "96d15588-3596-4b3c-adca-a2ff7279ea63",
16:33:02 [2025-01-28T16:33:02.123Z]   "label": "boot",
16:33:02 [2025-01-28T16:33:02.123Z]   "metadata_csum_seed": true
16:33:02 [2025-01-28T16:33:02.123Z] }
16:33:02 [2025-01-28T16:33:02.123Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
16:33:02 [2025-01-28T16:33:02.376Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:02 [2025-01-28T16:33:02.376Z] mke2fs 1.47.1 (20-May-2024)
16:33:02 [2025-01-28T16:33:02.376Z] Discarding device blocks:     0/98304           done                            
16:33:02 [2025-01-28T16:33:02.376Z] Creating filesystem with 98304 4k blocks and 98304 inodes
16:33:02 [2025-01-28T16:33:02.376Z] Filesystem UUID: 96d15588-3596-4b3c-adca-a2ff7279ea63
16:33:02 [2025-01-28T16:33:02.376Z] Superblock backups stored on blocks: 
16:33:02 [2025-01-28T16:33:02.376Z] 	32768
16:33:02 [2025-01-28T16:33:02.376Z] 
16:33:02 [2025-01-28T16:33:02.376Z] Allocating group tables: 0/3   done                            
16:33:02 [2025-01-28T16:33:02.376Z] Writing inode tables: 0/3   done                            
16:33:02 [2025-01-28T16:33:02.376Z] Creating journal (4096 blocks): done
16:33:02 [2025-01-28T16:33:02.376Z] Writing superblocks and filesystem accounting information: 0/3   done
16:33:02 [2025-01-28T16:33:02.376Z] 
16:33:02 [2025-01-28T16:33:02.376Z] 
16:33:02 [2025-01-28T16:33:02.376Z] ���  Duration: 0s
16:33:02 [2025-01-28T16:33:02.376Z] org.osbuild.mkfs.xfs: 8455639c5775e7c29abe7a1ab4734cfa586c5298f9ca8b5a0f47587c94842bde {
16:33:02 [2025-01-28T16:33:02.376Z]   "uuid": "910678ff-f77e-4a7d-8d53-86f2ac47a823",
16:33:02 [2025-01-28T16:33:02.376Z]   "label": "root"
16:33:02 [2025-01-28T16:33:02.376Z] }
16:33:02 [2025-01-28T16:33:02.632Z] device/device (org.osbuild.loopback): loop0 acquired (locked: True)
16:33:02 [2025-01-28T16:33:02.632Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:02 [2025-01-28T16:33:02.632Z] meta-data=/dev/loop0             isize=512    agcount=4, agsize=136768 blks
16:33:02 [2025-01-28T16:33:02.632Z]          =                       sectsz=4096  attr=2, projid32bit=1
16:33:02 [2025-01-28T16:33:02.632Z]          =                       crc=1        finobt=1, sparse=1, rmapbt=1
16:33:02 [2025-01-28T16:33:02.632Z]          =                       reflink=1    bigtime=1 inobtcount=1 nrext64=1
16:33:02 [2025-01-28T16:33:02.632Z] data     =                       bsize=4096   blocks=547072, imaxpct=25
16:33:02 [2025-01-28T16:33:02.632Z]          =                       sunit=0      swidth=0 blks
16:33:02 [2025-01-28T16:33:02.632Z] naming   =version 2              bsize=4096   ascii-ci=0, ftype=1
16:33:02 [2025-01-28T16:33:02.632Z] log      =internal log           bsize=4096   blocks=16384, version=2
16:33:02 [2025-01-28T16:33:02.632Z]          =                       sectsz=4096  sunit=1 blks, lazy-count=1
16:33:02 [2025-01-28T16:33:02.632Z] realtime =none                   extsz=4096   blocks=0, rtextents=0
16:33:02 [2025-01-28T16:33:02.885Z] Discarding blocks...Done.
16:33:02 [2025-01-28T16:33:02.885Z] 
16:33:02 [2025-01-28T16:33:02.885Z] ���  Duration: 0s
16:33:02 [2025-01-28T16:33:02.885Z] org.osbuild.mkdir: d6fe2eb0c6a5cb33497fb5adadb3bc3fd1b959320b3f357c86164cc295400a70 {
16:33:02 [2025-01-28T16:33:02.885Z]   "paths": [
16:33:02 [2025-01-28T16:33:02.885Z]     {
16:33:02 [2025-01-28T16:33:02.885Z]       "path": "mount://root/boot",
16:33:02 [2025-01-28T16:33:02.885Z]       "mode": 493
16:33:02 [2025-01-28T16:33:02.885Z]     },
16:33:02 [2025-01-28T16:33:02.885Z]     {
16:33:02 [2025-01-28T16:33:02.885Z]       "path": "mount://boot/efi",
16:33:02 [2025-01-28T16:33:02.885Z]       "mode": 493
16:33:02 [2025-01-28T16:33:02.885Z]     }
16:33:02 [2025-01-28T16:33:02.885Z]   ]
16:33:02 [2025-01-28T16:33:02.885Z] }
16:33:02 [2025-01-28T16:33:02.885Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:03 [2025-01-28T16:33:03.139Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qzmttdbt/mounts/root-mount-point
16:33:03 [2025-01-28T16:33:03.139Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qzmttdbt/mounts/boot-mount-point
16:33:03 [2025-01-28T16:33:03.139Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:03 [2025-01-28T16:33:03.392Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qzmttdbt/mounts/boot-mount-point unmounted
16:33:03 [2025-01-28T16:33:03.392Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qzmttdbt/mounts/root-mount-point unmounted
16:33:03 [2025-01-28T16:33:03.392Z] 
16:33:03 [2025-01-28T16:33:03.392Z] ���  Duration: 0s
16:33:03 [2025-01-28T16:33:03.392Z] org.osbuild.selinux: 9ba99189b6d2b2d63d2583ed87f5aee3e2c4eaf518ced815da75d3b269b69d20 {
16:33:03 [2025-01-28T16:33:03.392Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
16:33:03 [2025-01-28T16:33:03.392Z]   "target": "mount://root/"
16:33:03 [2025-01-28T16:33:03.392Z] }
16:33:03 [2025-01-28T16:33:03.704Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:03 [2025-01-28T16:33:03.704Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-nu9znit5/mounts/
16:33:03 [2025-01-28T16:33:03.704Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:03 [2025-01-28T16:33:03.958Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-nu9znit5/mounts/ unmounted
16:33:03 [2025-01-28T16:33:03.958Z] 
16:33:03 [2025-01-28T16:33:03.958Z] ���  Duration: 0s
16:33:03 [2025-01-28T16:33:03.958Z] org.osbuild.selinux: 93e02905cf6cc2b639aa7765ef959f574800dd7c03ff2ca4a011310c86943d93 {
16:33:03 [2025-01-28T16:33:03.958Z]   "file_contexts": "input://tree/etc/selinux/targeted/contexts/files/file_contexts",
16:33:03 [2025-01-28T16:33:03.958Z]   "target": "mount://root/boot/"
16:33:03 [2025-01-28T16:33:03.958Z] }
16:33:04 [2025-01-28T16:33:04.211Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:04 [2025-01-28T16:33:04.211Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-g839rxlw/mounts/
16:33:04 [2025-01-28T16:33:04.464Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-g839rxlw/mounts/boot
16:33:04 [2025-01-28T16:33:04.464Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:04 [2025-01-28T16:33:04.718Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-g839rxlw/mounts/boot unmounted
16:33:04 [2025-01-28T16:33:04.718Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-g839rxlw/mounts/ unmounted
16:33:04 [2025-01-28T16:33:04.718Z] 
16:33:04 [2025-01-28T16:33:04.718Z] ���  Duration: 0s
16:33:04 [2025-01-28T16:33:04.718Z] org.osbuild.copy: a57ee0856d2b18a0b97a41d239655dc1f089fb62e70da03dc1a9ce41ced317ca {
16:33:04 [2025-01-28T16:33:04.718Z]   "paths": [
16:33:04 [2025-01-28T16:33:04.718Z]     {
16:33:04 [2025-01-28T16:33:04.718Z]       "from": "input://tree/",
16:33:04 [2025-01-28T16:33:04.718Z]       "to": "mount://root/"
16:33:04 [2025-01-28T16:33:04.718Z]     }
16:33:04 [2025-01-28T16:33:04.718Z]   ]
16:33:04 [2025-01-28T16:33:04.718Z] }
16:33:04 [2025-01-28T16:33:04.971Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:04 [2025-01-28T16:33:04.971Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qxh2cj75/mounts/
16:33:05 [2025-01-28T16:33:05.235Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qxh2cj75/mounts/boot
16:33:05 [2025-01-28T16:33:05.235Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qxh2cj75/mounts/boot/efi
16:33:05 [2025-01-28T16:33:05.488Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:05 [2025-01-28T16:33:05.488Z] copying '/run/osbuild/inputs/tree/.' -> '/run/osbuild/mounts/.'
16:33:10 [2025-01-28T16:33:10.707Z] 
16:33:10 [2025-01-28T16:33:10.707Z] Filesystem      Size  Used Avail Use% Mounted on
16:33:10 [2025-01-28T16:33:10.707Z] /dev/vdb1        30G  9.5G   21G  32% /home/jenkins/agent/workspace/test-override/cache
16:33:10 [2025-01-28T16:33:10.707Z] 
16:33:20 [2025-01-28T16:33:20.616Z] 
16:33:20 [2025-01-28T16:33:20.616Z] Filesystem      Size  Used Avail Use% Mounted on
16:33:20 [2025-01-28T16:33:20.616Z] /dev/vdb1        30G   11G   20G  35% /home/jenkins/agent/workspace/test-override/cache
16:33:20 [2025-01-28T16:33:20.616Z] 
16:33:28 [2025-01-28T16:33:28.673Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qxh2cj75/mounts/boot/efi unmounted
16:33:28 [2025-01-28T16:33:28.926Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qxh2cj75/mounts/boot unmounted
16:33:29 [2025-01-28T16:33:29.178Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-qxh2cj75/mounts/ unmounted
16:33:29 [2025-01-28T16:33:29.431Z] 
16:33:29 [2025-01-28T16:33:29.431Z] ���  Duration: 24s
16:33:29 [2025-01-28T16:33:29.431Z] org.osbuild.bootupd: b90880db807dd6e5070b9042cf83b8176adef34dde54661bb3d6b26b2818e637 {
16:33:29 [2025-01-28T16:33:29.431Z]   "static-configs": true,
16:33:29 [2025-01-28T16:33:29.431Z]   "deployment": {
16:33:29 [2025-01-28T16:33:29.431Z]     "default": true
16:33:29 [2025-01-28T16:33:29.431Z]   }
16:33:29 [2025-01-28T16:33:29.431Z] }
16:33:29 [2025-01-28T16:33:29.431Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:29 [2025-01-28T16:33:29.686Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-lr07azok/mounts/
16:33:29 [2025-01-28T16:33:29.686Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-lr07azok/mounts/boot
16:33:29 [2025-01-28T16:33:29.686Z] mount/efi (org.osbuild.fat): mounting /dev/loop0p2 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-lr07azok/mounts/boot/efi
16:33:29 [2025-01-28T16:33:29.938Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:29 [2025-01-28T16:33:29.938Z] Skip installing component BIOS without target device
16:33:30 [2025-01-28T16:33:30.191Z] Installed 40_coreos-ignition.cfg
16:33:30 [2025-01-28T16:33:30.191Z] Installed 70_coreos-user.cfg
16:33:30 [2025-01-28T16:33:30.191Z] Installed: grub.cfg
16:33:30 [2025-01-28T16:33:30.191Z] Installed: "fedora/grub.cfg"
16:33:30 [2025-01-28T16:33:30.191Z] mount/efi (org.osbuild.fat): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-lr07azok/mounts/boot/efi unmounted
16:33:30 [2025-01-28T16:33:30.191Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-lr07azok/mounts/boot unmounted
16:33:30 [2025-01-28T16:33:30.191Z] mount/root (org.osbuild.xfs): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-lr07azok/mounts/ unmounted
16:33:30 [2025-01-28T16:33:30.191Z] 
16:33:30 [2025-01-28T16:33:30.191Z] ���  Duration: 0s
16:33:30 [2025-01-28T16:33:30.191Z] org.osbuild.chattr: 724489db1b4dbec92004f44b0c00ab4ba4d7ca6c8e22ec14353572a7846aedfc {
16:33:30 [2025-01-28T16:33:30.191Z]   "items": {
16:33:30 [2025-01-28T16:33:30.191Z]     "mount://root/": {
16:33:30 [2025-01-28T16:33:30.191Z]       "immutable": true
16:33:30 [2025-01-28T16:33:30.191Z]     }
16:33:30 [2025-01-28T16:33:30.191Z]   }
16:33:30 [2025-01-28T16:33:30.191Z] }
16:33:30 [2025-01-28T16:33:30.444Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:30 [2025-01-28T16:33:30.444Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts/
16:33:30 [2025-01-28T16:33:30.444Z] 
16:33:30 [2025-01-28T16:33:30.444Z] Filesystem      Size  Used Avail Use% Mounted on
16:33:30 [2025-01-28T16:33:30.444Z] /dev/vdb1        30G   11G   20G  37% /home/jenkins/agent/workspace/test-override/cache
16:33:30 [2025-01-28T16:33:30.444Z] 
16:33:30 [2025-01-28T16:33:30.444Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0'
16:33:30 [2025-01-28T16:33:30.698Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts/boot unmounted
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts/var unmounted
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts/sysroot unmounted
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts unmounted
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts unmounted
16:33:30 [2025-01-28T16:33:30.698Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts unmounted
16:33:30 [2025-01-28T16:33:30.951Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-9zj5_tpo/mounts/
16:33:30 [2025-01-28T16:33:30.951Z] 
16:33:30 [2025-01-28T16:33:30.951Z] ���  Duration: 0s
16:33:30 [2025-01-28T16:33:30.951Z] Pipeline raw-metal4k-image: a0c2aa1f87824ede780e6e38e8aa4173bd38db079b6826c3077846b26ac4bb0f
16:33:30 [2025-01-28T16:33:30.951Z] Build
16:33:30 [2025-01-28T16:33:30.951Z]   root: <host>
16:33:30 [2025-01-28T16:33:30.951Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
16:33:30 [2025-01-28T16:33:30.951Z] org.osbuild.copy: 99faffb5428794cb7ba4d5fb8689ff2c6f835135336ae8625d1b2a6869b13691 {
16:33:30 [2025-01-28T16:33:30.951Z]   "paths": [
16:33:30 [2025-01-28T16:33:30.951Z]     {
16:33:30 [2025-01-28T16:33:30.951Z]       "from": "input://tree/disk.img",
16:33:30 [2025-01-28T16:33:30.951Z]       "to": "tree:///disk.img"
16:33:30 [2025-01-28T16:33:30.951Z]     }
16:33:30 [2025-01-28T16:33:30.951Z]   ]
16:33:30 [2025-01-28T16:33:30.951Z] }
16:33:31 [2025-01-28T16:33:31.204Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:31 [2025-01-28T16:33:31.204Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/disk.img'
16:33:31 [2025-01-28T16:33:31.204Z] 
16:33:31 [2025-01-28T16:33:31.204Z] ���  Duration: 0s
16:33:31 [2025-01-28T16:33:31.204Z] org.osbuild.coreos.platform: a0c2aa1f87824ede780e6e38e8aa4173bd38db079b6826c3077846b26ac4bb0f {
16:33:31 [2025-01-28T16:33:31.204Z]   "platform": "metal"
16:33:31 [2025-01-28T16:33:31.204Z] }
16:33:31 [2025-01-28T16:33:31.456Z] device/disk (org.osbuild.loopback): loop0 acquired (locked: False)
16:33:31 [2025-01-28T16:33:31.456Z] mount/root (org.osbuild.xfs): mounting /dev/loop0p4 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/
16:33:31 [2025-01-28T16:33:31.457Z] mount/ostree.deployment (org.osbuild.ostree.deployment): Deployment root at 'ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0'
16:33:31 [2025-01-28T16:33:31.711Z] mount/boot (org.osbuild.ext4): mounting /dev/loop0p3 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/boot
16:33:31 [2025-01-28T16:33:31.711Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:31 [2025-01-28T16:33:31.964Z] mount/boot (org.osbuild.ext4): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/boot unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): mounting /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0 -> /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/boot unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/var unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/sysroot unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/ostree.deployment (org.osbuild.ostree.deployment): umount: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts unmounted
16:33:31 [2025-01-28T16:33:31.964Z] mount/root (org.osbuild.xfs): already unmounted: /home/jenkins/agent/workspace/test-override/cache/osbuild/store/tmp/buildroot-tmp-fqtt9drw/mounts/
16:33:31 [2025-01-28T16:33:31.964Z] 
16:33:31 [2025-01-28T16:33:31.964Z] ���  Duration: 0s
16:33:31 [2025-01-28T16:33:31.964Z] Pipeline metal4k: b7b6acafcf3a48484b83a25493a536d54d197fcea3a759be28153c1c66880173
16:33:31 [2025-01-28T16:33:31.964Z] Build
16:33:31 [2025-01-28T16:33:31.964Z]   root: <host>
16:33:31 [2025-01-28T16:33:31.964Z]   runner: org.osbuild.fedora38 (org.osbuild.fedora38)
16:33:31 [2025-01-28T16:33:31.964Z] org.osbuild.copy: b7b6acafcf3a48484b83a25493a536d54d197fcea3a759be28153c1c66880173 {
16:33:31 [2025-01-28T16:33:31.964Z]   "paths": [
16:33:31 [2025-01-28T16:33:31.964Z]     {
16:33:31 [2025-01-28T16:33:31.964Z]       "from": "input://tree/disk.img",
16:33:31 [2025-01-28T16:33:31.964Z]       "to": "tree:///fedora-coreos-41.20250128.dev.0-metal4k.x86_64.raw"
16:33:31 [2025-01-28T16:33:31.964Z]     }
16:33:31 [2025-01-28T16:33:31.964Z]   ]
16:33:31 [2025-01-28T16:33:31.964Z] }
16:33:32 [2025-01-28T16:33:32.216Z] Failed to open file "/sys/fs/selinux/checkreqprot": Read-only file system
16:33:32 [2025-01-28T16:33:32.216Z] copying '/run/osbuild/inputs/tree/disk.img' -> '/run/osbuild/tree/fedora-coreos-41.20250128.dev.0-metal4k.x86_64.raw'
16:33:32 [2025-01-28T16:33:32.469Z] 
16:33:32 [2025-01-28T16:33:32.469Z] ���  Duration: 0s
16:33:32 [2025-01-28T16:33:32.469Z] manifest /tmp/osbuild-jnk4.json finished successfully
16:33:32 [2025-01-28T16:33:32.721Z] oci-archive:	b0a09262525a08e631b2194b41f3785f97dfc448007f192406fe759d8fe6094c
16:33:32 [2025-01-28T16:33:32.721Z] deployed-tree:	431063e4dbe2ae1a46f434c0aef732e15adf9a7cd3d5ed3ae51559b4cb1bd7dc
16:33:32 [2025-01-28T16:33:32.721Z] tree:     	df4a8fb58536548d036e1d18c626d4071c7c75b2b5b3d146a910622f83b73dba
16:33:32 [2025-01-28T16:33:32.721Z] raw-image:	bf68d05f82dda462074040c245ff4cafe20823ae6dc74726afb07ec1307aeae9
16:33:32 [2025-01-28T16:33:32.721Z] raw-4k-image:	724489db1b4dbec92004f44b0c00ab4ba4d7ca6c8e22ec14353572a7846aedfc
16:33:32 [2025-01-28T16:33:32.721Z] raw-applehv-image:	c4b492334d47c4d918d4a8384b76a68a60d19352f055ad8b02adb3d108d5516f
16:33:32 [2025-01-28T16:33:32.721Z] applehv:  	130070b45037447a6d44e1c04cb875d7903d04e81b5dc8800d98ab2b1998ff98
16:33:32 [2025-01-28T16:33:32.721Z] raw-gcp-image:	f0e8f2148805997436d6f8d3007f52724fd052f06fa326843ab444852ea1a719
16:33:32 [2025-01-28T16:33:32.721Z] raw-gcp-image-tar:	77db4b2d0fcd21c45ec46d329d1caf19bedf31525e435a0f5f27097ea5c8808b
16:33:32 [2025-01-28T16:33:32.721Z] gcp:      	00cb7971fd8d11571d1d8cd4523505a2e29b95519dfb3cd49cd0771d8db52d2a
16:33:32 [2025-01-28T16:33:32.721Z] raw-hyperv-image:	57f0fd019f15a861b3ba7c9013f40a7544717d0e86703ae7c15b03885ecb660c
16:33:32 [2025-01-28T16:33:32.721Z] hyperv:   	a7f20228c45f98ff8f36dcc7d87cc7660d2c5d71e4a4fbf8b0a6354c9287b381
16:33:32 [2025-01-28T16:33:32.721Z] raw-metal-image:	b141bf52f6cf12b1e6186d42ddb719881c342bad9f4f7d46818226185069e0f9
16:33:32 [2025-01-28T16:33:32.721Z] metal:    	c2dcf7c301e3f43ea4d5351d9600bb9f5bc1b3e5747bab5a4ced9f6489240fa9
16:33:32 [2025-01-28T16:33:32.721Z] raw-metal4k-image:	a0c2aa1f87824ede780e6e38e8aa4173bd38db079b6826c3077846b26ac4bb0f
16:33:32 [2025-01-28T16:33:32.721Z] metal4k:  	b7b6acafcf3a48484b83a25493a536d54d197fcea3a759be28153c1c66880173
16:33:32 [2025-01-28T16:33:32.721Z] raw-qemu-image:	c6db0eb91306099cee61e3e51eb394a6e86dd6f4445ffe195f7106d25514b577
16:33:32 [2025-01-28T16:33:32.721Z] qemu:     	8f4aeff110788ccde6466955712636835013642ae650fddaa8da4e47ee481673
16:33:32 [2025-01-28T16:33:32.721Z] live:     	bb3e96dea4bf68988c104754e5285991657a6d141a0ed1ad7c563ed94220c16b
16:33:32 [2025-01-28T16:33:32.721Z] + set +x
16:33:36 [2025-01-28T16:33:36.864Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.LhuDL81Z4Q/metal4k/fedora-coreos-41.20250128.dev.0-metal4k.x86_64.raw': Operation not permitted
16:33:36 [2025-01-28T16:33:36.864Z] mv: failed to preserve ownership for '/home/jenkins/agent/workspace/test-override/tmp/build.metal4k/tmp.LhuDL81Z4Q/metal4k': Operation not permitted
16:33:46 [2025-01-28T16:33:46.770Z] /home/jenkins/agent/workspace/test-override/builds/41.20250128.dev.0/x86_64/meta.json wrote with version stamp 1738082025137220631
16:33:46 [2025-01-28T16:33:46.770Z] Successfully generated: fedora-coreos-41.20250128.dev.0-metal4k.x86_64.raw
16:33:46 [2025-01-28T16:33:46.772Z] [Pipeline] }
16:33:46 [2025-01-28T16:33:46.776Z] [Pipeline] // withEnv
16:33:46 [2025-01-28T16:33:46.780Z] [Pipeline] }
16:33:46 [2025-01-28T16:33:46.840Z] [Pipeline] // stage
16:33:46 [2025-01-28T16:33:46.846Z] [Pipeline] stage
16:33:46 [2025-01-28T16:33:46.846Z] [Pipeline] { (x86_64:Build Live)
16:33:46 [2025-01-28T16:33:46.850Z] [Pipeline] withEnv
16:33:46 [2025-01-28T16:33:46.850Z] [Pipeline] {
16:33:46 [2025-01-28T16:33:46.891Z] [Pipeline] sh
16:33:47 [2025-01-28T16:33:47.425Z] + set -xeuo pipefail
16:33:47 [2025-01-28T16:33:47.425Z] ++ umask
16:33:47 [2025-01-28T16:33:47.425Z] + '[' 0022 = 0000 ']'
16:33:47 [2025-01-28T16:33:47.425Z] + cosa buildextend-live --fast
16:33:47 [2025-01-28T16:33:47.425Z] Targeting build: 41.20250128.dev.0
16:33:47 [2025-01-28T16:33:47.680Z] 2025-01-28 16:33:47,482 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', 'e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc', '/usr/lib/modules']
16:33:47 [2025-01-28T16:33:47.681Z] 2025-01-28 16:33:47,497 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.12.10-200.fc41.x86_64/vmlinuz', 'e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:33:47 [2025-01-28T16:33:47.681Z] 2025-01-28 16:33:47,548 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.12.10-200.fc41.x86_64/initramfs.img', 'e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:33:47 [2025-01-28T16:33:47.934Z] 2025-01-28 16:33:47,745 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', 'e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc', '/usr/share/coreos-installer/example-config.yaml']
16:33:47 [2025-01-28T16:33:47.934Z] 2025-01-28 16:33:47,764 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', 'e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc', '/tmp/tmprcg2_csc']
16:33:47 [2025-01-28T16:33:47.934Z] Generating osmet file for 512b metal image
16:33:47 [2025-01-28T16:33:47.934Z] 2025-01-28 16:33:47,781 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 41.20250128.dev.0', '--checksum', '331a1006c9ee07097d3f8feed39b3562d6dae1ca4b1b842ae9be94a11d024359', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:34:05 [2025-01-28T16:34:05.946Z] + RUST_BACKTRACE=full
16:34:05 [2025-01-28T16:34:05.946Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 41.20250128.dev.0' --checksum 331a1006c9ee07097d3f8feed39b3562d6dae1ca4b1b842ae9be94a11d024359 --output /var/tmp/coreos-installer-output --fast
16:34:07 [2025-01-28T16:34:07.821Z] Total OSTree objects scanned from /root: 17756 (17750 mapped, 6 empty)
16:34:07 [2025-01-28T16:34:07.821Z] Total OSTree objects found in /boot: 317
16:34:07 [2025-01-28T16:34:07.821Z] Duplicate extents dropped: 0
16:34:07 [2025-01-28T16:34:07.821Z] Overlapping extents clamped: 0
16:34:07 [2025-01-28T16:34:07.821Z] Total /root extents: 17753
16:34:07 [2025-01-28T16:34:07.821Z] Duplicate extents dropped: 0
16:34:07 [2025-01-28T16:34:07.821Z] Overlapping extents clamped: 0
16:34:07 [2025-01-28T16:34:07.821Z] Total /boot extents: 322
16:34:07 [2025-01-28T16:34:07.821Z] Packing image
16:34:22 [2025-01-28T16:34:22.636Z] Total bytes skipped: 1680449536
16:34:22 [2025-01-28T16:34:22.636Z] Total bytes written: 1099325440
16:34:22 [2025-01-28T16:34:22.636Z] Total bytes written (compressed): 24231492
16:34:22 [2025-01-28T16:34:22.636Z] Verifying that repacked image matches digest
16:34:34 [2025-01-28T16:34:34.788Z] Packing successful!
16:34:34 [2025-01-28T16:34:34.788Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:34:34 [2025-01-28T16:34:34.788Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:34:35 [2025-01-28T16:34:35.344Z] Generating osmet file for 4k metal image
16:34:35 [2025-01-28T16:34:35.344Z] 2025-01-28 16:34:35,291 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-41.20250128.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 41.20250128.dev.0', '--checksum', '3c4167208e3ed2e3e72c60a190cea3fcfaf7c0f60ccb7e389034be4686a48beb', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:34:53 [2025-01-28T16:34:53.418Z] + RUST_BACKTRACE=full
16:34:53 [2025-01-28T16:34:53.418Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 41.20250128.dev.0' --checksum 3c4167208e3ed2e3e72c60a190cea3fcfaf7c0f60ccb7e389034be4686a48beb --output /var/tmp/coreos-installer-output --fast
16:34:53 [2025-01-28T16:34:53.418Z] Total OSTree objects scanned from /root: 17756 (17750 mapped, 6 empty)
16:34:53 [2025-01-28T16:34:53.418Z] Total OSTree objects found in /boot: 3
16:34:53 [2025-01-28T16:34:53.418Z] Duplicate extents dropped: 0
16:34:53 [2025-01-28T16:34:53.418Z] Overlapping extents clamped: 0
16:34:53 [2025-01-28T16:34:53.418Z] Total /root extents: 17752
16:34:53 [2025-01-28T16:34:53.418Z] Duplicate extents dropped: 0
16:34:53 [2025-01-28T16:34:53.418Z] Overlapping extents clamped: 0
16:34:53 [2025-01-28T16:34:53.418Z] Total /boot extents: 4
16:34:53 [2025-01-28T16:34:53.418Z] Packing image
16:35:11 [2025-01-28T16:35:11.426Z] Total bytes skipped: 1669574656
16:35:11 [2025-01-28T16:35:11.426Z] Total bytes written: 1110200320
16:35:11 [2025-01-28T16:35:11.426Z] Total bytes written (compressed): 23673768
16:35:11 [2025-01-28T16:35:11.426Z] Verifying that repacked image matches digest
16:35:16 [2025-01-28T16:35:16.655Z] Packing successful!
16:35:16 [2025-01-28T16:35:16.655Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:35:16 [2025-01-28T16:35:16.655Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:35:18 [2025-01-28T16:35:18.543Z] Compressing squashfs with lz4
16:35:18 [2025-01-28T16:35:18.543Z] 2025-01-28 16:35:18,181 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
16:35:18 [2025-01-28T16:35:18.543Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:35:18 [2025-01-28T16:35:18.543Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
16:35:18 [2025-01-28T16:35:18.543Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA
16:35:18 [2025-01-28T16:35:18.543Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/image.squashfs
16:35:18 [2025-01-28T16:35:18.543Z] + coreos_gf_run_mount builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:18 [2025-01-28T16:35:18.543Z] + local mntarg=mount
16:35:18 [2025-01-28T16:35:18.543Z] + '[' builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw = ro ']'
16:35:18 [2025-01-28T16:35:18.543Z] + coreos_gf_run builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:18 [2025-01-28T16:35:18.543Z] + '[' -n '' ']'
16:35:18 [2025-01-28T16:35:18.543Z] + coreos_gf_launch builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:18 [2025-01-28T16:35:18.543Z] + '[' -n '' ']'
16:35:18 [2025-01-28T16:35:18.543Z] ++ guestfish --listen -a builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:18 [2025-01-28T16:35:18.543Z] + eval 'GUESTFISH_PID=12362; export GUESTFISH_PID'
16:35:18 [2025-01-28T16:35:18.543Z] ++ GUESTFISH_PID=12362
16:35:18 [2025-01-28T16:35:18.543Z] ++ export GUESTFISH_PID
16:35:18 [2025-01-28T16:35:18.543Z] + '[' -z 12362 ']'
16:35:18 [2025-01-28T16:35:18.543Z] ++ kola ncpu
16:35:18 [2025-01-28T16:35:18.543Z] + coreos_gf set-smp 6
16:35:18 [2025-01-28T16:35:18.543Z] + guestfish --remote -- set-smp 6
16:35:18 [2025-01-28T16:35:18.543Z] + coreos_gf run
16:35:18 [2025-01-28T16:35:18.543Z] + guestfish --remote -- run
16:35:20 [2025-01-28T16:35:20.419Z] + GUESTFISH_RUNNING=1
16:35:20 [2025-01-28T16:35:20.419Z] ++ coreos_gf findfs-label root
16:35:20 [2025-01-28T16:35:20.419Z] ++ guestfish --remote -- findfs-label root
16:35:20 [2025-01-28T16:35:20.419Z] + root=/dev/sda4
16:35:20 [2025-01-28T16:35:20.419Z] + coreos_gf mount /dev/sda4 /
16:35:20 [2025-01-28T16:35:20.419Z] + guestfish --remote -- mount /dev/sda4 /
16:35:20 [2025-01-28T16:35:20.973Z] + local boot
16:35:20 [2025-01-28T16:35:20.973Z] ++ coreos_gf findfs-label boot
16:35:20 [2025-01-28T16:35:20.973Z] ++ guestfish --remote -- findfs-label boot
16:35:20 [2025-01-28T16:35:20.974Z] + boot=/dev/sda3
16:35:20 [2025-01-28T16:35:20.974Z] + coreos_gf mount /dev/sda3 /boot
16:35:20 [2025-01-28T16:35:20.974Z] + guestfish --remote -- mount /dev/sda3 /boot
16:35:20 [2025-01-28T16:35:20.974Z] + local partitions
16:35:20 [2025-01-28T16:35:20.974Z] + local label
16:35:20 [2025-01-28T16:35:20.974Z] ++ coreos_gf list-partitions
16:35:20 [2025-01-28T16:35:20.974Z] ++ guestfish --remote -- list-partitions
16:35:20 [2025-01-28T16:35:20.974Z] + partitions='/dev/sda1
16:35:20 [2025-01-28T16:35:20.974Z] /dev/sda2
16:35:20 [2025-01-28T16:35:20.974Z] /dev/sda3
16:35:20 [2025-01-28T16:35:20.974Z] /dev/sda4'
16:35:20 [2025-01-28T16:35:20.974Z] + for pt in $partitions
16:35:20 [2025-01-28T16:35:20.974Z] ++ coreos_gf vfs-label /dev/sda1
16:35:20 [2025-01-28T16:35:20.974Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:35:21 [2025-01-28T16:35:21.226Z] + label=
16:35:21 [2025-01-28T16:35:21.226Z] + '[' '' == EFI-SYSTEM ']'
16:35:21 [2025-01-28T16:35:21.226Z] + for pt in $partitions
16:35:21 [2025-01-28T16:35:21.226Z] ++ coreos_gf vfs-label /dev/sda2
16:35:21 [2025-01-28T16:35:21.226Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:35:21 [2025-01-28T16:35:21.226Z] + label=EFI-SYSTEM
16:35:21 [2025-01-28T16:35:21.226Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:35:21 [2025-01-28T16:35:21.226Z] + coreos_gf mount /dev/sda2 /boot/efi
16:35:21 [2025-01-28T16:35:21.226Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:35:21 [2025-01-28T16:35:21.226Z] + for pt in $partitions
16:35:21 [2025-01-28T16:35:21.226Z] ++ coreos_gf vfs-label /dev/sda3
16:35:21 [2025-01-28T16:35:21.226Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:35:21 [2025-01-28T16:35:21.226Z] + label=boot
16:35:21 [2025-01-28T16:35:21.226Z] + '[' boot == EFI-SYSTEM ']'
16:35:21 [2025-01-28T16:35:21.226Z] + for pt in $partitions
16:35:21 [2025-01-28T16:35:21.226Z] ++ coreos_gf vfs-label /dev/sda4
16:35:21 [2025-01-28T16:35:21.226Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:35:21 [2025-01-28T16:35:21.226Z] + label=root
16:35:21 [2025-01-28T16:35:21.226Z] + '[' root == EFI-SYSTEM ']'
16:35:21 [2025-01-28T16:35:21.226Z] ++ coreos_gf ls /ostree/deploy
16:35:21 [2025-01-28T16:35:21.226Z] ++ guestfish --remote -- ls /ostree/deploy
16:35:21 [2025-01-28T16:35:21.226Z] + stateroot=/ostree/deploy/fedora-coreos
16:35:21 [2025-01-28T16:35:21.226Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:35:21 [2025-01-28T16:35:21.226Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:35:21 [2025-01-28T16:35:21.226Z] ++ grep -v .origin
16:35:21 [2025-01-28T16:35:21.226Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0
16:35:21 [2025-01-28T16:35:21.226Z] + export stateroot deploydir
16:35:21 [2025-01-28T16:35:21.226Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/config
16:35:21 [2025-01-28T16:35:21.226Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/config
16:35:21 [2025-01-28T16:35:21.480Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/config
16:35:21 [2025-01-28T16:35:21.480Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/config.new /ostree/repo/config
16:35:21 [2025-01-28T16:35:21.480Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/config.new /ostree/repo/config
16:35:21 [2025-01-28T16:35:21.480Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
16:35:21 [2025-01-28T16:35:21.480Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
16:35:21 [2025-01-28T16:35:21.480Z] + kernel_binary=/boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/vmlinuz-6.12.10-200.fc41.x86_64
16:35:21 [2025-01-28T16:35:21.480Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
16:35:21 [2025-01-28T16:35:21.480Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
16:35:21 [2025-01-28T16:35:21.480Z] + kernel_hmac=/boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/.vmlinuz-6.12.10-200.fc41.x86_64.hmac
16:35:21 [2025-01-28T16:35:21.480Z] ++ basename /boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/.vmlinuz-6.12.10-200.fc41.x86_64.hmac
16:35:21 [2025-01-28T16:35:21.480Z] + coreos_gf ln /boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/.vmlinuz-6.12.10-200.fc41.x86_64.hmac /boot/.vmlinuz-6.12.10-200.fc41.x86_64.hmac
16:35:21 [2025-01-28T16:35:21.480Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/.vmlinuz-6.12.10-200.fc41.x86_64.hmac /boot/.vmlinuz-6.12.10-200.fc41.x86_64.hmac
16:35:21 [2025-01-28T16:35:21.480Z] ++ basename /boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/vmlinuz-6.12.10-200.fc41.x86_64
16:35:21 [2025-01-28T16:35:21.480Z] + coreos_gf ln /boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/vmlinuz-6.12.10-200.fc41.x86_64 /boot/vmlinuz-6.12.10-200.fc41.x86_64
16:35:21 [2025-01-28T16:35:21.480Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-e96582140d0309d0cd7800a1844a34a7dfed2ac7ae76d823d5aab99520c8762b/vmlinuz-6.12.10-200.fc41.x86_64 /boot/vmlinuz-6.12.10-200.fc41.x86_64
16:35:21 [2025-01-28T16:35:21.480Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/image.squashfs compress:lz4
16:35:21 [2025-01-28T16:35:21.480Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/image.squashfs compress:lz4
16:35:29 [2025-01-28T16:35:29.536Z] + coreos_gf_shutdown
16:35:29 [2025-01-28T16:35:29.536Z] + coreos_gf umount-all
16:35:29 [2025-01-28T16:35:29.536Z] + guestfish --remote -- umount-all
16:35:29 [2025-01-28T16:35:29.536Z] + coreos_gf exit
16:35:29 [2025-01-28T16:35:29.536Z] + guestfish --remote -- exit
16:35:29 [2025-01-28T16:35:29.790Z] + GUESTFISH_RUNNING=
16:35:29 [2025-01-28T16:35:29.790Z] + GUESTFISH_PID=
16:35:29 [2025-01-28T16:35:29.790Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:35:29 [2025-01-28T16:35:29.790Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.PhYmuA -rf
16:35:29 [2025-01-28T16:35:29.790Z] + _coreos_gf_cleanup
16:35:29 [2025-01-28T16:35:29.790Z] + guestfish --remote -- exit
16:35:29 [2025-01-28T16:35:29.790Z] + :
16:35:35 [2025-01-28T16:35:35.011Z] 2025-01-28 16:35:34,514 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw']
16:35:35 [2025-01-28T16:35:35.011Z] + coreos_gf_run_mount builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:35 [2025-01-28T16:35:35.011Z] + local mntarg=mount
16:35:35 [2025-01-28T16:35:35.011Z] + '[' builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw = ro ']'
16:35:35 [2025-01-28T16:35:35.011Z] + coreos_gf_run builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:35 [2025-01-28T16:35:35.011Z] + '[' -n '' ']'
16:35:35 [2025-01-28T16:35:35.011Z] + coreos_gf_launch builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:35 [2025-01-28T16:35:35.011Z] + '[' -n '' ']'
16:35:35 [2025-01-28T16:35:35.011Z] ++ guestfish --listen -a builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw --ro
16:35:35 [2025-01-28T16:35:35.011Z] + eval 'GUESTFISH_PID=12500; export GUESTFISH_PID'
16:35:35 [2025-01-28T16:35:35.011Z] ++ GUESTFISH_PID=12500
16:35:35 [2025-01-28T16:35:35.011Z] ++ export GUESTFISH_PID
16:35:35 [2025-01-28T16:35:35.011Z] + '[' -z 12500 ']'
16:35:35 [2025-01-28T16:35:35.011Z] ++ kola ncpu
16:35:35 [2025-01-28T16:35:35.011Z] + coreos_gf set-smp 6
16:35:35 [2025-01-28T16:35:35.011Z] + guestfish --remote -- set-smp 6
16:35:35 [2025-01-28T16:35:35.011Z] + coreos_gf run
16:35:35 [2025-01-28T16:35:35.011Z] + guestfish --remote -- run
16:35:36 [2025-01-28T16:35:36.886Z] + GUESTFISH_RUNNING=1
16:35:36 [2025-01-28T16:35:36.886Z] ++ coreos_gf findfs-label root
16:35:36 [2025-01-28T16:35:36.886Z] ++ guestfish --remote -- findfs-label root
16:35:36 [2025-01-28T16:35:36.886Z] + root=/dev/sda4
16:35:36 [2025-01-28T16:35:36.886Z] + coreos_gf mount /dev/sda4 /
16:35:36 [2025-01-28T16:35:36.886Z] + guestfish --remote -- mount /dev/sda4 /
16:35:37 [2025-01-28T16:35:37.138Z] + local boot
16:35:37 [2025-01-28T16:35:37.138Z] ++ coreos_gf findfs-label boot
16:35:37 [2025-01-28T16:35:37.138Z] ++ guestfish --remote -- findfs-label boot
16:35:37 [2025-01-28T16:35:37.139Z] + boot=/dev/sda3
16:35:37 [2025-01-28T16:35:37.139Z] + coreos_gf mount /dev/sda3 /boot
16:35:37 [2025-01-28T16:35:37.139Z] + guestfish --remote -- mount /dev/sda3 /boot
16:35:37 [2025-01-28T16:35:37.139Z] + local partitions
16:35:37 [2025-01-28T16:35:37.139Z] + local label
16:35:37 [2025-01-28T16:35:37.139Z] ++ coreos_gf list-partitions
16:35:37 [2025-01-28T16:35:37.139Z] ++ guestfish --remote -- list-partitions
16:35:37 [2025-01-28T16:35:37.139Z] + partitions='/dev/sda1
16:35:37 [2025-01-28T16:35:37.139Z] /dev/sda2
16:35:37 [2025-01-28T16:35:37.139Z] /dev/sda3
16:35:37 [2025-01-28T16:35:37.139Z] /dev/sda4'
16:35:37 [2025-01-28T16:35:37.139Z] + for pt in $partitions
16:35:37 [2025-01-28T16:35:37.139Z] ++ coreos_gf vfs-label /dev/sda1
16:35:37 [2025-01-28T16:35:37.139Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:35:37 [2025-01-28T16:35:37.139Z] + label=
16:35:37 [2025-01-28T16:35:37.139Z] + '[' '' == EFI-SYSTEM ']'
16:35:37 [2025-01-28T16:35:37.139Z] + for pt in $partitions
16:35:37 [2025-01-28T16:35:37.139Z] ++ coreos_gf vfs-label /dev/sda2
16:35:37 [2025-01-28T16:35:37.139Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:35:37 [2025-01-28T16:35:37.393Z] + label=EFI-SYSTEM
16:35:37 [2025-01-28T16:35:37.393Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:35:37 [2025-01-28T16:35:37.393Z] + coreos_gf mount /dev/sda2 /boot/efi
16:35:37 [2025-01-28T16:35:37.393Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:35:37 [2025-01-28T16:35:37.393Z] + for pt in $partitions
16:35:37 [2025-01-28T16:35:37.393Z] ++ coreos_gf vfs-label /dev/sda3
16:35:37 [2025-01-28T16:35:37.393Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:35:37 [2025-01-28T16:35:37.393Z] + label=boot
16:35:37 [2025-01-28T16:35:37.393Z] + '[' boot == EFI-SYSTEM ']'
16:35:37 [2025-01-28T16:35:37.393Z] + for pt in $partitions
16:35:37 [2025-01-28T16:35:37.393Z] ++ coreos_gf vfs-label /dev/sda4
16:35:37 [2025-01-28T16:35:37.393Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:35:37 [2025-01-28T16:35:37.393Z] + label=root
16:35:37 [2025-01-28T16:35:37.393Z] + '[' root == EFI-SYSTEM ']'
16:35:37 [2025-01-28T16:35:37.393Z] ++ coreos_gf ls /ostree/deploy
16:35:37 [2025-01-28T16:35:37.393Z] ++ guestfish --remote -- ls /ostree/deploy
16:35:37 [2025-01-28T16:35:37.393Z] + stateroot=/ostree/deploy/fedora-coreos
16:35:37 [2025-01-28T16:35:37.393Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:35:37 [2025-01-28T16:35:37.393Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:35:37 [2025-01-28T16:35:37.393Z] ++ grep -v .origin
16:35:37 [2025-01-28T16:35:37.393Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0
16:35:37 [2025-01-28T16:35:37.393Z] + export stateroot deploydir
16:35:37 [2025-01-28T16:35:37.393Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
16:35:37 [2025-01-28T16:35:37.393Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
16:35:37 [2025-01-28T16:35:37.393Z] + sed -e '/^options/!d' -e 's/^options\s*//'
16:35:37 [2025-01-28T16:35:37.646Z] + coreos_gf_shutdown
16:35:37 [2025-01-28T16:35:37.646Z] + coreos_gf umount-all
16:35:37 [2025-01-28T16:35:37.646Z] + guestfish --remote -- umount-all
16:35:37 [2025-01-28T16:35:37.646Z] + coreos_gf exit
16:35:37 [2025-01-28T16:35:37.646Z] + guestfish --remote -- exit
16:35:37 [2025-01-28T16:35:37.646Z] + GUESTFISH_RUNNING=
16:35:37 [2025-01-28T16:35:37.646Z] + GUESTFISH_PID=
16:35:37 [2025-01-28T16:35:37.646Z] + _coreos_gf_cleanup
16:35:37 [2025-01-28T16:35:37.646Z] + guestfish --remote -- exit
16:35:37 [2025-01-28T16:35:37.646Z] + :
16:35:37 [2025-01-28T16:35:37.646Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-41.20250128.dev.0
16:35:37 [2025-01-28T16:35:37.646Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
16:35:37 [2025-01-28T16:35:37.899Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
16:35:37 [2025-01-28T16:35:37.899Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
16:35:37 [2025-01-28T16:35:37.899Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
16:35:37 [2025-01-28T16:35:37.899Z] 2025-01-28 16:35:37,760 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', 'e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
16:35:38 [2025-01-28T16:35:38.817Z] 2025-01-28 16:35:38,577 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpotim6ays.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
16:35:41 [2025-01-28T16:35:41.315Z] 2025-01-28 16:35:40,821 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-41.20250128.dev.0', '-volset', 'fedora-coreos-41.20250128.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:35:41 [2025-01-28T16:35:41.315Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:35:41 [2025-01-28T16:35:41.315Z] genisoimage 1.1.11 (Linux)
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:35:41 [2025-01-28T16:35:41.315Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Initial Padblock                        Start Block 0
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Initial Padblock                        Block(s)    16
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Primary Volume Descriptor               Start Block 16
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Primary Volume Descriptor               Block(s)    1
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:35:41 [2025-01-28T16:35:41.315Z] Size of boot image is 4 sectors -> No emulation
16:35:41 [2025-01-28T16:35:41.315Z] Size of boot image is 13192 sectors -> No emulation
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   End Volume Descriptor                   Start Block 19
16:35:41 [2025-01-28T16:35:41.315Z] Done with: End Volume Descriptor                   Block(s)    1
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Version block                           Start Block 20
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Version block                           Block(s)    1
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Path table                              Start Block 21
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Path table                              Block(s)    4
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Joliet path table                       Start Block 25
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Joliet path table                       Block(s)    4
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Directory tree                          Start Block 29
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Directory tree                          Block(s)    7
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Joliet directory tree                   Start Block 36
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Joliet directory tree                   Block(s)    7
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Directory tree cleanup                  Start Block 43
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Directory tree cleanup                  Block(s)    0
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   Extension record                        Start Block 43
16:35:41 [2025-01-28T16:35:41.315Z] Done with: Extension record                        Block(s)    1
16:35:41 [2025-01-28T16:35:41.315Z] Writing:   The File(s)                             Start Block 44
16:35:41 [2025-01-28T16:35:41.315Z]   0.92% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   1.83% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   2.75% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   3.67% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   4.58% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   5.50% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   6.41% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   7.33% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   8.24% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]   9.16% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  10.08% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  10.99% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  11.91% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  12.83% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  13.74% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  14.66% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  15.57% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  16.49% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  17.40% done, estimate finish Tue Jan 28 16:35:40 2025
16:35:41 [2025-01-28T16:35:41.315Z]  18.32% done, estimate finish Tue Jan 28 16:35:45 2025
16:35:41 [2025-01-28T16:35:41.315Z]  19.24% done, estimate finish Tue Jan 28 16:35:45 2025
16:35:41 [2025-01-28T16:35:41.315Z]  20.15% done, estimate finish Tue Jan 28 16:35:44 2025
16:35:41 [2025-01-28T16:35:41.315Z]  21.07% done, estimate finish Tue Jan 28 16:35:44 2025
16:35:41 [2025-01-28T16:35:41.315Z]  21.99% done, estimate finish Tue Jan 28 16:35:44 2025
16:35:41 [2025-01-28T16:35:41.315Z]  22.90% done, estimate finish Tue Jan 28 16:35:44 2025
16:35:41 [2025-01-28T16:35:41.315Z]  23.82% done, estimate finish Tue Jan 28 16:35:44 2025
16:35:41 [2025-01-28T16:35:41.315Z]  24.73% done, estimate finish Tue Jan 28 16:35:44 2025
16:35:41 [2025-01-28T16:35:41.315Z]  25.65% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  26.56% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  27.48% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  28.40% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  29.31% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  30.23% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  31.14% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  32.06% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  32.98% done, estimate finish Tue Jan 28 16:35:43 2025
16:35:41 [2025-01-28T16:35:41.315Z]  33.89% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  34.81% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  35.72% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  36.64% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  37.56% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  38.47% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  39.39% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  40.30% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  41.22% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  42.14% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  43.05% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  43.97% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  44.88% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.315Z]  45.80% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.568Z]  46.71% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.568Z]  47.63% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.568Z]  48.55% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.568Z]  49.46% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:41 [2025-01-28T16:35:41.568Z]  50.38% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  51.30% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  52.21% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  53.13% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  54.04% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  54.96% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  55.87% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  56.79% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  57.71% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  58.62% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  59.54% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  60.46% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  61.37% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  62.29% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  63.20% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  64.12% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  65.03% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  65.95% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  66.87% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.568Z]  67.78% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  68.70% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  69.61% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  70.53% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  71.45% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  72.36% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  73.28% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  74.19% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  75.11% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  76.03% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  76.94% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  77.86% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  78.77% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  79.69% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  80.61% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  81.52% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  82.44% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  83.35% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  84.27% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  85.18% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  86.10% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  87.02% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  87.93% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:41 [2025-01-28T16:35:41.822Z]  88.85% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  89.77% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  90.68% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  91.60% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  92.51% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  93.43% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  94.34% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  95.26% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  96.18% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  97.09% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  98.01% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  98.92% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z]  99.84% done, estimate finish Tue Jan 28 16:35:41 2025
16:35:42 [2025-01-28T16:35:42.075Z] Total translation table size: 2048
16:35:42 [2025-01-28T16:35:42.075Z] Total rockridge attributes bytes: 3006
16:35:42 [2025-01-28T16:35:42.075Z] Total directory bytes: 12288
16:35:42 [2025-01-28T16:35:42.075Z] Path table size(bytes): 96
16:35:42 [2025-01-28T16:35:42.075Z] Done with: The File(s)                             Block(s)    545686
16:35:42 [2025-01-28T16:35:42.075Z] Writing:   Ending Padblock                         Start Block 545730
16:35:42 [2025-01-28T16:35:42.075Z] Done with: Ending Padblock                         Block(s)    150
16:35:42 [2025-01-28T16:35:42.075Z] Max brk space used 1c000
16:35:42 [2025-01-28T16:35:42.075Z] 545880 extents written (1066 MB)
16:35:42 [2025-01-28T16:35:42.075Z] 2025-01-28 16:35:41,949 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso']
16:35:42 [2025-01-28T16:35:42.075Z] isohybrid: Warning: more than 1024 cylinders: 1067
16:35:42 [2025-01-28T16:35:42.075Z] isohybrid: Not all BIOSes will be able to boot this device
16:35:42 [2025-01-28T16:35:42.631Z] 2025-01-28 16:35:42,386 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-41.20250128.dev.0', '-volset', 'fedora-coreos-41.20250128.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:35:42 [2025-01-28T16:35:42.631Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:35:42 [2025-01-28T16:35:42.631Z] genisoimage 1.1.11 (Linux)
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:35:42 [2025-01-28T16:35:42.631Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Initial Padblock                        Start Block 0
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Initial Padblock                        Block(s)    16
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Primary Volume Descriptor               Start Block 16
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Primary Volume Descriptor               Block(s)    1
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:35:42 [2025-01-28T16:35:42.631Z] Size of boot image is 4 sectors -> No emulation
16:35:42 [2025-01-28T16:35:42.631Z] Size of boot image is 13192 sectors -> No emulation
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   End Volume Descriptor                   Start Block 19
16:35:42 [2025-01-28T16:35:42.631Z] Done with: End Volume Descriptor                   Block(s)    1
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Version block                           Start Block 20
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Version block                           Block(s)    1
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Path table                              Start Block 21
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Path table                              Block(s)    4
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Joliet path table                       Start Block 25
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Joliet path table                       Block(s)    4
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Directory tree                          Start Block 29
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Directory tree                          Block(s)    7
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Joliet directory tree                   Start Block 36
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Joliet directory tree                   Block(s)    7
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Directory tree cleanup                  Start Block 43
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Directory tree cleanup                  Block(s)    0
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Extension record                        Start Block 43
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Extension record                        Block(s)    1
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   The File(s)                             Start Block 44
16:35:42 [2025-01-28T16:35:42.631Z]   8.60% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  17.17% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  25.76% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  34.32% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  42.91% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  51.47% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  60.07% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  68.63% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  77.22% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  85.78% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z]  94.37% done, estimate finish Tue Jan 28 16:35:42 2025
16:35:42 [2025-01-28T16:35:42.631Z] Total translation table size: 2048
16:35:42 [2025-01-28T16:35:42.631Z] Total rockridge attributes bytes: 2842
16:35:42 [2025-01-28T16:35:42.631Z] Total directory bytes: 12288
16:35:42 [2025-01-28T16:35:42.631Z] Path table size(bytes): 96
16:35:42 [2025-01-28T16:35:42.631Z] Done with: The File(s)                             Block(s)    58099
16:35:42 [2025-01-28T16:35:42.631Z] Writing:   Ending Padblock                         Start Block 58143
16:35:42 [2025-01-28T16:35:42.631Z] Done with: Ending Padblock                         Block(s)    150
16:35:42 [2025-01-28T16:35:42.631Z] Max brk space used 1b000
16:35:42 [2025-01-28T16:35:42.631Z] 58293 extents written (113 MB)
16:35:42 [2025-01-28T16:35:42.631Z] 2025-01-28 16:35:42,497 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso.minimal']
16:35:42 [2025-01-28T16:35:42.631Z] 2025-01-28 16:35:42,539 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso.minimal', '--consume']
16:36:00 [2025-01-28T16:36:00.635Z] + RUST_BACKTRACE=full
16:36:00 [2025-01-28T16:36:00.635Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/e4f6fd1b653c352548bf32d48a7086a5267175f8d5d1080e58f11c3b9f8551fc.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack minimal-iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-41.20250128.dev.0-live.x86_64.iso.minimal --consume
16:36:00 [2025-01-28T16:36:00.635Z] Packing minimal ISO
16:36:00 [2025-01-28T16:36:00.635Z] Matched 17 files of 17
16:36:00 [2025-01-28T16:36:00.635Z] Total bytes skipped: 118964451
16:36:00 [2025-01-28T16:36:00.635Z] Total bytes written: 573213
16:36:00 [2025-01-28T16:36:00.635Z] Total bytes written (compressed): 2796
16:36:00 [2025-01-28T16:36:00.635Z] Verifying that packed image matches digest
16:36:00 [2025-01-28T16:36:00.635Z] Packing successful!
16:36:00 [2025-01-28T16:36:00.635Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:36:03 [2025-01-28T16:36:03.145Z] Updated: builds/41.20250128.dev.0/x86_64/meta.json
16:36:03 [2025-01-28T16:36:03.147Z] [Pipeline] }
16:36:03 [2025-01-28T16:36:03.152Z] [Pipeline] // withEnv
16:36:03 [2025-01-28T16:36:03.223Z] [Pipeline] withEnv
16:36:03 [2025-01-28T16:36:03.223Z] [Pipeline] {
16:36:03 [2025-01-28T16:36:03.235Z] [Pipeline] sh
16:36:03 [2025-01-28T16:36:03.771Z] + set -xeuo pipefail
16:36:03 [2025-01-28T16:36:03.771Z] ++ umask
16:36:03 [2025-01-28T16:36:03.771Z] + '[' 0022 = 0000 ']'
16:36:03 [2025-01-28T16:36:03.771Z] + cosa shell -- env XZ_DEFAULTS=--memlimit=4G cosa compress --artifact=metal
16:36:03 [2025-01-28T16:36:03.771Z] Targeting build: 41.20250128.dev.0
16:36:04 [2025-01-28T16:36:04.023Z] Compressing: builds/41.20250128.dev.0/x86_64
16:36:04 [2025-01-28T16:36:04.023Z] 2025-01-28 16:36:03,812 INFO - Running command: ['xz', '-c9', '-T6', 'builds/41.20250128.dev.0/x86_64/fedora-coreos-41.20250128.dev.0-metal.x86_64.raw']
16:40:55 [2025-01-28T16:40:55.434Z] Compressed: fedora-coreos-41.20250128.dev.0-metal.x86_64.raw.xz
16:40:55 [2025-01-28T16:40:55.434Z] Skipped compressing artifacts: ostree oci-manifest live-iso live-kernel live-initramfs live-rootfs
16:40:55 [2025-01-28T16:40:55.434Z] Updated: builds/41.20250128.dev.0/x86_64/meta.json
16:40:55 [2025-01-28T16:40:55.436Z] [Pipeline] }
16:40:55 [2025-01-28T16:40:55.440Z] [Pipeline] // withEnv
16:40:55 [2025-01-28T16:40:55.523Z] [Pipeline] }
16:40:55 [2025-01-28T16:40:55.527Z] [Pipeline] // stage
16:40:55 [2025-01-28T16:40:55.533Z] [Pipeline] stage
16:40:55 [2025-01-28T16:40:55.534Z] [Pipeline] { (x86_64:kola:testiso)
16:40:55 [2025-01-28T16:40:55.605Z] [Pipeline] withEnv
16:40:55 [2025-01-28T16:40:55.605Z] [Pipeline] {
16:40:55 [2025-01-28T16:40:55.610Z] [Pipeline] sh
16:40:56 [2025-01-28T16:40:56.142Z] + set -euo pipefail
16:40:56 [2025-01-28T16:40:56.143Z] ++ umask
16:40:56 [2025-01-28T16:40:56.143Z] + '[' 0022 = 0000 ']'
16:40:56 [2025-01-28T16:40:56.143Z] + uuidgen
16:40:56 [2025-01-28T16:40:56.143Z] + cut -f1 -d-
16:40:56 [2025-01-28T16:40:56.148Z] [Pipeline] }
16:40:56 [2025-01-28T16:40:56.150Z] [Pipeline] // withEnv
16:40:56 [2025-01-28T16:40:56.226Z] [Pipeline] withEnv
16:40:56 [2025-01-28T16:40:56.227Z] [Pipeline] {
16:40:56 [2025-01-28T16:40:56.230Z] [Pipeline] sh
16:40:56 [2025-01-28T16:40:56.771Z] + set -euo pipefail
16:40:56 [2025-01-28T16:40:56.771Z] ++ umask
16:40:56 [2025-01-28T16:40:56.771Z] + '[' 0022 = 0000 ']'
16:40:56 [2025-01-28T16:40:56.771Z] + cd /home/jenkins/agent/workspace/test-override
16:40:56 [2025-01-28T16:40:56.771Z] + cosa shell -- mktemp -d /home/jenkins/agent/workspace/test-override/tmp/kola-XXXXX
16:40:56 [2025-01-28T16:40:56.774Z] [Pipeline] }
16:40:56 [2025-01-28T16:40:56.777Z] [Pipeline] // withEnv
16:40:56 [2025-01-28T16:40:56.844Z] [Pipeline] withEnv
16:40:56 [2025-01-28T16:40:56.844Z] [Pipeline] {
16:40:56 [2025-01-28T16:40:56.891Z] [Pipeline] sh
16:40:57 [2025-01-28T16:40:57.450Z] + set -xeuo pipefail
16:40:57 [2025-01-28T16:40:57.450Z] ++ umask
16:40:57 [2025-01-28T16:40:57.450Z] + '[' 0022 = 0000 ']'
16:40:57 [2025-01-28T16:40:57.450Z] + cd /home/jenkins/agent/workspace/test-override
16:40:57 [2025-01-28T16:40:57.450Z] + cosa kola testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-Kix8s/kola-testiso-x86_64
16:40:57 [2025-01-28T16:40:57.450Z] kola -p qemu testiso --inst-insecure --output-dir /home/jenkins/agent/workspace/test-override/tmp/kola-Kix8s/kola-testiso-x86_64
16:40:57 [2025-01-28T16:40:57.450Z] Ignoring verification of signature on metal image
16:40:57 [2025-01-28T16:40:57.450Z] Running test: iso-as-disk.bios
16:41:23 [2025-01-28T16:41:23.909Z] PASS: iso-as-disk.bios (18.201s)
16:41:23 [2025-01-28T16:41:23.909Z] Running test: iso-as-disk.uefi
16:41:50 [2025-01-28T16:41:50.369Z] PASS: iso-as-disk.uefi (22.146s)
16:41:50 [2025-01-28T16:41:50.369Z] Running test: iso-as-disk.uefi-secure
16:42:16 [2025-01-28T16:42:16.822Z] PASS: iso-as-disk.uefi-secure (23.216s)
16:42:16 [2025-01-28T16:42:16.822Z] Running test: iso-as-disk.4k.uefi
16:42:43 [2025-01-28T16:42:43.296Z] PASS: iso-as-disk.4k.uefi (22.196s)
16:42:43 [2025-01-28T16:42:43.296Z] Running test: iso-install.bios
16:47:04 [2025-01-28T16:47:04.975Z] PASS: iso-install.bios (4m7.849s)
16:47:04 [2025-01-28T16:47:04.975Z] Running test: iso-live-login.bios
16:47:36 [2025-01-28T16:47:36.958Z] The file: journal.txt does not exist
16:47:36 [2025-01-28T16:47:36.958Z] PASS: iso-live-login.bios (30.305s)
16:47:36 [2025-01-28T16:47:36.958Z] Running test: iso-live-login.uefi
16:48:03 [2025-01-28T16:48:03.421Z] The file: journal.txt does not exist
16:48:04 [2025-01-28T16:48:04.341Z] PASS: iso-live-login.uefi (26.392s)
16:48:04 [2025-01-28T16:48:04.341Z] Running test: iso-live-login.uefi-secure
16:48:36 [2025-01-28T16:48:36.319Z] The file: journal.txt does not exist
16:48:36 [2025-01-28T16:48:36.319Z] PASS: iso-live-login.uefi-secure (27.625s)
16:48:36 [2025-01-28T16:48:36.319Z] Running test: iso-live-login.4k.uefi
16:49:08 [2025-01-28T16:49:08.300Z] The file: journal.txt does not exist
16:49:08 [2025-01-28T16:49:08.300Z] PASS: iso-live-login.4k.uefi (26.748s)
16:49:08 [2025-01-28T16:49:08.300Z] Running test: iso-offline-install.bios
16:53:29 [2025-01-28T16:53:29.716Z] PASS: iso-offline-install.bios (4m8.238s)
16:53:29 [2025-01-28T16:53:29.716Z] Running test: iso-offline-install.mpath.bios
16:57:51 [2025-01-28T16:57:51.115Z] PASS: iso-offline-install.mpath.bios (4m13.843s)
16:57:51 [2025-01-28T16:57:51.115Z] Running test: iso-offline-install-fromram.4k.uefi
17:02:13 [2025-01-28T17:02:13.175Z] PASS: iso-offline-install-fromram.4k.uefi (4m2.989s)
17:02:13 [2025-01-28T17:02:13.175Z] Running test: iso-offline-install-iscsi.ibft.uefi
17:06:04 [2025-01-28T17:06:04.569Z] PASS: iso-offline-install-iscsi.ibft.uefi (3m49.722s)
17:06:04 [2025-01-28T17:06:04.569Z] Running test: iso-offline-install-iscsi.ibft-with-mpath.bios
17:10:11 [2025-01-28T17:10:11.036Z] PASS: iso-offline-install-iscsi.ibft-with-mpath.bios (3m59.728s)
17:10:11 [2025-01-28T17:10:11.036Z] Running test: iso-offline-install-iscsi.manual.bios
17:14:02 [2025-01-28T17:14:02.414Z] PASS: iso-offline-install-iscsi.manual.bios (3m50.715s)
17:14:02 [2025-01-28T17:14:02.414Z] Running test: miniso-install.bios
17:18:38 [2025-01-28T17:18:38.812Z] PASS: miniso-install.bios (4m18.473s)
17:18:38 [2025-01-28T17:18:38.812Z] Running test: miniso-install.nm.bios
17:23:15 [2025-01-28T17:23:15.198Z] PASS: miniso-install.nm.bios (4m23.961s)
17:23:15 [2025-01-28T17:23:15.198Z] Running test: miniso-install.4k.uefi
17:27:51 [2025-01-28T17:27:51.597Z] PASS: miniso-install.4k.uefi (4m20.904s)
17:27:51 [2025-01-28T17:27:51.597Z] Running test: miniso-install.4k.nm.uefi
17:32:28 [2025-01-28T17:32:28.023Z] PASS: miniso-install.4k.nm.uefi (4m31.063s)
17:32:28 [2025-01-28T17:32:28.023Z] Running test: pxe-offline-install.bios
17:36:49 [2025-01-28T17:36:49.649Z] PASS: pxe-offline-install.bios (4m13.46s)
17:36:49 [2025-01-28T17:36:49.649Z] Running test: pxe-offline-install.4k.uefi
17:41:26 [2025-01-28T17:41:26.069Z] PASS: pxe-offline-install.4k.uefi (4m22.863s)
17:41:26 [2025-01-28T17:41:26.069Z] Running test: pxe-online-install.bios
17:45:47 [2025-01-28T17:45:47.470Z] PASS: pxe-online-install.bios (4m14.614s)
17:45:47 [2025-01-28T17:45:47.470Z] Running test: pxe-online-install.4k.uefi
17:50:23 [2025-01-28T17:50:23.883Z] PASS: pxe-online-install.4k.uefi (4m13.527s)
17:50:23 [2025-01-28T17:50:23.887Z] [Pipeline] }
17:50:23 [2025-01-28T17:50:23.892Z] [Pipeline] // withEnv
17:50:23 [2025-01-28T17:50:23.950Z] [Pipeline] withEnv
17:50:23 [2025-01-28T17:50:23.950Z] [Pipeline] {
17:50:23 [2025-01-28T17:50:23.953Z] [Pipeline] sh
17:50:24 [2025-01-28T17:50:24.540Z] + set -xeuo pipefail
17:50:24 [2025-01-28T17:50:24.540Z] ++ umask
17:50:24 [2025-01-28T17:50:24.540Z] + '[' 0022 = 0000 ']'
17:50:24 [2025-01-28T17:50:24.540Z] + cd /home/jenkins/agent/workspace/test-override
17:50:24 [2025-01-28T17:50:24.540Z] + cosa shell -- tar -C /home/jenkins/agent/workspace/test-override/tmp/kola-Kix8s -c --xz kola-testiso-x86_64
17:50:36 [2025-01-28T17:50:36.689Z] [Pipeline] }
17:50:36 [2025-01-28T17:50:36.693Z] [Pipeline] // withEnv
17:50:36 [2025-01-28T17:50:36.786Z] [Pipeline] archiveArtifacts
17:50:36 [2025-01-28T17:50:36.790Z] Archiving artifacts
17:50:37 [2025-01-28T17:50:37.886Z] [Pipeline] withEnv
17:50:37 [2025-01-28T17:50:37.888Z] [Pipeline] {
17:50:37 [2025-01-28T17:50:37.891Z] [Pipeline] sh
17:50:38 [2025-01-28T17:50:38.427Z] + set -xeuo pipefail
17:50:38 [2025-01-28T17:50:38.427Z] ++ umask
17:50:38 [2025-01-28T17:50:38.427Z] + '[' 0022 = 0000 ']'
17:50:38 [2025-01-28T17:50:38.427Z] + cd /home/jenkins/agent/workspace/test-override
17:50:38 [2025-01-28T17:50:38.427Z] + cosa shell -- /usr/lib/coreos-assembler/kola-junit --classname kola-testiso-x86_64 --koladir /home/jenkins/agent/workspace/test-override/tmp/kola-Kix8s/kola-testiso-x86_64 --output -
17:50:38 [2025-01-28T17:50:38.429Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.431Z] [Pipeline] // withEnv
17:50:38 [2025-01-28T17:50:38.439Z] [Pipeline] junit
17:50:38 [2025-01-28T17:50:38.450Z] Recording test results
17:50:38 [2025-01-28T17:50:38.533Z] None of the test reports contained any result
17:50:38 [2025-01-28T17:50:38.533Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.536Z] [Pipeline] // stage
17:50:38 [2025-01-28T17:50:38.616Z] [Pipeline] stage
17:50:38 [2025-01-28T17:50:38.616Z] [Pipeline] { (x86_64:Destroy Remote)
17:50:38 [2025-01-28T17:50:38.630Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.632Z] [Pipeline] // stage
17:50:38 [2025-01-28T17:50:38.647Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.649Z] [Pipeline] // parallel
17:50:38 [2025-01-28T17:50:38.670Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.673Z] [Pipeline] // timeout
17:50:38 [2025-01-28T17:50:38.693Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.704Z] [Pipeline] // container
17:50:38 [2025-01-28T17:50:38.707Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.722Z] [Pipeline] // node
17:50:38 [2025-01-28T17:50:38.734Z] [Pipeline] }
17:50:38 [2025-01-28T17:50:38.809Z] [Pipeline] // podTemplate
17:50:38 [2025-01-28T17:50:38.876Z] [Pipeline] End of Pipeline
17:50:38 [2025-01-28T17:50:38.920Z] Finished: SUCCESS