Console Output

12:31:19 [2025-02-13T12:31:19.853Z] + set -xeuo pipefail
12:31:19 [2025-02-13T12:31:19.853Z] ++ umask
12:31:19 [2025-02-13T12:31:19.853Z] + '[' 0022 = 0000 ']'
12:31:19 [2025-02-13T12:31:19.853Z] + cosa buildextend-live --fast
12:31:20 [2025-02-13T12:31:20.107Z] Targeting build: 43.20250213.dev.0
12:31:20 [2025-02-13T12:31:20.107Z] 2025-02-13 12:31:19,942 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', 'e2dc161a77ad9d8e5676cb4bc2d1a26aa65d4da7f339cc716c0cff9a986cf268', '/usr/lib/modules']
12:31:20 [2025-02-13T12:31:20.107Z] 2025-02-13 12:31:19,951 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.14.0-0.rc2.22.fc43.x86_64/vmlinuz', 'e2dc161a77ad9d8e5676cb4bc2d1a26aa65d4da7f339cc716c0cff9a986cf268', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
12:31:20 [2025-02-13T12:31:20.107Z] 2025-02-13 12:31:20,001 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.14.0-0.rc2.22.fc43.x86_64/initramfs.img', 'e2dc161a77ad9d8e5676cb4bc2d1a26aa65d4da7f339cc716c0cff9a986cf268', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
12:31:20 [2025-02-13T12:31:20.360Z] 2025-02-13 12:31:20,195 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', 'e2dc161a77ad9d8e5676cb4bc2d1a26aa65d4da7f339cc716c0cff9a986cf268', '/usr/share/coreos-installer/example-config.yaml']
12:31:20 [2025-02-13T12:31:20.360Z] 2025-02-13 12:31:20,211 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', 'e2dc161a77ad9d8e5676cb4bc2d1a26aa65d4da7f339cc716c0cff9a986cf268', '/tmp/tmpfq3f0tyf']
12:31:20 [2025-02-13T12:31:20.360Z] Generating osmet file for 512b metal image
12:31:20 [2025-02-13T12:31:20.360Z] 2025-02-13 12:31:20,229 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43.20250213.dev.0', '--checksum', '1b83c4de5342c26f6bfe413a9cc9f0d36ff14645f5a7a0fe472528cf9a8ec1af', '--output', '/var/tmp/coreos-installer-output', '--fast']
12:31:38 [2025-02-13T12:31:38.374Z] + RUST_BACKTRACE=full
12:31:38 [2025-02-13T12:31:38.374Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/b61d6d03899efebbbe3dd761d93ff4b0ec9eee112d201881155fae59395783e2.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43.20250213.dev.0' --checksum 1b83c4de5342c26f6bfe413a9cc9f0d36ff14645f5a7a0fe472528cf9a8ec1af --output /var/tmp/coreos-installer-output --fast
12:31:43 [2025-02-13T12:31:43.595Z] Total OSTree objects scanned from /root: 17845 (17839 mapped, 6 empty)
12:31:43 [2025-02-13T12:31:43.595Z] Total OSTree objects found in /boot: 317
12:31:43 [2025-02-13T12:31:43.595Z] Duplicate extents dropped: 0
12:31:43 [2025-02-13T12:31:43.595Z] Overlapping extents clamped: 0
12:31:43 [2025-02-13T12:31:43.595Z] Total /root extents: 17839
12:31:43 [2025-02-13T12:31:43.595Z] Duplicate extents dropped: 0
12:31:43 [2025-02-13T12:31:43.595Z] Overlapping extents clamped: 0
12:31:43 [2025-02-13T12:31:43.595Z] Total /boot extents: 322
12:31:43 [2025-02-13T12:31:43.595Z] Packing image
12:31:58 [2025-02-13T12:31:58.405Z] Total bytes skipped: 1657180160
12:31:58 [2025-02-13T12:31:58.405Z] Total bytes written: 1087991808
12:31:58 [2025-02-13T12:31:58.405Z] Total bytes written (compressed): 25341152
12:31:58 [2025-02-13T12:31:58.405Z] Verifying that repacked image matches digest
12:32:04 [2025-02-13T12:32:04.919Z] Packing successful!
12:32:04 [2025-02-13T12:32:04.919Z] + '[' -f /var/tmp/coreos-installer-output ']'
12:32:04 [2025-02-13T12:32:04.919Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
12:32:06 [2025-02-13T12:32:06.277Z] Generating osmet file for 4k metal image
12:32:06 [2025-02-13T12:32:06.277Z] 2025-02-13 12:32:05,921 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-43.20250213.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43.20250213.dev.0', '--checksum', 'a43b3c77c364b90be5277ab2808a647200c30b406dc57a5dc8bffbdc961f9982', '--output', '/var/tmp/coreos-installer-output', '--fast']
12:32:24 [2025-02-13T12:32:24.299Z] + RUST_BACKTRACE=full
12:32:24 [2025-02-13T12:32:24.299Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/b61d6d03899efebbbe3dd761d93ff4b0ec9eee112d201881155fae59395783e2.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43.20250213.dev.0' --checksum a43b3c77c364b90be5277ab2808a647200c30b406dc57a5dc8bffbdc961f9982 --output /var/tmp/coreos-installer-output --fast
12:32:24 [2025-02-13T12:32:24.299Z] Total OSTree objects scanned from /root: 17845 (17839 mapped, 6 empty)
12:32:24 [2025-02-13T12:32:24.299Z] Total OSTree objects found in /boot: 3
12:32:24 [2025-02-13T12:32:24.299Z] Duplicate extents dropped: 0
12:32:24 [2025-02-13T12:32:24.299Z] Overlapping extents clamped: 0
12:32:24 [2025-02-13T12:32:24.299Z] Total /root extents: 17840
12:32:24 [2025-02-13T12:32:24.299Z] Duplicate extents dropped: 0
12:32:24 [2025-02-13T12:32:24.299Z] Overlapping extents clamped: 0
12:32:24 [2025-02-13T12:32:24.299Z] Total /boot extents: 4
12:32:24 [2025-02-13T12:32:24.299Z] Packing image
12:32:39 [2025-02-13T12:32:39.113Z] Total bytes skipped: 1646305280
12:32:39 [2025-02-13T12:32:39.113Z] Total bytes written: 1098866688
12:32:39 [2025-02-13T12:32:39.113Z] Total bytes written (compressed): 25439248
12:32:39 [2025-02-13T12:32:39.113Z] Verifying that repacked image matches digest
12:32:45 [2025-02-13T12:32:45.629Z] Packing successful!
12:32:45 [2025-02-13T12:32:45.629Z] + '[' -f /var/tmp/coreos-installer-output ']'
12:32:45 [2025-02-13T12:32:45.629Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
12:32:48 [2025-02-13T12:32:48.142Z] Compressing squashfs with lz4
12:32:48 [2025-02-13T12:32:48.142Z] 2025-02-13 12:32:47,540 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
12:32:48 [2025-02-13T12:32:48.142Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
12:32:48 [2025-02-13T12:32:48.142Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
12:32:48 [2025-02-13T12:32:48.142Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk
12:32:48 [2025-02-13T12:32:48.142Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/image.squashfs
12:32:48 [2025-02-13T12:32:48.142Z] + coreos_gf_run_mount builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:32:48 [2025-02-13T12:32:48.142Z] + local mntarg=mount
12:32:48 [2025-02-13T12:32:48.142Z] + '[' builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw = ro ']'
12:32:48 [2025-02-13T12:32:48.142Z] + coreos_gf_run builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:32:48 [2025-02-13T12:32:48.142Z] + '[' -n '' ']'
12:32:48 [2025-02-13T12:32:48.142Z] + coreos_gf_launch builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:32:48 [2025-02-13T12:32:48.142Z] + '[' -n '' ']'
12:32:48 [2025-02-13T12:32:48.142Z] ++ guestfish --listen -a builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:32:48 [2025-02-13T12:32:48.142Z] + eval 'GUESTFISH_PID=12562; export GUESTFISH_PID'
12:32:48 [2025-02-13T12:32:48.142Z] ++ GUESTFISH_PID=12562
12:32:48 [2025-02-13T12:32:48.142Z] ++ export GUESTFISH_PID
12:32:48 [2025-02-13T12:32:48.142Z] + '[' -z 12562 ']'
12:32:48 [2025-02-13T12:32:48.142Z] ++ kola ncpu
12:32:48 [2025-02-13T12:32:48.142Z] + coreos_gf set-smp 6
12:32:48 [2025-02-13T12:32:48.142Z] + guestfish --remote -- set-smp 6
12:32:48 [2025-02-13T12:32:48.142Z] + coreos_gf run
12:32:48 [2025-02-13T12:32:48.142Z] + guestfish --remote -- run
12:32:50 [2025-02-13T12:32:50.024Z] + GUESTFISH_RUNNING=1
12:32:50 [2025-02-13T12:32:50.024Z] ++ coreos_gf findfs-label root
12:32:50 [2025-02-13T12:32:50.024Z] ++ guestfish --remote -- findfs-label root
12:32:50 [2025-02-13T12:32:50.024Z] + root=/dev/sda4
12:32:50 [2025-02-13T12:32:50.024Z] + coreos_gf mount /dev/sda4 /
12:32:50 [2025-02-13T12:32:50.024Z] + guestfish --remote -- mount /dev/sda4 /
12:32:50 [2025-02-13T12:32:50.277Z] + local boot
12:32:50 [2025-02-13T12:32:50.277Z] ++ coreos_gf findfs-label boot
12:32:50 [2025-02-13T12:32:50.277Z] ++ guestfish --remote -- findfs-label boot
12:32:50 [2025-02-13T12:32:50.277Z] + boot=/dev/sda3
12:32:50 [2025-02-13T12:32:50.277Z] + coreos_gf mount /dev/sda3 /boot
12:32:50 [2025-02-13T12:32:50.277Z] + guestfish --remote -- mount /dev/sda3 /boot
12:32:50 [2025-02-13T12:32:50.277Z] + local partitions
12:32:50 [2025-02-13T12:32:50.277Z] + local label
12:32:50 [2025-02-13T12:32:50.277Z] ++ coreos_gf list-partitions
12:32:50 [2025-02-13T12:32:50.277Z] ++ guestfish --remote -- list-partitions
12:32:50 [2025-02-13T12:32:50.277Z] + partitions='/dev/sda1
12:32:50 [2025-02-13T12:32:50.277Z] /dev/sda2
12:32:50 [2025-02-13T12:32:50.277Z] /dev/sda3
12:32:50 [2025-02-13T12:32:50.277Z] /dev/sda4'
12:32:50 [2025-02-13T12:32:50.277Z] + for pt in $partitions
12:32:50 [2025-02-13T12:32:50.277Z] ++ coreos_gf vfs-label /dev/sda1
12:32:50 [2025-02-13T12:32:50.277Z] ++ guestfish --remote -- vfs-label /dev/sda1
12:32:50 [2025-02-13T12:32:50.277Z] + label=
12:32:50 [2025-02-13T12:32:50.277Z] + '[' '' == EFI-SYSTEM ']'
12:32:50 [2025-02-13T12:32:50.277Z] + for pt in $partitions
12:32:50 [2025-02-13T12:32:50.277Z] ++ coreos_gf vfs-label /dev/sda2
12:32:50 [2025-02-13T12:32:50.277Z] ++ guestfish --remote -- vfs-label /dev/sda2
12:32:50 [2025-02-13T12:32:50.531Z] + label=EFI-SYSTEM
12:32:50 [2025-02-13T12:32:50.531Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
12:32:50 [2025-02-13T12:32:50.531Z] + coreos_gf mount /dev/sda2 /boot/efi
12:32:50 [2025-02-13T12:32:50.531Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
12:32:50 [2025-02-13T12:32:50.531Z] + for pt in $partitions
12:32:50 [2025-02-13T12:32:50.531Z] ++ coreos_gf vfs-label /dev/sda3
12:32:50 [2025-02-13T12:32:50.531Z] ++ guestfish --remote -- vfs-label /dev/sda3
12:32:50 [2025-02-13T12:32:50.531Z] + label=boot
12:32:50 [2025-02-13T12:32:50.531Z] + '[' boot == EFI-SYSTEM ']'
12:32:50 [2025-02-13T12:32:50.531Z] + for pt in $partitions
12:32:50 [2025-02-13T12:32:50.531Z] ++ coreos_gf vfs-label /dev/sda4
12:32:50 [2025-02-13T12:32:50.531Z] ++ guestfish --remote -- vfs-label /dev/sda4
12:32:50 [2025-02-13T12:32:50.531Z] + label=root
12:32:50 [2025-02-13T12:32:50.531Z] + '[' root == EFI-SYSTEM ']'
12:32:50 [2025-02-13T12:32:50.531Z] ++ coreos_gf ls /ostree/deploy
12:32:50 [2025-02-13T12:32:50.531Z] ++ guestfish --remote -- ls /ostree/deploy
12:32:50 [2025-02-13T12:32:50.531Z] + stateroot=/ostree/deploy/fedora-coreos
12:32:50 [2025-02-13T12:32:50.531Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
12:32:50 [2025-02-13T12:32:50.531Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
12:32:50 [2025-02-13T12:32:50.531Z] ++ grep -v .origin
12:32:50 [2025-02-13T12:32:50.531Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/b61d6d03899efebbbe3dd761d93ff4b0ec9eee112d201881155fae59395783e2.0
12:32:50 [2025-02-13T12:32:50.531Z] + export stateroot deploydir
12:32:50 [2025-02-13T12:32:50.531Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/config
12:32:50 [2025-02-13T12:32:50.531Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/config
12:32:50 [2025-02-13T12:32:50.531Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/config
12:32:50 [2025-02-13T12:32:50.531Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/config.new /ostree/repo/config
12:32:50 [2025-02-13T12:32:50.531Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/config.new /ostree/repo/config
12:32:50 [2025-02-13T12:32:50.785Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
12:32:50 [2025-02-13T12:32:50.785Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
12:32:50 [2025-02-13T12:32:50.786Z] + kernel_binary=/boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/vmlinuz-6.14.0-0.rc2.22.fc43.x86_64
12:32:50 [2025-02-13T12:32:50.786Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
12:32:50 [2025-02-13T12:32:50.786Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
12:32:50 [2025-02-13T12:32:50.786Z] + kernel_hmac=/boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/.vmlinuz-6.14.0-0.rc2.22.fc43.x86_64.hmac
12:32:50 [2025-02-13T12:32:50.786Z] ++ basename /boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/.vmlinuz-6.14.0-0.rc2.22.fc43.x86_64.hmac
12:32:50 [2025-02-13T12:32:50.786Z] + coreos_gf ln /boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/.vmlinuz-6.14.0-0.rc2.22.fc43.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc2.22.fc43.x86_64.hmac
12:32:50 [2025-02-13T12:32:50.786Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/.vmlinuz-6.14.0-0.rc2.22.fc43.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc2.22.fc43.x86_64.hmac
12:32:50 [2025-02-13T12:32:50.786Z] ++ basename /boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/vmlinuz-6.14.0-0.rc2.22.fc43.x86_64
12:32:50 [2025-02-13T12:32:50.786Z] + coreos_gf ln /boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/vmlinuz-6.14.0-0.rc2.22.fc43.x86_64 /boot/vmlinuz-6.14.0-0.rc2.22.fc43.x86_64
12:32:50 [2025-02-13T12:32:50.786Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-7d2bf18ecbf8887ba5b873deaf95ed4939e3b953aa264d0eadcffaf76124f559/vmlinuz-6.14.0-0.rc2.22.fc43.x86_64 /boot/vmlinuz-6.14.0-0.rc2.22.fc43.x86_64
12:32:50 [2025-02-13T12:32:50.786Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/image.squashfs compress:lz4
12:32:50 [2025-02-13T12:32:50.786Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/image.squashfs compress:lz4
12:32:59 [2025-02-13T12:32:59.104Z] + coreos_gf_shutdown
12:32:59 [2025-02-13T12:32:59.104Z] + coreos_gf umount-all
12:32:59 [2025-02-13T12:32:59.104Z] + guestfish --remote -- umount-all
12:32:59 [2025-02-13T12:32:59.104Z] + coreos_gf exit
12:32:59 [2025-02-13T12:32:59.104Z] + guestfish --remote -- exit
12:32:59 [2025-02-13T12:32:59.104Z] + GUESTFISH_RUNNING=
12:32:59 [2025-02-13T12:32:59.104Z] + GUESTFISH_PID=
12:32:59 [2025-02-13T12:32:59.104Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
12:32:59 [2025-02-13T12:32:59.104Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.jy0Ynk -rf
12:32:59 [2025-02-13T12:32:59.104Z] + _coreos_gf_cleanup
12:32:59 [2025-02-13T12:32:59.104Z] + guestfish --remote -- exit
12:32:59 [2025-02-13T12:32:59.104Z] + :
12:33:04 [2025-02-13T12:33:04.327Z] 2025-02-13 12:33:03,776 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw']
12:33:04 [2025-02-13T12:33:04.327Z] + coreos_gf_run_mount builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:33:04 [2025-02-13T12:33:04.327Z] + local mntarg=mount
12:33:04 [2025-02-13T12:33:04.327Z] + '[' builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw = ro ']'
12:33:04 [2025-02-13T12:33:04.327Z] + coreos_gf_run builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:33:04 [2025-02-13T12:33:04.327Z] + '[' -n '' ']'
12:33:04 [2025-02-13T12:33:04.327Z] + coreos_gf_launch builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:33:04 [2025-02-13T12:33:04.327Z] + '[' -n '' ']'
12:33:04 [2025-02-13T12:33:04.327Z] ++ guestfish --listen -a builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw --ro
12:33:04 [2025-02-13T12:33:04.327Z] + eval 'GUESTFISH_PID=12701; export GUESTFISH_PID'
12:33:04 [2025-02-13T12:33:04.327Z] ++ GUESTFISH_PID=12701
12:33:04 [2025-02-13T12:33:04.327Z] ++ export GUESTFISH_PID
12:33:04 [2025-02-13T12:33:04.327Z] + '[' -z 12701 ']'
12:33:04 [2025-02-13T12:33:04.327Z] ++ kola ncpu
12:33:04 [2025-02-13T12:33:04.327Z] + coreos_gf set-smp 6
12:33:04 [2025-02-13T12:33:04.327Z] + guestfish --remote -- set-smp 6
12:33:04 [2025-02-13T12:33:04.327Z] + coreos_gf run
12:33:04 [2025-02-13T12:33:04.327Z] + guestfish --remote -- run
12:33:05 [2025-02-13T12:33:05.683Z] + GUESTFISH_RUNNING=1
12:33:05 [2025-02-13T12:33:05.683Z] ++ coreos_gf findfs-label root
12:33:05 [2025-02-13T12:33:05.683Z] ++ guestfish --remote -- findfs-label root
12:33:05 [2025-02-13T12:33:05.936Z] + root=/dev/sda4
12:33:05 [2025-02-13T12:33:05.936Z] + coreos_gf mount /dev/sda4 /
12:33:05 [2025-02-13T12:33:05.936Z] + guestfish --remote -- mount /dev/sda4 /
12:33:06 [2025-02-13T12:33:06.502Z] + local boot
12:33:06 [2025-02-13T12:33:06.502Z] ++ coreos_gf findfs-label boot
12:33:06 [2025-02-13T12:33:06.502Z] ++ guestfish --remote -- findfs-label boot
12:33:06 [2025-02-13T12:33:06.502Z] + boot=/dev/sda3
12:33:06 [2025-02-13T12:33:06.502Z] + coreos_gf mount /dev/sda3 /boot
12:33:06 [2025-02-13T12:33:06.502Z] + guestfish --remote -- mount /dev/sda3 /boot
12:33:06 [2025-02-13T12:33:06.502Z] + local partitions
12:33:06 [2025-02-13T12:33:06.502Z] + local label
12:33:06 [2025-02-13T12:33:06.502Z] ++ coreos_gf list-partitions
12:33:06 [2025-02-13T12:33:06.502Z] ++ guestfish --remote -- list-partitions
12:33:06 [2025-02-13T12:33:06.502Z] + partitions='/dev/sda1
12:33:06 [2025-02-13T12:33:06.502Z] /dev/sda2
12:33:06 [2025-02-13T12:33:06.502Z] /dev/sda3
12:33:06 [2025-02-13T12:33:06.502Z] /dev/sda4'
12:33:06 [2025-02-13T12:33:06.502Z] + for pt in $partitions
12:33:06 [2025-02-13T12:33:06.502Z] ++ coreos_gf vfs-label /dev/sda1
12:33:06 [2025-02-13T12:33:06.502Z] ++ guestfish --remote -- vfs-label /dev/sda1
12:33:06 [2025-02-13T12:33:06.502Z] + label=
12:33:06 [2025-02-13T12:33:06.502Z] + '[' '' == EFI-SYSTEM ']'
12:33:06 [2025-02-13T12:33:06.502Z] + for pt in $partitions
12:33:06 [2025-02-13T12:33:06.502Z] ++ coreos_gf vfs-label /dev/sda2
12:33:06 [2025-02-13T12:33:06.502Z] ++ guestfish --remote -- vfs-label /dev/sda2
12:33:06 [2025-02-13T12:33:06.502Z] + label=EFI-SYSTEM
12:33:06 [2025-02-13T12:33:06.502Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
12:33:06 [2025-02-13T12:33:06.502Z] + coreos_gf mount /dev/sda2 /boot/efi
12:33:06 [2025-02-13T12:33:06.502Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
12:33:06 [2025-02-13T12:33:06.502Z] + for pt in $partitions
12:33:06 [2025-02-13T12:33:06.502Z] ++ coreos_gf vfs-label /dev/sda3
12:33:06 [2025-02-13T12:33:06.502Z] ++ guestfish --remote -- vfs-label /dev/sda3
12:33:06 [2025-02-13T12:33:06.756Z] + label=boot
12:33:06 [2025-02-13T12:33:06.756Z] + '[' boot == EFI-SYSTEM ']'
12:33:06 [2025-02-13T12:33:06.756Z] + for pt in $partitions
12:33:06 [2025-02-13T12:33:06.756Z] ++ coreos_gf vfs-label /dev/sda4
12:33:06 [2025-02-13T12:33:06.756Z] ++ guestfish --remote -- vfs-label /dev/sda4
12:33:06 [2025-02-13T12:33:06.756Z] + label=root
12:33:06 [2025-02-13T12:33:06.756Z] + '[' root == EFI-SYSTEM ']'
12:33:06 [2025-02-13T12:33:06.756Z] ++ coreos_gf ls /ostree/deploy
12:33:06 [2025-02-13T12:33:06.756Z] ++ guestfish --remote -- ls /ostree/deploy
12:33:06 [2025-02-13T12:33:06.756Z] + stateroot=/ostree/deploy/fedora-coreos
12:33:06 [2025-02-13T12:33:06.756Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
12:33:06 [2025-02-13T12:33:06.757Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
12:33:06 [2025-02-13T12:33:06.757Z] ++ grep -v .origin
12:33:06 [2025-02-13T12:33:06.757Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/b61d6d03899efebbbe3dd761d93ff4b0ec9eee112d201881155fae59395783e2.0
12:33:06 [2025-02-13T12:33:06.757Z] + export stateroot deploydir
12:33:06 [2025-02-13T12:33:06.757Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
12:33:06 [2025-02-13T12:33:06.757Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
12:33:06 [2025-02-13T12:33:06.757Z] + sed -e '/^options/!d' -e 's/^options\s*//'
12:33:06 [2025-02-13T12:33:06.757Z] + coreos_gf_shutdown
12:33:06 [2025-02-13T12:33:06.757Z] + coreos_gf umount-all
12:33:06 [2025-02-13T12:33:06.757Z] + guestfish --remote -- umount-all
12:33:06 [2025-02-13T12:33:06.757Z] + coreos_gf exit
12:33:06 [2025-02-13T12:33:06.757Z] + guestfish --remote -- exit
12:33:07 [2025-02-13T12:33:07.010Z] + GUESTFISH_RUNNING=
12:33:07 [2025-02-13T12:33:07.010Z] + GUESTFISH_PID=
12:33:07 [2025-02-13T12:33:07.010Z] + _coreos_gf_cleanup
12:33:07 [2025-02-13T12:33:07.010Z] + guestfish --remote -- exit
12:33:07 [2025-02-13T12:33:07.010Z] + :
12:33:07 [2025-02-13T12:33:07.010Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-43.20250213.dev.0
12:33:07 [2025-02-13T12:33:07.010Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
12:33:07 [2025-02-13T12:33:07.010Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
12:33:07 [2025-02-13T12:33:07.010Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
12:33:07 [2025-02-13T12:33:07.263Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
12:33:07 [2025-02-13T12:33:07.263Z] 2025-02-13 12:33:07,026 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', 'e2dc161a77ad9d8e5676cb4bc2d1a26aa65d4da7f339cc716c0cff9a986cf268', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
12:33:08 [2025-02-13T12:33:08.182Z] 2025-02-13 12:33:07,922 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpyozk6m34.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
12:33:10 [2025-02-13T12:33:10.686Z] 2025-02-13 12:33:10,552 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-43.20250213.dev.0', '-volset', 'fedora-coreos-43.20250213.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
12:33:10 [2025-02-13T12:33:10.686Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
12:33:10 [2025-02-13T12:33:10.686Z] genisoimage 1.1.11 (Linux)
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
12:33:10 [2025-02-13T12:33:10.686Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Initial Padblock                        Start Block 0
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Initial Padblock                        Block(s)    16
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Primary Volume Descriptor               Start Block 16
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Primary Volume Descriptor               Block(s)    1
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Eltorito Volume Descriptor              Start Block 17
12:33:10 [2025-02-13T12:33:10.686Z] Size of boot image is 4 sectors -> No emulation
12:33:10 [2025-02-13T12:33:10.686Z] Size of boot image is 13104 sectors -> No emulation
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Eltorito Volume Descriptor              Block(s)    1
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Joliet Volume Descriptor                Start Block 18
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Joliet Volume Descriptor                Block(s)    1
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   End Volume Descriptor                   Start Block 19
12:33:10 [2025-02-13T12:33:10.686Z] Done with: End Volume Descriptor                   Block(s)    1
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Version block                           Start Block 20
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Version block                           Block(s)    1
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Path table                              Start Block 21
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Path table                              Block(s)    4
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Joliet path table                       Start Block 25
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Joliet path table                       Block(s)    4
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Directory tree                          Start Block 29
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Directory tree                          Block(s)    7
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Joliet directory tree                   Start Block 36
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Joliet directory tree                   Block(s)    7
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Directory tree cleanup                  Start Block 43
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Directory tree cleanup                  Block(s)    0
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   Extension record                        Start Block 43
12:33:10 [2025-02-13T12:33:10.686Z] Done with: Extension record                        Block(s)    1
12:33:10 [2025-02-13T12:33:10.686Z] Writing:   The File(s)                             Start Block 44
12:33:10 [2025-02-13T12:33:10.686Z]   0.91% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   1.83% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   2.74% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   3.66% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   4.57% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   5.48% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   6.39% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   7.31% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   8.22% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]   9.14% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]  10.05% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]  10.96% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]  11.88% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.686Z]  12.79% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  13.70% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  14.62% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  15.53% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  16.45% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  17.36% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  18.27% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  19.18% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  20.10% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  21.01% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  21.93% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  22.84% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  23.75% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  24.67% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  25.58% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  26.49% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  27.41% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  28.32% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  29.23% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  30.15% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  31.06% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  31.97% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  32.89% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  33.80% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  34.72% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  35.63% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  36.54% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  37.45% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:10 [2025-02-13T12:33:10.939Z]  38.37% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  39.28% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  40.20% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  41.11% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  42.02% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  42.94% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  43.85% done, estimate finish Thu Feb 13 12:33:10 2025
12:33:11 [2025-02-13T12:33:11.193Z]  44.76% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:11 [2025-02-13T12:33:11.193Z]  45.68% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:11 [2025-02-13T12:33:11.193Z]  46.59% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:11 [2025-02-13T12:33:11.193Z]  47.50% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:11 [2025-02-13T12:33:11.193Z]  48.42% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:11 [2025-02-13T12:33:11.193Z]  49.33% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:11 [2025-02-13T12:33:11.193Z]  50.24% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  51.16% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  52.07% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  52.99% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  53.90% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  54.81% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  55.72% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  56.64% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  57.55% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  58.47% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.193Z]  59.38% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  60.29% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  61.21% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  62.12% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  63.03% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  63.95% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  64.86% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  65.78% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  66.69% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  67.60% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  68.51% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  69.43% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  70.34% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  71.26% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  72.17% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  73.08% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  74.00% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  74.91% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  75.82% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  76.74% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  77.65% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  78.56% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  79.48% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  80.39% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.447Z]  81.30% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  82.22% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  83.13% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  84.05% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  84.96% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  85.87% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  86.78% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  87.70% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  88.61% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  89.53% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  90.44% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  91.35% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  92.27% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  93.18% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  94.09% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  95.01% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  95.92% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  96.83% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  97.75% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  98.66% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z]  99.57% done, estimate finish Thu Feb 13 12:33:11 2025
12:33:11 [2025-02-13T12:33:11.700Z] Total translation table size: 2048
12:33:11 [2025-02-13T12:33:11.700Z] Total rockridge attributes bytes: 3006
12:33:11 [2025-02-13T12:33:11.700Z] Total directory bytes: 12288
12:33:11 [2025-02-13T12:33:11.700Z] Path table size(bytes): 96
12:33:11 [2025-02-13T12:33:11.700Z] Done with: The File(s)                             Block(s)    547146
12:33:11 [2025-02-13T12:33:11.700Z] Writing:   Ending Padblock                         Start Block 547190
12:33:11 [2025-02-13T12:33:11.700Z] Done with: Ending Padblock                         Block(s)    150
12:33:11 [2025-02-13T12:33:11.700Z] Max brk space used 1c000
12:33:11 [2025-02-13T12:33:11.700Z] 547340 extents written (1069 MB)
12:33:11 [2025-02-13T12:33:11.700Z] 2025-02-13 12:33:11,668 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso']
12:33:11 [2025-02-13T12:33:11.700Z] isohybrid: Warning: more than 1024 cylinders: 1070
12:33:11 [2025-02-13T12:33:11.700Z] isohybrid: Not all BIOSes will be able to boot this device
12:33:12 [2025-02-13T12:33:12.258Z] 2025-02-13 12:33:12,117 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-43.20250213.dev.0', '-volset', 'fedora-coreos-43.20250213.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
12:33:12 [2025-02-13T12:33:12.258Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
12:33:12 [2025-02-13T12:33:12.258Z] genisoimage 1.1.11 (Linux)
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
12:33:12 [2025-02-13T12:33:12.258Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Initial Padblock                        Start Block 0
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Initial Padblock                        Block(s)    16
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Primary Volume Descriptor               Start Block 16
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Primary Volume Descriptor               Block(s)    1
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Eltorito Volume Descriptor              Start Block 17
12:33:12 [2025-02-13T12:33:12.258Z] Size of boot image is 4 sectors -> No emulation
12:33:12 [2025-02-13T12:33:12.258Z] Size of boot image is 13104 sectors -> No emulation
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Eltorito Volume Descriptor              Block(s)    1
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Joliet Volume Descriptor                Start Block 18
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Joliet Volume Descriptor                Block(s)    1
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   End Volume Descriptor                   Start Block 19
12:33:12 [2025-02-13T12:33:12.258Z] Done with: End Volume Descriptor                   Block(s)    1
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Version block                           Start Block 20
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Version block                           Block(s)    1
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Path table                              Start Block 21
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Path table                              Block(s)    4
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Joliet path table                       Start Block 25
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Joliet path table                       Block(s)    4
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Directory tree                          Start Block 29
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Directory tree                          Block(s)    7
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Joliet directory tree                   Start Block 36
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Joliet directory tree                   Block(s)    7
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Directory tree cleanup                  Start Block 43
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Directory tree cleanup                  Block(s)    0
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   Extension record                        Start Block 43
12:33:12 [2025-02-13T12:33:12.258Z] Done with: Extension record                        Block(s)    1
12:33:12 [2025-02-13T12:33:12.258Z] Writing:   The File(s)                             Start Block 44
12:33:12 [2025-02-13T12:33:12.511Z]   8.40% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.511Z]  16.77% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.511Z]  25.18% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.511Z]  33.55% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.764Z]  41.95% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.764Z]  50.32% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.764Z]  58.72% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:12 [2025-02-13T12:33:12.764Z]  67.10% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:13 [2025-02-13T12:33:13.019Z]  75.50% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:13 [2025-02-13T12:33:13.019Z]  83.87% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:13 [2025-02-13T12:33:13.019Z]  92.28% done, estimate finish Thu Feb 13 12:33:12 2025
12:33:13 [2025-02-13T12:33:13.019Z] Total translation table size: 2048
12:33:13 [2025-02-13T12:33:13.019Z] Total rockridge attributes bytes: 2842
12:33:13 [2025-02-13T12:33:13.019Z] Total directory bytes: 12288
12:33:13 [2025-02-13T12:33:13.019Z] Path table size(bytes): 96
12:33:13 [2025-02-13T12:33:13.019Z] Done with: The File(s)                             Block(s)    59420
12:33:13 [2025-02-13T12:33:13.019Z] Writing:   Ending Padblock                         Start Block 59464
12:33:13 [2025-02-13T12:33:13.019Z] Done with: Ending Padblock                         Block(s)    150
12:33:13 [2025-02-13T12:33:13.019Z] Max brk space used 1b000
12:33:13 [2025-02-13T12:33:13.019Z] 59614 extents written (116 MB)
12:33:13 [2025-02-13T12:33:13.019Z] 2025-02-13 12:33:12,873 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso.minimal']
12:33:13 [2025-02-13T12:33:13.019Z] 2025-02-13 12:33:12,912 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250213.dev.0/x86_64/fedora-coreos-43.20250213.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso.minimal', '--consume']
12:33:31 [2025-02-13T12:33:31.036Z] + RUST_BACKTRACE=full
12:33:31 [2025-02-13T12:33:31.036Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/b61d6d03899efebbbe3dd761d93ff4b0ec9eee112d201881155fae59395783e2.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack minimal-iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250213.dev.0-live.x86_64.iso.minimal --consume
12:33:31 [2025-02-13T12:33:31.036Z] Packing minimal ISO
12:33:31 [2025-02-13T12:33:31.036Z] Matched 17 files of 17
12:33:31 [2025-02-13T12:33:31.036Z] Total bytes skipped: 121670323
12:33:31 [2025-02-13T12:33:31.036Z] Total bytes written: 1013069
12:33:31 [2025-02-13T12:33:31.036Z] Total bytes written (compressed): 2872
12:33:31 [2025-02-13T12:33:31.036Z] Verifying that packed image matches digest
12:33:31 [2025-02-13T12:33:31.036Z] Packing successful!
12:33:31 [2025-02-13T12:33:31.036Z] + '[' -f /var/tmp/coreos-installer-output ']'
12:33:34 [2025-02-13T12:33:34.291Z] Updated: builds/43.20250213.dev.0/x86_64/meta.json