Console Output

16:49:35 [2024-10-28T16:49:35.102Z] + set -xeuo pipefail
16:49:35 [2024-10-28T16:49:35.102Z] ++ umask
16:49:35 [2024-10-28T16:49:35.102Z] + '[' 0022 = 0000 ']'
16:49:35 [2024-10-28T16:49:35.102Z] + cosa buildextend-live --fast
16:49:35 [2024-10-28T16:49:35.102Z] Targeting build: 42.20241028.dev.0
16:49:35 [2024-10-28T16:49:35.356Z] 2024-10-28 16:49:35,162 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '30b6b8df903613a88195ea1151f5d2cef39d0ba81db1a9522d1bcb94718cff83', '/usr/lib/modules']
16:49:35 [2024-10-28T16:49:35.356Z] 2024-10-28 16:49:35,180 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.0-0.rc5.44.fc42.x86_64/vmlinuz', '30b6b8df903613a88195ea1151f5d2cef39d0ba81db1a9522d1bcb94718cff83', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:49:35 [2024-10-28T16:49:35.356Z] 2024-10-28 16:49:35,297 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.0-0.rc5.44.fc42.x86_64/initramfs.img', '30b6b8df903613a88195ea1151f5d2cef39d0ba81db1a9522d1bcb94718cff83', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:49:36 [2024-10-28T16:49:36.276Z] 2024-10-28 16:49:36,178 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '30b6b8df903613a88195ea1151f5d2cef39d0ba81db1a9522d1bcb94718cff83', '/usr/share/coreos-installer/example-config.yaml']
16:49:36 [2024-10-28T16:49:36.276Z] 2024-10-28 16:49:36,194 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '30b6b8df903613a88195ea1151f5d2cef39d0ba81db1a9522d1bcb94718cff83', '/tmp/tmpqu7xo2jz']
16:49:36 [2024-10-28T16:49:36.276Z] Generating osmet file for 512b metal image
16:49:36 [2024-10-28T16:49:36.276Z] 2024-10-28 16:49:36,211 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20241028.dev.0', '--checksum', '3f1ef92b3c3b3015963e8cdcb82cfe2398bf27ac39b8e93106dc84ab8d339b1d', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:49:54 [2024-10-28T16:49:54.555Z] + RUST_BACKTRACE=full
16:49:54 [2024-10-28T16:49:54.556Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/ef45c82aa51944e862234998836e12fb7813406bd51a804304485edab335532b.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20241028.dev.0' --checksum 3f1ef92b3c3b3015963e8cdcb82cfe2398bf27ac39b8e93106dc84ab8d339b1d --output /var/tmp/coreos-installer-output --fast
16:49:54 [2024-10-28T16:49:54.556Z] Total OSTree objects scanned from /root: 17711 (17705 mapped, 6 empty)
16:49:54 [2024-10-28T16:49:54.556Z] Total OSTree objects found in /boot: 316
16:49:54 [2024-10-28T16:49:54.556Z] Duplicate extents dropped: 0
16:49:54 [2024-10-28T16:49:54.556Z] Overlapping extents clamped: 0
16:49:54 [2024-10-28T16:49:54.556Z] Total /root extents: 17707
16:49:54 [2024-10-28T16:49:54.556Z] Duplicate extents dropped: 0
16:49:54 [2024-10-28T16:49:54.556Z] Overlapping extents clamped: 0
16:49:54 [2024-10-28T16:49:54.556Z] Total /boot extents: 321
16:49:54 [2024-10-28T16:49:54.556Z] Packing image
16:50:09 [2024-10-28T16:50:09.362Z] Total bytes skipped: 1675684864
16:50:09 [2024-10-28T16:50:09.362Z] Total bytes written: 1096750080
16:50:09 [2024-10-28T16:50:09.362Z] Total bytes written (compressed): 25910136
16:50:09 [2024-10-28T16:50:09.362Z] Verifying that repacked image matches digest
16:50:19 [2024-10-28T16:50:19.279Z] Packing successful!
16:50:19 [2024-10-28T16:50:19.279Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:50:19 [2024-10-28T16:50:19.279Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:50:21 [2024-10-28T16:50:21.154Z] Generating osmet file for 4k metal image
16:50:21 [2024-10-28T16:50:21.154Z] 2024-10-28 16:50:21,070 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20241028.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20241028.dev.0', '--checksum', '451d7af616c948384599c30058de4e1e102759127f9fb0d84e6fa045b1e52360', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:50:39 [2024-10-28T16:50:39.160Z] + RUST_BACKTRACE=full
16:50:39 [2024-10-28T16:50:39.160Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/ef45c82aa51944e862234998836e12fb7813406bd51a804304485edab335532b.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20241028.dev.0' --checksum 451d7af616c948384599c30058de4e1e102759127f9fb0d84e6fa045b1e52360 --output /var/tmp/coreos-installer-output --fast
16:50:39 [2024-10-28T16:50:39.160Z] Total OSTree objects scanned from /root: 17711 (17705 mapped, 6 empty)
16:50:39 [2024-10-28T16:50:39.160Z] Total OSTree objects found in /boot: 3
16:50:39 [2024-10-28T16:50:39.160Z] Duplicate extents dropped: 0
16:50:39 [2024-10-28T16:50:39.160Z] Overlapping extents clamped: 0
16:50:39 [2024-10-28T16:50:39.160Z] Total /root extents: 17708
16:50:39 [2024-10-28T16:50:39.160Z] Duplicate extents dropped: 0
16:50:39 [2024-10-28T16:50:39.160Z] Overlapping extents clamped: 0
16:50:39 [2024-10-28T16:50:39.160Z] Total /boot extents: 4
16:50:39 [2024-10-28T16:50:39.160Z] Packing image
16:50:53 [2024-10-28T16:50:53.965Z] Total bytes skipped: 1664819200
16:50:53 [2024-10-28T16:50:53.965Z] Total bytes written: 1107615744
16:50:53 [2024-10-28T16:50:53.965Z] Total bytes written (compressed): 25707892
16:50:53 [2024-10-28T16:50:53.965Z] Verifying that repacked image matches digest
16:51:15 [2024-10-28T16:51:15.807Z] Packing successful!
16:51:15 [2024-10-28T16:51:15.807Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:51:15 [2024-10-28T16:51:15.807Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:51:17 [2024-10-28T16:51:17.162Z] Compressing squashfs with lz4
16:51:17 [2024-10-28T16:51:17.162Z] 2024-10-28 16:51:16,831 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
16:51:17 [2024-10-28T16:51:17.162Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:51:17 [2024-10-28T16:51:17.162Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
16:51:17 [2024-10-28T16:51:17.162Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3
16:51:17 [2024-10-28T16:51:17.162Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/image.squashfs
16:51:17 [2024-10-28T16:51:17.162Z] + coreos_gf_run_mount builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:17 [2024-10-28T16:51:17.162Z] + local mntarg=mount
16:51:17 [2024-10-28T16:51:17.162Z] + '[' builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw = ro ']'
16:51:17 [2024-10-28T16:51:17.162Z] + coreos_gf_run builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:17 [2024-10-28T16:51:17.162Z] + '[' -n '' ']'
16:51:17 [2024-10-28T16:51:17.162Z] + coreos_gf_launch builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:17 [2024-10-28T16:51:17.162Z] + '[' -n '' ']'
16:51:17 [2024-10-28T16:51:17.162Z] ++ guestfish --listen -a builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:17 [2024-10-28T16:51:17.162Z] + eval 'GUESTFISH_PID=12206; export GUESTFISH_PID'
16:51:17 [2024-10-28T16:51:17.162Z] ++ GUESTFISH_PID=12206
16:51:17 [2024-10-28T16:51:17.162Z] ++ export GUESTFISH_PID
16:51:17 [2024-10-28T16:51:17.162Z] + '[' -z 12206 ']'
16:51:17 [2024-10-28T16:51:17.162Z] ++ kola ncpu
16:51:17 [2024-10-28T16:51:17.162Z] + coreos_gf set-smp 6
16:51:17 [2024-10-28T16:51:17.162Z] + guestfish --remote -- set-smp 6
16:51:17 [2024-10-28T16:51:17.162Z] + coreos_gf run
16:51:17 [2024-10-28T16:51:17.162Z] + guestfish --remote -- run
16:51:25 [2024-10-28T16:51:25.216Z] + GUESTFISH_RUNNING=1
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf findfs-label root
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- findfs-label root
16:51:25 [2024-10-28T16:51:25.216Z] + root=/dev/sda4
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf mount /dev/sda4 /
16:51:25 [2024-10-28T16:51:25.216Z] + guestfish --remote -- mount /dev/sda4 /
16:51:25 [2024-10-28T16:51:25.216Z] + local boot
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf findfs-label boot
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- findfs-label boot
16:51:25 [2024-10-28T16:51:25.216Z] + boot=/dev/sda3
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf mount /dev/sda3 /boot
16:51:25 [2024-10-28T16:51:25.216Z] + guestfish --remote -- mount /dev/sda3 /boot
16:51:25 [2024-10-28T16:51:25.216Z] + local partitions
16:51:25 [2024-10-28T16:51:25.216Z] + local label
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf list-partitions
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- list-partitions
16:51:25 [2024-10-28T16:51:25.216Z] + partitions='/dev/sda1
16:51:25 [2024-10-28T16:51:25.216Z] /dev/sda2
16:51:25 [2024-10-28T16:51:25.216Z] /dev/sda3
16:51:25 [2024-10-28T16:51:25.216Z] /dev/sda4'
16:51:25 [2024-10-28T16:51:25.216Z] + for pt in $partitions
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf vfs-label /dev/sda1
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:51:25 [2024-10-28T16:51:25.216Z] + label=
16:51:25 [2024-10-28T16:51:25.216Z] + '[' '' == EFI-SYSTEM ']'
16:51:25 [2024-10-28T16:51:25.216Z] + for pt in $partitions
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf vfs-label /dev/sda2
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:51:25 [2024-10-28T16:51:25.216Z] + label=EFI-SYSTEM
16:51:25 [2024-10-28T16:51:25.216Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf mount /dev/sda2 /boot/efi
16:51:25 [2024-10-28T16:51:25.216Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:51:25 [2024-10-28T16:51:25.216Z] + for pt in $partitions
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf vfs-label /dev/sda3
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:51:25 [2024-10-28T16:51:25.216Z] + label=boot
16:51:25 [2024-10-28T16:51:25.216Z] + '[' boot == EFI-SYSTEM ']'
16:51:25 [2024-10-28T16:51:25.216Z] + for pt in $partitions
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf vfs-label /dev/sda4
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:51:25 [2024-10-28T16:51:25.216Z] + label=root
16:51:25 [2024-10-28T16:51:25.216Z] + '[' root == EFI-SYSTEM ']'
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf ls /ostree/deploy
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- ls /ostree/deploy
16:51:25 [2024-10-28T16:51:25.216Z] + stateroot=/ostree/deploy/fedora-coreos
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:51:25 [2024-10-28T16:51:25.216Z] ++ grep -v .origin
16:51:25 [2024-10-28T16:51:25.216Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/ef45c82aa51944e862234998836e12fb7813406bd51a804304485edab335532b.0
16:51:25 [2024-10-28T16:51:25.216Z] + export stateroot deploydir
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/config
16:51:25 [2024-10-28T16:51:25.216Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/config
16:51:25 [2024-10-28T16:51:25.216Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/config
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/config.new /ostree/repo/config
16:51:25 [2024-10-28T16:51:25.216Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/config.new /ostree/repo/config
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
16:51:25 [2024-10-28T16:51:25.216Z] + kernel_binary=/boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/vmlinuz-6.12.0-0.rc5.44.fc42.x86_64
16:51:25 [2024-10-28T16:51:25.216Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
16:51:25 [2024-10-28T16:51:25.216Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
16:51:25 [2024-10-28T16:51:25.216Z] + kernel_hmac=/boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/.vmlinuz-6.12.0-0.rc5.44.fc42.x86_64.hmac
16:51:25 [2024-10-28T16:51:25.216Z] ++ basename /boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/.vmlinuz-6.12.0-0.rc5.44.fc42.x86_64.hmac
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf ln /boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/.vmlinuz-6.12.0-0.rc5.44.fc42.x86_64.hmac /boot/.vmlinuz-6.12.0-0.rc5.44.fc42.x86_64.hmac
16:51:25 [2024-10-28T16:51:25.216Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/.vmlinuz-6.12.0-0.rc5.44.fc42.x86_64.hmac /boot/.vmlinuz-6.12.0-0.rc5.44.fc42.x86_64.hmac
16:51:25 [2024-10-28T16:51:25.216Z] ++ basename /boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/vmlinuz-6.12.0-0.rc5.44.fc42.x86_64
16:51:25 [2024-10-28T16:51:25.216Z] + coreos_gf ln /boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/vmlinuz-6.12.0-0.rc5.44.fc42.x86_64 /boot/vmlinuz-6.12.0-0.rc5.44.fc42.x86_64
16:51:25 [2024-10-28T16:51:25.217Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-403c0c433815f9b1abfe0e6f5407c571dbe01fdba0fa7d8b230f4a04426ed552/vmlinuz-6.12.0-0.rc5.44.fc42.x86_64 /boot/vmlinuz-6.12.0-0.rc5.44.fc42.x86_64
16:51:25 [2024-10-28T16:51:25.217Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/image.squashfs compress:lz4
16:51:25 [2024-10-28T16:51:25.217Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/image.squashfs compress:lz4
16:51:35 [2024-10-28T16:51:35.126Z] + coreos_gf_shutdown
16:51:35 [2024-10-28T16:51:35.126Z] + coreos_gf umount-all
16:51:35 [2024-10-28T16:51:35.126Z] + guestfish --remote -- umount-all
16:51:35 [2024-10-28T16:51:35.126Z] + coreos_gf exit
16:51:35 [2024-10-28T16:51:35.126Z] + guestfish --remote -- exit
16:51:35 [2024-10-28T16:51:35.126Z] + GUESTFISH_RUNNING=
16:51:35 [2024-10-28T16:51:35.126Z] + GUESTFISH_PID=
16:51:35 [2024-10-28T16:51:35.126Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:51:35 [2024-10-28T16:51:35.126Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.k03iO3 -rf
16:51:35 [2024-10-28T16:51:35.126Z] + _coreos_gf_cleanup
16:51:35 [2024-10-28T16:51:35.126Z] + guestfish --remote -- exit
16:51:35 [2024-10-28T16:51:35.126Z] + :
16:51:40 [2024-10-28T16:51:40.349Z] 2024-10-28 16:51:40,344 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw']
16:51:40 [2024-10-28T16:51:40.608Z] + coreos_gf_run_mount builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:40 [2024-10-28T16:51:40.608Z] + local mntarg=mount
16:51:40 [2024-10-28T16:51:40.608Z] + '[' builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw = ro ']'
16:51:40 [2024-10-28T16:51:40.608Z] + coreos_gf_run builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:40 [2024-10-28T16:51:40.608Z] + '[' -n '' ']'
16:51:40 [2024-10-28T16:51:40.608Z] + coreos_gf_launch builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:40 [2024-10-28T16:51:40.608Z] + '[' -n '' ']'
16:51:40 [2024-10-28T16:51:40.608Z] ++ guestfish --listen -a builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
16:51:40 [2024-10-28T16:51:40.608Z] + eval 'GUESTFISH_PID=12372; export GUESTFISH_PID'
16:51:40 [2024-10-28T16:51:40.608Z] ++ GUESTFISH_PID=12372
16:51:40 [2024-10-28T16:51:40.608Z] ++ export GUESTFISH_PID
16:51:40 [2024-10-28T16:51:40.608Z] + '[' -z 12372 ']'
16:51:40 [2024-10-28T16:51:40.608Z] ++ kola ncpu
16:51:40 [2024-10-28T16:51:40.608Z] + coreos_gf set-smp 6
16:51:40 [2024-10-28T16:51:40.608Z] + guestfish --remote -- set-smp 6
16:51:40 [2024-10-28T16:51:40.861Z] + coreos_gf run
16:51:40 [2024-10-28T16:51:40.861Z] + guestfish --remote -- run
16:51:42 [2024-10-28T16:51:42.215Z] + GUESTFISH_RUNNING=1
16:51:42 [2024-10-28T16:51:42.215Z] ++ coreos_gf findfs-label root
16:51:42 [2024-10-28T16:51:42.215Z] ++ guestfish --remote -- findfs-label root
16:51:42 [2024-10-28T16:51:42.469Z] + root=/dev/sda4
16:51:42 [2024-10-28T16:51:42.469Z] + coreos_gf mount /dev/sda4 /
16:51:42 [2024-10-28T16:51:42.469Z] + guestfish --remote -- mount /dev/sda4 /
16:51:43 [2024-10-28T16:51:43.025Z] + local boot
16:51:43 [2024-10-28T16:51:43.025Z] ++ coreos_gf findfs-label boot
16:51:43 [2024-10-28T16:51:43.025Z] ++ guestfish --remote -- findfs-label boot
16:51:43 [2024-10-28T16:51:43.025Z] + boot=/dev/sda3
16:51:43 [2024-10-28T16:51:43.025Z] + coreos_gf mount /dev/sda3 /boot
16:51:43 [2024-10-28T16:51:43.025Z] + guestfish --remote -- mount /dev/sda3 /boot
16:51:43 [2024-10-28T16:51:43.025Z] + local partitions
16:51:43 [2024-10-28T16:51:43.025Z] + local label
16:51:43 [2024-10-28T16:51:43.025Z] ++ coreos_gf list-partitions
16:51:43 [2024-10-28T16:51:43.025Z] ++ guestfish --remote -- list-partitions
16:51:43 [2024-10-28T16:51:43.025Z] + partitions='/dev/sda1
16:51:43 [2024-10-28T16:51:43.025Z] /dev/sda2
16:51:43 [2024-10-28T16:51:43.025Z] /dev/sda3
16:51:43 [2024-10-28T16:51:43.025Z] /dev/sda4'
16:51:43 [2024-10-28T16:51:43.025Z] + for pt in $partitions
16:51:43 [2024-10-28T16:51:43.025Z] ++ coreos_gf vfs-label /dev/sda1
16:51:43 [2024-10-28T16:51:43.025Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:51:43 [2024-10-28T16:51:43.025Z] + label=
16:51:43 [2024-10-28T16:51:43.025Z] + '[' '' == EFI-SYSTEM ']'
16:51:43 [2024-10-28T16:51:43.025Z] + for pt in $partitions
16:51:43 [2024-10-28T16:51:43.025Z] ++ coreos_gf vfs-label /dev/sda2
16:51:43 [2024-10-28T16:51:43.025Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:51:43 [2024-10-28T16:51:43.278Z] + label=EFI-SYSTEM
16:51:43 [2024-10-28T16:51:43.278Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:51:43 [2024-10-28T16:51:43.279Z] + coreos_gf mount /dev/sda2 /boot/efi
16:51:43 [2024-10-28T16:51:43.279Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:51:43 [2024-10-28T16:51:43.279Z] + for pt in $partitions
16:51:43 [2024-10-28T16:51:43.279Z] ++ coreos_gf vfs-label /dev/sda3
16:51:43 [2024-10-28T16:51:43.279Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:51:43 [2024-10-28T16:51:43.279Z] + label=boot
16:51:43 [2024-10-28T16:51:43.279Z] + '[' boot == EFI-SYSTEM ']'
16:51:43 [2024-10-28T16:51:43.279Z] + for pt in $partitions
16:51:43 [2024-10-28T16:51:43.279Z] ++ coreos_gf vfs-label /dev/sda4
16:51:43 [2024-10-28T16:51:43.279Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:51:43 [2024-10-28T16:51:43.279Z] + label=root
16:51:43 [2024-10-28T16:51:43.279Z] + '[' root == EFI-SYSTEM ']'
16:51:43 [2024-10-28T16:51:43.279Z] ++ coreos_gf ls /ostree/deploy
16:51:43 [2024-10-28T16:51:43.279Z] ++ guestfish --remote -- ls /ostree/deploy
16:51:43 [2024-10-28T16:51:43.279Z] + stateroot=/ostree/deploy/fedora-coreos
16:51:43 [2024-10-28T16:51:43.279Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:51:43 [2024-10-28T16:51:43.279Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:51:43 [2024-10-28T16:51:43.279Z] ++ grep -v .origin
16:51:43 [2024-10-28T16:51:43.279Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/ef45c82aa51944e862234998836e12fb7813406bd51a804304485edab335532b.0
16:51:43 [2024-10-28T16:51:43.279Z] + export stateroot deploydir
16:51:43 [2024-10-28T16:51:43.279Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
16:51:43 [2024-10-28T16:51:43.279Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
16:51:43 [2024-10-28T16:51:43.279Z] + sed -e '/^options/!d' -e 's/^options\s*//'
16:51:43 [2024-10-28T16:51:43.279Z] + coreos_gf_shutdown
16:51:43 [2024-10-28T16:51:43.279Z] + coreos_gf umount-all
16:51:43 [2024-10-28T16:51:43.279Z] + guestfish --remote -- umount-all
16:51:43 [2024-10-28T16:51:43.531Z] + coreos_gf exit
16:51:43 [2024-10-28T16:51:43.531Z] + guestfish --remote -- exit
16:51:43 [2024-10-28T16:51:43.531Z] + GUESTFISH_RUNNING=
16:51:43 [2024-10-28T16:51:43.531Z] + GUESTFISH_PID=
16:51:43 [2024-10-28T16:51:43.531Z] + _coreos_gf_cleanup
16:51:43 [2024-10-28T16:51:43.531Z] + guestfish --remote -- exit
16:51:43 [2024-10-28T16:51:43.531Z] + :
16:51:43 [2024-10-28T16:51:43.531Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20241028.dev.0
16:51:43 [2024-10-28T16:51:43.531Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
16:51:43 [2024-10-28T16:51:43.784Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
16:51:43 [2024-10-28T16:51:43.784Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
16:51:43 [2024-10-28T16:51:43.784Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
16:51:43 [2024-10-28T16:51:43.785Z] 2024-10-28 16:51:43,716 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '30b6b8df903613a88195ea1151f5d2cef39d0ba81db1a9522d1bcb94718cff83', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
16:51:45 [2024-10-28T16:51:45.144Z] 2024-10-28 16:51:44,952 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpo4qlmd7g.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
16:51:47 [2024-10-28T16:51:47.652Z] 2024-10-28 16:51:47,130 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20241028.dev.0', '-volset', 'fedora-coreos-42.20241028.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:51:47 [2024-10-28T16:51:47.652Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:51:47 [2024-10-28T16:51:47.652Z] genisoimage 1.1.11 (Linux)
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:51:47 [2024-10-28T16:51:47.652Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Initial Padblock                        Start Block 0
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Initial Padblock                        Block(s)    16
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Primary Volume Descriptor               Start Block 16
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Primary Volume Descriptor               Block(s)    1
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:51:47 [2024-10-28T16:51:47.652Z] Size of boot image is 4 sectors -> No emulation
16:51:47 [2024-10-28T16:51:47.652Z] Size of boot image is 13192 sectors -> No emulation
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   End Volume Descriptor                   Start Block 19
16:51:47 [2024-10-28T16:51:47.652Z] Done with: End Volume Descriptor                   Block(s)    1
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Version block                           Start Block 20
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Version block                           Block(s)    1
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Path table                              Start Block 21
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Path table                              Block(s)    4
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Joliet path table                       Start Block 25
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Joliet path table                       Block(s)    4
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Directory tree                          Start Block 29
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Directory tree                          Block(s)    7
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Joliet directory tree                   Start Block 36
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Joliet directory tree                   Block(s)    7
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Directory tree cleanup                  Start Block 43
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Directory tree cleanup                  Block(s)    0
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   Extension record                        Start Block 43
16:51:47 [2024-10-28T16:51:47.652Z] Done with: Extension record                        Block(s)    1
16:51:47 [2024-10-28T16:51:47.652Z] Writing:   The File(s)                             Start Block 44
16:51:47 [2024-10-28T16:51:47.652Z]   0.91% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:47 [2024-10-28T16:51:47.652Z]   1.83% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:47 [2024-10-28T16:51:47.652Z]   2.74% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:47 [2024-10-28T16:51:47.906Z]   3.65% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:47 [2024-10-28T16:51:47.906Z]   4.56% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:47 [2024-10-28T16:51:47.906Z]   5.47% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:48 [2024-10-28T16:51:48.159Z]   6.38% done, estimate finish Mon Oct 28 16:51:47 2024
16:51:48 [2024-10-28T16:51:48.159Z]   7.30% done, estimate finish Mon Oct 28 16:52:00 2024
16:51:48 [2024-10-28T16:51:48.417Z]   8.21% done, estimate finish Mon Oct 28 16:51:59 2024
16:51:48 [2024-10-28T16:51:48.417Z]   9.12% done, estimate finish Mon Oct 28 16:51:57 2024
16:51:48 [2024-10-28T16:51:48.417Z]  10.03% done, estimate finish Mon Oct 28 16:51:56 2024
16:51:48 [2024-10-28T16:51:48.417Z]  10.94% done, estimate finish Mon Oct 28 16:51:56 2024
16:51:48 [2024-10-28T16:51:48.417Z]  11.86% done, estimate finish Mon Oct 28 16:51:55 2024
16:51:48 [2024-10-28T16:51:48.417Z]  12.77% done, estimate finish Mon Oct 28 16:51:54 2024
16:51:48 [2024-10-28T16:51:48.417Z]  13.68% done, estimate finish Mon Oct 28 16:51:54 2024
16:51:48 [2024-10-28T16:51:48.417Z]  14.59% done, estimate finish Mon Oct 28 16:51:53 2024
16:51:48 [2024-10-28T16:51:48.417Z]  15.50% done, estimate finish Mon Oct 28 16:51:53 2024
16:51:48 [2024-10-28T16:51:48.417Z]  16.41% done, estimate finish Mon Oct 28 16:51:53 2024
16:51:48 [2024-10-28T16:51:48.417Z]  17.33% done, estimate finish Mon Oct 28 16:51:52 2024
16:51:48 [2024-10-28T16:51:48.417Z]  18.24% done, estimate finish Mon Oct 28 16:51:52 2024
16:51:48 [2024-10-28T16:51:48.417Z]  19.15% done, estimate finish Mon Oct 28 16:51:52 2024
16:51:48 [2024-10-28T16:51:48.417Z]  20.06% done, estimate finish Mon Oct 28 16:51:51 2024
16:51:48 [2024-10-28T16:51:48.417Z]  20.97% done, estimate finish Mon Oct 28 16:51:51 2024
16:51:48 [2024-10-28T16:51:48.417Z]  21.88% done, estimate finish Mon Oct 28 16:51:51 2024
16:51:48 [2024-10-28T16:51:48.669Z]  22.80% done, estimate finish Mon Oct 28 16:51:51 2024
16:51:48 [2024-10-28T16:51:48.669Z]  23.71% done, estimate finish Mon Oct 28 16:51:51 2024
16:51:48 [2024-10-28T16:51:48.669Z]  24.62% done, estimate finish Mon Oct 28 16:51:51 2024
16:51:48 [2024-10-28T16:51:48.669Z]  25.53% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.669Z]  26.44% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.669Z]  27.35% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.669Z]  28.27% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.669Z]  29.18% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.669Z]  30.09% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.670Z]  31.00% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.670Z]  31.91% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.670Z]  32.82% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:48 [2024-10-28T16:51:48.670Z]  33.74% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.670Z]  34.65% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.670Z]  35.56% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.670Z]  36.47% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  37.39% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  38.30% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  39.21% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  40.12% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  41.03% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  41.94% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  42.86% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  43.77% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  44.68% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  45.59% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  46.50% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  47.41% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  48.33% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  49.24% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:48 [2024-10-28T16:51:48.923Z]  50.15% done, estimate finish Mon Oct 28 16:51:48 2024
16:51:49 [2024-10-28T16:51:49.175Z]  51.06% done, estimate finish Mon Oct 28 16:51:48 2024
16:51:49 [2024-10-28T16:51:49.175Z]  51.97% done, estimate finish Mon Oct 28 16:51:48 2024
16:51:49 [2024-10-28T16:51:49.175Z]  52.88% done, estimate finish Mon Oct 28 16:51:48 2024
16:51:49 [2024-10-28T16:51:49.175Z]  53.80% done, estimate finish Mon Oct 28 16:51:48 2024
16:51:49 [2024-10-28T16:51:49.175Z]  54.71% done, estimate finish Mon Oct 28 16:51:48 2024
16:51:49 [2024-10-28T16:51:49.176Z]  55.62% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  56.53% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  57.44% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  58.35% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  59.27% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  60.18% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  61.09% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  62.00% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  62.92% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  63.83% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.176Z]  64.74% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.428Z]  65.65% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.428Z]  66.56% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:49 [2024-10-28T16:51:49.428Z]  67.47% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  68.39% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  69.30% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  70.21% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  71.12% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  72.03% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  72.94% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  73.86% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  74.77% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  75.68% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  76.59% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  77.50% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.428Z]  78.41% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  79.33% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  80.24% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  81.15% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  82.06% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  82.97% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  83.88% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  84.80% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  85.71% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  86.62% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  87.53% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  88.44% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  89.36% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  90.27% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  91.18% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  92.09% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  93.00% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.682Z]  93.92% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.935Z]  94.83% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.935Z]  95.74% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.935Z]  96.65% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.935Z]  97.56% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.935Z]  98.47% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:49 [2024-10-28T16:51:49.935Z]  99.38% done, estimate finish Mon Oct 28 16:51:49 2024
16:51:50 [2024-10-28T16:51:50.188Z] Total translation table size: 2048
16:51:50 [2024-10-28T16:51:50.188Z] Total rockridge attributes bytes: 3006
16:51:50 [2024-10-28T16:51:50.188Z] Total directory bytes: 12288
16:51:50 [2024-10-28T16:51:50.188Z] Path table size(bytes): 96
16:51:50 [2024-10-28T16:51:50.188Z] Done with: The File(s)                             Block(s)    548187
16:51:50 [2024-10-28T16:51:50.188Z] Writing:   Ending Padblock                         Start Block 548231
16:51:50 [2024-10-28T16:51:50.188Z] Done with: Ending Padblock                         Block(s)    150
16:51:50 [2024-10-28T16:51:50.188Z] Max brk space used 1c000
16:51:50 [2024-10-28T16:51:50.188Z] 548381 extents written (1071 MB)
16:51:50 [2024-10-28T16:51:50.188Z] 2024-10-28 16:51:49,944 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso']
16:51:50 [2024-10-28T16:51:50.188Z] isohybrid: Warning: more than 1024 cylinders: 1072
16:51:50 [2024-10-28T16:51:50.188Z] isohybrid: Not all BIOSes will be able to boot this device
16:51:50 [2024-10-28T16:51:50.744Z] 2024-10-28 16:51:50,444 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20241028.dev.0', '-volset', 'fedora-coreos-42.20241028.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:51:50 [2024-10-28T16:51:50.744Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:51:50 [2024-10-28T16:51:50.744Z] genisoimage 1.1.11 (Linux)
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:51:50 [2024-10-28T16:51:50.744Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Initial Padblock                        Start Block 0
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Initial Padblock                        Block(s)    16
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Primary Volume Descriptor               Start Block 16
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Primary Volume Descriptor               Block(s)    1
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:51:50 [2024-10-28T16:51:50.744Z] Size of boot image is 4 sectors -> No emulation
16:51:50 [2024-10-28T16:51:50.744Z] Size of boot image is 13192 sectors -> No emulation
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   End Volume Descriptor                   Start Block 19
16:51:50 [2024-10-28T16:51:50.744Z] Done with: End Volume Descriptor                   Block(s)    1
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Version block                           Start Block 20
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Version block                           Block(s)    1
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Path table                              Start Block 21
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Path table                              Block(s)    4
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Joliet path table                       Start Block 25
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Joliet path table                       Block(s)    4
16:51:50 [2024-10-28T16:51:50.744Z] Writing:   Directory tree                          Start Block 29
16:51:50 [2024-10-28T16:51:50.744Z] Done with: Directory tree                          Block(s)    7
16:51:50 [2024-10-28T16:51:50.745Z] Writing:   Joliet directory tree                   Start Block 36
16:51:50 [2024-10-28T16:51:50.745Z] Done with: Joliet directory tree                   Block(s)    7
16:51:50 [2024-10-28T16:51:50.745Z] Writing:   Directory tree cleanup                  Start Block 43
16:51:50 [2024-10-28T16:51:50.745Z] Done with: Directory tree cleanup                  Block(s)    0
16:51:50 [2024-10-28T16:51:50.745Z] Writing:   Extension record                        Start Block 43
16:51:50 [2024-10-28T16:51:50.745Z] Done with: Extension record                        Block(s)    1
16:51:50 [2024-10-28T16:51:50.745Z] Writing:   The File(s)                             Start Block 44
16:51:50 [2024-10-28T16:51:50.745Z]   8.56% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  17.09% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  25.64% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  34.17% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  42.72% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  51.24% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  59.80% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  68.32% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  76.87% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  85.40% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z]  93.94% done, estimate finish Mon Oct 28 16:51:50 2024
16:51:50 [2024-10-28T16:51:50.745Z] Total translation table size: 2048
16:51:50 [2024-10-28T16:51:50.745Z] Total rockridge attributes bytes: 2842
16:51:50 [2024-10-28T16:51:50.745Z] Total directory bytes: 12288
16:51:50 [2024-10-28T16:51:50.745Z] Path table size(bytes): 96
16:51:50 [2024-10-28T16:51:50.745Z] Done with: The File(s)                             Block(s)    58361
16:51:50 [2024-10-28T16:51:50.745Z] Writing:   Ending Padblock                         Start Block 58405
16:51:50 [2024-10-28T16:51:50.745Z] Done with: Ending Padblock                         Block(s)    150
16:51:50 [2024-10-28T16:51:50.745Z] Max brk space used 1b000
16:51:50 [2024-10-28T16:51:50.745Z] 58555 extents written (114 MB)
16:51:50 [2024-10-28T16:51:50.745Z] 2024-10-28 16:51:50,565 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal']
16:51:50 [2024-10-28T16:51:50.745Z] 2024-10-28 16:51:50,601 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal', '--consume']
16:52:08 [2024-10-28T16:52:08.747Z] + RUST_BACKTRACE=full
16:52:08 [2024-10-28T16:52:08.747Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/ef45c82aa51944e862234998836e12fb7813406bd51a804304485edab335532b.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack minimal-iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal --consume
16:52:08 [2024-10-28T16:52:08.999Z] Packing minimal ISO
16:52:09 [2024-10-28T16:52:09.918Z] Matched 17 files of 17
16:52:09 [2024-10-28T16:52:09.918Z] Total bytes skipped: 119501855
16:52:09 [2024-10-28T16:52:09.918Z] Total bytes written: 1084385
16:52:09 [2024-10-28T16:52:09.918Z] Total bytes written (compressed): 2876
16:52:09 [2024-10-28T16:52:09.918Z] Verifying that packed image matches digest
16:52:10 [2024-10-28T16:52:10.172Z] Packing successful!
16:52:10 [2024-10-28T16:52:10.172Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:52:18 [2024-10-28T16:52:18.391Z] Updated: builds/42.20241028.dev.0/x86_64/meta.json