Console Output
19:32:46 [2025-01-23T19:32:46.882Z] + set -xeuo pipefail
19:32:46 [2025-01-23T19:32:46.883Z] ++ umask
19:32:46 [2025-01-23T19:32:46.883Z] + '[' 0022 = 0000 ']'
19:32:46 [2025-01-23T19:32:46.883Z] + cosa buildextend-live --fast
19:32:46 [2025-01-23T19:32:46.883Z] Targeting build: 42.20250123.dev.0
19:32:47 [2025-01-23T19:32:47.137Z] 2025-01-23 19:32:46,938 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '4a4634ca3bc07fdbbb2423ebe4a100e5689106bc58ceb56eec578a6335a1dfe4', '/usr/lib/modules']
19:32:47 [2025-01-23T19:32:47.137Z] 2025-01-23 19:32:46,949 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.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64/vmlinuz', '4a4634ca3bc07fdbbb2423ebe4a100e5689106bc58ceb56eec578a6335a1dfe4', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
19:32:47 [2025-01-23T19:32:47.137Z] 2025-01-23 19:32:46,998 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.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64/initramfs.img', '4a4634ca3bc07fdbbb2423ebe4a100e5689106bc58ceb56eec578a6335a1dfe4', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
19:32:47 [2025-01-23T19:32:47.390Z] 2025-01-23 19:32:47,193 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '4a4634ca3bc07fdbbb2423ebe4a100e5689106bc58ceb56eec578a6335a1dfe4', '/usr/share/coreos-installer/example-config.yaml']
19:32:47 [2025-01-23T19:32:47.390Z] 2025-01-23 19:32:47,210 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '4a4634ca3bc07fdbbb2423ebe4a100e5689106bc58ceb56eec578a6335a1dfe4', '/tmp/tmpxix8x5ww']
19:32:47 [2025-01-23T19:32:47.390Z] Generating osmet file for 512b metal image
19:32:47 [2025-01-23T19:32:47.390Z] 2025-01-23 19:32:47,224 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20250123.dev.0', '--checksum', '4615ae6d9b426ad43db57701f29918e592885af0d2c5d5e05ee94544fd8281f5', '--output', '/var/tmp/coreos-installer-output', '--fast']
19:33:05 [2025-01-23T19:33:05.416Z] + RUST_BACKTRACE=full
19:33:05 [2025-01-23T19:33:05.416Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/fecffcb5c66539cbe796c9725b1b9defae8a4f62c0a036b18209fcbcd11f5220.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20250123.dev.0' --checksum 4615ae6d9b426ad43db57701f29918e592885af0d2c5d5e05ee94544fd8281f5 --output /var/tmp/coreos-installer-output --fast
19:33:17 [2025-01-23T19:33:17.555Z] Total OSTree objects scanned from /root: 17819 (17813 mapped, 6 empty)
19:33:17 [2025-01-23T19:33:17.555Z] Total OSTree objects found in /boot: 313
19:33:17 [2025-01-23T19:33:17.555Z] Duplicate extents dropped: 0
19:33:17 [2025-01-23T19:33:17.555Z] Overlapping extents clamped: 0
19:33:17 [2025-01-23T19:33:17.555Z] Total /root extents: 17815
19:33:17 [2025-01-23T19:33:17.555Z] Duplicate extents dropped: 0
19:33:17 [2025-01-23T19:33:17.555Z] Overlapping extents clamped: 0
19:33:17 [2025-01-23T19:33:17.555Z] Total /boot extents: 318
19:33:17 [2025-01-23T19:33:17.555Z] Packing image
19:33:32 [2025-01-23T19:33:32.360Z] Total bytes skipped: 1648400384
19:33:32 [2025-01-23T19:33:32.360Z] Total bytes written: 1086285824
19:33:32 [2025-01-23T19:33:32.360Z] Total bytes written (compressed): 25228448
19:33:32 [2025-01-23T19:33:32.360Z] Verifying that repacked image matches digest
19:33:38 [2025-01-23T19:33:38.873Z] Packing successful!
19:33:38 [2025-01-23T19:33:38.873Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:33:38 [2025-01-23T19:33:38.873Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
19:33:40 [2025-01-23T19:33:40.229Z] Generating osmet file for 4k metal image
19:33:40 [2025-01-23T19:33:40.229Z] 2025-01-23 19:33:39,795 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250123.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20250123.dev.0', '--checksum', '08b41aab0eb5de0c9a9f51ebdb68b66b3763ea888c78c963900530db678dc829', '--output', '/var/tmp/coreos-installer-output', '--fast']
19:33:58 [2025-01-23T19:33:58.239Z] + RUST_BACKTRACE=full
19:33:58 [2025-01-23T19:33:58.239Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/fecffcb5c66539cbe796c9725b1b9defae8a4f62c0a036b18209fcbcd11f5220.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20250123.dev.0' --checksum 08b41aab0eb5de0c9a9f51ebdb68b66b3763ea888c78c963900530db678dc829 --output /var/tmp/coreos-installer-output --fast
19:33:58 [2025-01-23T19:33:58.239Z] Total OSTree objects scanned from /root: 17819 (17813 mapped, 6 empty)
19:33:58 [2025-01-23T19:33:58.239Z] Total OSTree objects found in /boot: 3
19:33:58 [2025-01-23T19:33:58.239Z] Duplicate extents dropped: 0
19:33:58 [2025-01-23T19:33:58.239Z] Overlapping extents clamped: 0
19:33:58 [2025-01-23T19:33:58.239Z] Total /root extents: 17814
19:33:58 [2025-01-23T19:33:58.239Z] Duplicate extents dropped: 0
19:33:58 [2025-01-23T19:33:58.239Z] Overlapping extents clamped: 0
19:33:58 [2025-01-23T19:33:58.239Z] Total /boot extents: 4
19:33:58 [2025-01-23T19:33:58.239Z] Packing image
19:34:13 [2025-01-23T19:34:13.045Z] Total bytes skipped: 1637552128
19:34:13 [2025-01-23T19:34:13.045Z] Total bytes written: 1097134080
19:34:13 [2025-01-23T19:34:13.045Z] Total bytes written (compressed): 25311804
19:34:13 [2025-01-23T19:34:13.045Z] Verifying that repacked image matches digest
19:34:19 [2025-01-23T19:34:19.553Z] Packing successful!
19:34:19 [2025-01-23T19:34:19.553Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:34:19 [2025-01-23T19:34:19.553Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
19:34:20 [2025-01-23T19:34:20.908Z] Compressing squashfs with lz4
19:34:20 [2025-01-23T19:34:20.908Z] 2025-01-23 19:34:20,473 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
19:34:20 [2025-01-23T19:34:20.908Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
19:34:20 [2025-01-23T19:34:20.908Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
19:34:20 [2025-01-23T19:34:20.908Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK
19:34:20 [2025-01-23T19:34:20.908Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/image.squashfs
19:34:20 [2025-01-23T19:34:20.908Z] + coreos_gf_run_mount builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:20 [2025-01-23T19:34:20.908Z] + local mntarg=mount
19:34:20 [2025-01-23T19:34:20.908Z] + '[' builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw = ro ']'
19:34:20 [2025-01-23T19:34:20.908Z] + coreos_gf_run builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:20 [2025-01-23T19:34:20.908Z] + '[' -n '' ']'
19:34:20 [2025-01-23T19:34:20.908Z] + coreos_gf_launch builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:20 [2025-01-23T19:34:20.908Z] + '[' -n '' ']'
19:34:20 [2025-01-23T19:34:20.908Z] ++ guestfish --listen -a builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:20 [2025-01-23T19:34:20.908Z] + eval 'GUESTFISH_PID=12411; export GUESTFISH_PID'
19:34:20 [2025-01-23T19:34:20.908Z] ++ GUESTFISH_PID=12411
19:34:20 [2025-01-23T19:34:20.908Z] ++ export GUESTFISH_PID
19:34:20 [2025-01-23T19:34:20.908Z] + '[' -z 12411 ']'
19:34:20 [2025-01-23T19:34:20.908Z] ++ kola ncpu
19:34:20 [2025-01-23T19:34:20.908Z] + coreos_gf set-smp 6
19:34:20 [2025-01-23T19:34:20.908Z] + guestfish --remote -- set-smp 6
19:34:20 [2025-01-23T19:34:20.908Z] + coreos_gf run
19:34:20 [2025-01-23T19:34:20.908Z] + guestfish --remote -- run
19:34:22 [2025-01-23T19:34:22.782Z] + GUESTFISH_RUNNING=1
19:34:22 [2025-01-23T19:34:22.782Z] ++ coreos_gf findfs-label root
19:34:22 [2025-01-23T19:34:22.782Z] ++ guestfish --remote -- findfs-label root
19:34:22 [2025-01-23T19:34:22.782Z] + root=/dev/sda4
19:34:22 [2025-01-23T19:34:22.782Z] + coreos_gf mount /dev/sda4 /
19:34:22 [2025-01-23T19:34:22.782Z] + guestfish --remote -- mount /dev/sda4 /
19:34:23 [2025-01-23T19:34:23.338Z] + local boot
19:34:23 [2025-01-23T19:34:23.338Z] ++ coreos_gf findfs-label boot
19:34:23 [2025-01-23T19:34:23.338Z] ++ guestfish --remote -- findfs-label boot
19:34:23 [2025-01-23T19:34:23.338Z] + boot=/dev/sda3
19:34:23 [2025-01-23T19:34:23.338Z] + coreos_gf mount /dev/sda3 /boot
19:34:23 [2025-01-23T19:34:23.338Z] + guestfish --remote -- mount /dev/sda3 /boot
19:34:23 [2025-01-23T19:34:23.338Z] + local partitions
19:34:23 [2025-01-23T19:34:23.338Z] + local label
19:34:23 [2025-01-23T19:34:23.338Z] ++ coreos_gf list-partitions
19:34:23 [2025-01-23T19:34:23.338Z] ++ guestfish --remote -- list-partitions
19:34:23 [2025-01-23T19:34:23.338Z] + partitions='/dev/sda1
19:34:23 [2025-01-23T19:34:23.338Z] /dev/sda2
19:34:23 [2025-01-23T19:34:23.338Z] /dev/sda3
19:34:23 [2025-01-23T19:34:23.338Z] /dev/sda4'
19:34:23 [2025-01-23T19:34:23.338Z] + for pt in $partitions
19:34:23 [2025-01-23T19:34:23.338Z] ++ coreos_gf vfs-label /dev/sda1
19:34:23 [2025-01-23T19:34:23.338Z] ++ guestfish --remote -- vfs-label /dev/sda1
19:34:23 [2025-01-23T19:34:23.338Z] + label=
19:34:23 [2025-01-23T19:34:23.338Z] + '[' '' == EFI-SYSTEM ']'
19:34:23 [2025-01-23T19:34:23.338Z] + for pt in $partitions
19:34:23 [2025-01-23T19:34:23.338Z] ++ coreos_gf vfs-label /dev/sda2
19:34:23 [2025-01-23T19:34:23.338Z] ++ guestfish --remote -- vfs-label /dev/sda2
19:34:23 [2025-01-23T19:34:23.338Z] + label=EFI-SYSTEM
19:34:23 [2025-01-23T19:34:23.338Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
19:34:23 [2025-01-23T19:34:23.338Z] + coreos_gf mount /dev/sda2 /boot/efi
19:34:23 [2025-01-23T19:34:23.338Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
19:34:23 [2025-01-23T19:34:23.338Z] + for pt in $partitions
19:34:23 [2025-01-23T19:34:23.338Z] ++ coreos_gf vfs-label /dev/sda3
19:34:23 [2025-01-23T19:34:23.338Z] ++ guestfish --remote -- vfs-label /dev/sda3
19:34:23 [2025-01-23T19:34:23.338Z] + label=boot
19:34:23 [2025-01-23T19:34:23.338Z] + '[' boot == EFI-SYSTEM ']'
19:34:23 [2025-01-23T19:34:23.338Z] + for pt in $partitions
19:34:23 [2025-01-23T19:34:23.338Z] ++ coreos_gf vfs-label /dev/sda4
19:34:23 [2025-01-23T19:34:23.338Z] ++ guestfish --remote -- vfs-label /dev/sda4
19:34:23 [2025-01-23T19:34:23.591Z] + label=root
19:34:23 [2025-01-23T19:34:23.591Z] + '[' root == EFI-SYSTEM ']'
19:34:23 [2025-01-23T19:34:23.591Z] ++ coreos_gf ls /ostree/deploy
19:34:23 [2025-01-23T19:34:23.591Z] ++ guestfish --remote -- ls /ostree/deploy
19:34:23 [2025-01-23T19:34:23.591Z] + stateroot=/ostree/deploy/fedora-coreos
19:34:23 [2025-01-23T19:34:23.591Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
19:34:23 [2025-01-23T19:34:23.591Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
19:34:23 [2025-01-23T19:34:23.591Z] ++ grep -v .origin
19:34:23 [2025-01-23T19:34:23.591Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/fecffcb5c66539cbe796c9725b1b9defae8a4f62c0a036b18209fcbcd11f5220.0
19:34:23 [2025-01-23T19:34:23.591Z] + export stateroot deploydir
19:34:23 [2025-01-23T19:34:23.591Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/config
19:34:23 [2025-01-23T19:34:23.591Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/config
19:34:23 [2025-01-23T19:34:23.591Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/config
19:34:23 [2025-01-23T19:34:23.591Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/config.new /ostree/repo/config
19:34:23 [2025-01-23T19:34:23.591Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/config.new /ostree/repo/config
19:34:23 [2025-01-23T19:34:23.591Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
19:34:23 [2025-01-23T19:34:23.591Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
19:34:23 [2025-01-23T19:34:23.591Z] + kernel_binary=/boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64
19:34:23 [2025-01-23T19:34:23.591Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
19:34:23 [2025-01-23T19:34:23.591Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
19:34:23 [2025-01-23T19:34:23.591Z] + kernel_hmac=/boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/.vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64.hmac
19:34:23 [2025-01-23T19:34:23.591Z] ++ basename /boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/.vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64.hmac
19:34:23 [2025-01-23T19:34:23.591Z] + coreos_gf ln /boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/.vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64.hmac /boot/.vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64.hmac
19:34:23 [2025-01-23T19:34:23.591Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/.vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64.hmac /boot/.vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64.hmac
19:34:23 [2025-01-23T19:34:23.591Z] ++ basename /boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64
19:34:23 [2025-01-23T19:34:23.591Z] + coreos_gf ln /boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64 /boot/vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64
19:34:23 [2025-01-23T19:34:23.591Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-73f9694929e350e6d9f407a67b2fd51b06875b6281cf53ca0093adb10b5053c8/vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64 /boot/vmlinuz-6.13.0-0.rc7.20250114gitc45323b7560e.56.fc42.x86_64
19:34:23 [2025-01-23T19:34:23.591Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/image.squashfs compress:lz4
19:34:23 [2025-01-23T19:34:23.591Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/image.squashfs compress:lz4
19:34:31 [2025-01-23T19:34:31.646Z] + coreos_gf_shutdown
19:34:31 [2025-01-23T19:34:31.646Z] + coreos_gf umount-all
19:34:31 [2025-01-23T19:34:31.646Z] + guestfish --remote -- umount-all
19:34:31 [2025-01-23T19:34:31.646Z] + coreos_gf exit
19:34:31 [2025-01-23T19:34:31.646Z] + guestfish --remote -- exit
19:34:31 [2025-01-23T19:34:31.646Z] + GUESTFISH_RUNNING=
19:34:31 [2025-01-23T19:34:31.646Z] + GUESTFISH_PID=
19:34:31 [2025-01-23T19:34:31.646Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
19:34:31 [2025-01-23T19:34:31.646Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.pqIyzK -rf
19:34:31 [2025-01-23T19:34:31.646Z] + _coreos_gf_cleanup
19:34:31 [2025-01-23T19:34:31.646Z] + guestfish --remote -- exit
19:34:31 [2025-01-23T19:34:31.646Z] + :
19:34:36 [2025-01-23T19:34:36.868Z] 2025-01-23 19:34:36,250 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw']
19:34:36 [2025-01-23T19:34:36.868Z] + coreos_gf_run_mount builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:36 [2025-01-23T19:34:36.868Z] + local mntarg=mount
19:34:36 [2025-01-23T19:34:36.868Z] + '[' builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw = ro ']'
19:34:36 [2025-01-23T19:34:36.868Z] + coreos_gf_run builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:36 [2025-01-23T19:34:36.868Z] + '[' -n '' ']'
19:34:36 [2025-01-23T19:34:36.868Z] + coreos_gf_launch builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:36 [2025-01-23T19:34:36.868Z] + '[' -n '' ']'
19:34:36 [2025-01-23T19:34:36.868Z] ++ guestfish --listen -a builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw --ro
19:34:36 [2025-01-23T19:34:36.868Z] + eval 'GUESTFISH_PID=12552; export GUESTFISH_PID'
19:34:36 [2025-01-23T19:34:36.868Z] ++ GUESTFISH_PID=12552
19:34:36 [2025-01-23T19:34:36.868Z] ++ export GUESTFISH_PID
19:34:36 [2025-01-23T19:34:36.868Z] + '[' -z 12552 ']'
19:34:36 [2025-01-23T19:34:36.868Z] ++ kola ncpu
19:34:36 [2025-01-23T19:34:36.868Z] + coreos_gf set-smp 6
19:34:36 [2025-01-23T19:34:36.868Z] + guestfish --remote -- set-smp 6
19:34:36 [2025-01-23T19:34:36.868Z] + coreos_gf run
19:34:36 [2025-01-23T19:34:36.868Z] + guestfish --remote -- run
19:34:38 [2025-01-23T19:34:38.223Z] + GUESTFISH_RUNNING=1
19:34:38 [2025-01-23T19:34:38.223Z] ++ coreos_gf findfs-label root
19:34:38 [2025-01-23T19:34:38.223Z] ++ guestfish --remote -- findfs-label root
19:34:38 [2025-01-23T19:34:38.223Z] + root=/dev/sda4
19:34:38 [2025-01-23T19:34:38.223Z] + coreos_gf mount /dev/sda4 /
19:34:38 [2025-01-23T19:34:38.223Z] + guestfish --remote -- mount /dev/sda4 /
19:34:38 [2025-01-23T19:34:38.780Z] + local boot
19:34:38 [2025-01-23T19:34:38.780Z] ++ coreos_gf findfs-label boot
19:34:38 [2025-01-23T19:34:38.780Z] ++ guestfish --remote -- findfs-label boot
19:34:38 [2025-01-23T19:34:38.780Z] + boot=/dev/sda3
19:34:38 [2025-01-23T19:34:38.780Z] + coreos_gf mount /dev/sda3 /boot
19:34:38 [2025-01-23T19:34:38.780Z] + guestfish --remote -- mount /dev/sda3 /boot
19:34:38 [2025-01-23T19:34:38.780Z] + local partitions
19:34:38 [2025-01-23T19:34:38.780Z] + local label
19:34:38 [2025-01-23T19:34:38.780Z] ++ coreos_gf list-partitions
19:34:38 [2025-01-23T19:34:38.780Z] ++ guestfish --remote -- list-partitions
19:34:39 [2025-01-23T19:34:39.033Z] + partitions='/dev/sda1
19:34:39 [2025-01-23T19:34:39.033Z] /dev/sda2
19:34:39 [2025-01-23T19:34:39.033Z] /dev/sda3
19:34:39 [2025-01-23T19:34:39.033Z] /dev/sda4'
19:34:39 [2025-01-23T19:34:39.033Z] + for pt in $partitions
19:34:39 [2025-01-23T19:34:39.033Z] ++ coreos_gf vfs-label /dev/sda1
19:34:39 [2025-01-23T19:34:39.033Z] ++ guestfish --remote -- vfs-label /dev/sda1
19:34:39 [2025-01-23T19:34:39.033Z] + label=
19:34:39 [2025-01-23T19:34:39.033Z] + '[' '' == EFI-SYSTEM ']'
19:34:39 [2025-01-23T19:34:39.033Z] + for pt in $partitions
19:34:39 [2025-01-23T19:34:39.033Z] ++ coreos_gf vfs-label /dev/sda2
19:34:39 [2025-01-23T19:34:39.033Z] ++ guestfish --remote -- vfs-label /dev/sda2
19:34:39 [2025-01-23T19:34:39.033Z] + label=EFI-SYSTEM
19:34:39 [2025-01-23T19:34:39.033Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
19:34:39 [2025-01-23T19:34:39.033Z] + coreos_gf mount /dev/sda2 /boot/efi
19:34:39 [2025-01-23T19:34:39.033Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
19:34:39 [2025-01-23T19:34:39.033Z] + for pt in $partitions
19:34:39 [2025-01-23T19:34:39.033Z] ++ coreos_gf vfs-label /dev/sda3
19:34:39 [2025-01-23T19:34:39.033Z] ++ guestfish --remote -- vfs-label /dev/sda3
19:34:39 [2025-01-23T19:34:39.033Z] + label=boot
19:34:39 [2025-01-23T19:34:39.033Z] + '[' boot == EFI-SYSTEM ']'
19:34:39 [2025-01-23T19:34:39.033Z] + for pt in $partitions
19:34:39 [2025-01-23T19:34:39.033Z] ++ coreos_gf vfs-label /dev/sda4
19:34:39 [2025-01-23T19:34:39.033Z] ++ guestfish --remote -- vfs-label /dev/sda4
19:34:39 [2025-01-23T19:34:39.033Z] + label=root
19:34:39 [2025-01-23T19:34:39.033Z] + '[' root == EFI-SYSTEM ']'
19:34:39 [2025-01-23T19:34:39.033Z] ++ coreos_gf ls /ostree/deploy
19:34:39 [2025-01-23T19:34:39.033Z] ++ guestfish --remote -- ls /ostree/deploy
19:34:39 [2025-01-23T19:34:39.033Z] + stateroot=/ostree/deploy/fedora-coreos
19:34:39 [2025-01-23T19:34:39.033Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
19:34:39 [2025-01-23T19:34:39.033Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
19:34:39 [2025-01-23T19:34:39.033Z] ++ grep -v .origin
19:34:39 [2025-01-23T19:34:39.033Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/fecffcb5c66539cbe796c9725b1b9defae8a4f62c0a036b18209fcbcd11f5220.0
19:34:39 [2025-01-23T19:34:39.033Z] + export stateroot deploydir
19:34:39 [2025-01-23T19:34:39.033Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
19:34:39 [2025-01-23T19:34:39.033Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
19:34:39 [2025-01-23T19:34:39.033Z] + sed -e '/^options/!d' -e 's/^options\s*//'
19:34:39 [2025-01-23T19:34:39.287Z] + coreos_gf_shutdown
19:34:39 [2025-01-23T19:34:39.287Z] + coreos_gf umount-all
19:34:39 [2025-01-23T19:34:39.287Z] + guestfish --remote -- umount-all
19:34:39 [2025-01-23T19:34:39.287Z] + coreos_gf exit
19:34:39 [2025-01-23T19:34:39.287Z] + guestfish --remote -- exit
19:34:39 [2025-01-23T19:34:39.287Z] + GUESTFISH_RUNNING=
19:34:39 [2025-01-23T19:34:39.287Z] + GUESTFISH_PID=
19:34:39 [2025-01-23T19:34:39.287Z] + _coreos_gf_cleanup
19:34:39 [2025-01-23T19:34:39.287Z] + guestfish --remote -- exit
19:34:39 [2025-01-23T19:34:39.287Z] + :
19:34:39 [2025-01-23T19:34:39.287Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20250123.dev.0
19:34:39 [2025-01-23T19:34:39.541Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
19:34:39 [2025-01-23T19:34:39.541Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
19:34:39 [2025-01-23T19:34:39.541Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
19:34:39 [2025-01-23T19:34:39.541Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
19:34:39 [2025-01-23T19:34:39.541Z] 2025-01-23 19:34:39,444 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '4a4634ca3bc07fdbbb2423ebe4a100e5689106bc58ceb56eec578a6335a1dfe4', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
19:34:40 [2025-01-23T19:34:40.459Z] 2025-01-23 19:34:40,348 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpq7rk1_zv.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
19:34:42 [2025-01-23T19:34:42.332Z] 2025-01-23 19:34:42,187 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250123.dev.0', '-volset', 'fedora-coreos-42.20250123.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.20250123.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
19:34:42 [2025-01-23T19:34:42.332Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
19:34:42 [2025-01-23T19:34:42.332Z] genisoimage 1.1.11 (Linux)
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
19:34:42 [2025-01-23T19:34:42.332Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Initial Padblock Start Block 0
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Initial Padblock Block(s) 16
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Primary Volume Descriptor Start Block 16
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Primary Volume Descriptor Block(s) 1
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Eltorito Volume Descriptor Start Block 17
19:34:42 [2025-01-23T19:34:42.332Z] Size of boot image is 4 sectors -> No emulation
19:34:42 [2025-01-23T19:34:42.332Z] Size of boot image is 13104 sectors -> No emulation
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Eltorito Volume Descriptor Block(s) 1
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Joliet Volume Descriptor Start Block 18
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Joliet Volume Descriptor Block(s) 1
19:34:42 [2025-01-23T19:34:42.332Z] Writing: End Volume Descriptor Start Block 19
19:34:42 [2025-01-23T19:34:42.332Z] Done with: End Volume Descriptor Block(s) 1
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Version block Start Block 20
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Version block Block(s) 1
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Path table Start Block 21
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Path table Block(s) 4
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Joliet path table Start Block 25
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Joliet path table Block(s) 4
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Directory tree Start Block 29
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Directory tree Block(s) 7
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Joliet directory tree Start Block 36
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Joliet directory tree Block(s) 7
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Directory tree cleanup Start Block 43
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Directory tree cleanup Block(s) 0
19:34:42 [2025-01-23T19:34:42.332Z] Writing: Extension record Start Block 43
19:34:42 [2025-01-23T19:34:42.332Z] Done with: Extension record Block(s) 1
19:34:42 [2025-01-23T19:34:42.332Z] Writing: The File(s) Start Block 44
19:34:42 [2025-01-23T19:34:42.332Z] 0.93% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 1.85% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 2.78% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 3.70% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 4.63% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 5.55% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 6.48% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 7.40% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 8.33% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 9.25% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 10.18% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 11.10% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 12.03% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 12.95% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 13.88% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.332Z] 14.81% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 15.73% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 16.66% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 17.58% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 18.51% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 19.43% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 20.36% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 21.28% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 22.21% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 23.13% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 24.06% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 24.98% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 25.91% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 26.83% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 27.76% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 28.68% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 29.61% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 30.53% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 31.46% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 32.38% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 33.31% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 34.23% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 35.16% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 36.08% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 37.01% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 37.93% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 38.86% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 39.78% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 40.71% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 41.63% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 42.56% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.631Z] 43.49% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 44.41% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 45.34% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 46.26% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 47.19% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 48.11% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 49.04% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 49.96% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 50.89% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 51.81% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 52.74% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 53.66% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 54.59% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 55.51% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 56.44% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 57.37% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 58.29% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 59.22% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 60.14% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 61.07% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 61.99% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 62.92% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 63.84% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 64.77% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:42 [2025-01-23T19:34:42.885Z] 65.69% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 66.62% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 67.54% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 68.47% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 69.39% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 70.32% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 71.24% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 72.17% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 73.09% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 74.02% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 74.94% done, estimate finish Thu Jan 23 19:34:42 2025
19:34:43 [2025-01-23T19:34:43.138Z] 75.87% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 76.79% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 77.72% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 78.64% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 79.57% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 80.49% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 81.42% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 82.34% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 83.27% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 84.20% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 85.12% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 86.05% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.138Z] 86.97% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 87.90% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 88.82% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 89.75% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 90.67% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 91.60% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 92.52% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 93.45% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 94.37% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 95.30% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 96.22% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 97.15% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 98.07% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 99.00% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] 99.93% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.391Z] Total translation table size: 2048
19:34:43 [2025-01-23T19:34:43.391Z] Total rockridge attributes bytes: 3006
19:34:43 [2025-01-23T19:34:43.391Z] Total directory bytes: 12288
19:34:43 [2025-01-23T19:34:43.391Z] Path table size(bytes): 96
19:34:43 [2025-01-23T19:34:43.391Z] Done with: The File(s) Block(s) 540217
19:34:43 [2025-01-23T19:34:43.391Z] Writing: Ending Padblock Start Block 540261
19:34:43 [2025-01-23T19:34:43.391Z] Done with: Ending Padblock Block(s) 150
19:34:43 [2025-01-23T19:34:43.391Z] Max brk space used 1c000
19:34:43 [2025-01-23T19:34:43.391Z] 540411 extents written (1055 MB)
19:34:43 [2025-01-23T19:34:43.391Z] 2025-01-23 19:34:43,284 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250123.dev.0-live.x86_64.iso']
19:34:43 [2025-01-23T19:34:43.391Z] isohybrid: Warning: more than 1024 cylinders: 1056
19:34:43 [2025-01-23T19:34:43.391Z] isohybrid: Not all BIOSes will be able to boot this device
19:34:43 [2025-01-23T19:34:43.947Z] 2025-01-23 19:34:43,703 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250123.dev.0', '-volset', 'fedora-coreos-42.20250123.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.20250123.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
19:34:43 [2025-01-23T19:34:43.947Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
19:34:43 [2025-01-23T19:34:43.947Z] genisoimage 1.1.11 (Linux)
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
19:34:43 [2025-01-23T19:34:43.947Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Initial Padblock Start Block 0
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Initial Padblock Block(s) 16
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Primary Volume Descriptor Start Block 16
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Primary Volume Descriptor Block(s) 1
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Eltorito Volume Descriptor Start Block 17
19:34:43 [2025-01-23T19:34:43.947Z] Size of boot image is 4 sectors -> No emulation
19:34:43 [2025-01-23T19:34:43.947Z] Size of boot image is 13104 sectors -> No emulation
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Eltorito Volume Descriptor Block(s) 1
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Joliet Volume Descriptor Start Block 18
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Joliet Volume Descriptor Block(s) 1
19:34:43 [2025-01-23T19:34:43.947Z] Writing: End Volume Descriptor Start Block 19
19:34:43 [2025-01-23T19:34:43.947Z] Done with: End Volume Descriptor Block(s) 1
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Version block Start Block 20
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Version block Block(s) 1
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Path table Start Block 21
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Path table Block(s) 4
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Joliet path table Start Block 25
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Joliet path table Block(s) 4
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Directory tree Start Block 29
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Directory tree Block(s) 7
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Joliet directory tree Start Block 36
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Joliet directory tree Block(s) 7
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Directory tree cleanup Start Block 43
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Directory tree cleanup Block(s) 0
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Extension record Start Block 43
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Extension record Block(s) 1
19:34:43 [2025-01-23T19:34:43.947Z] Writing: The File(s) Start Block 44
19:34:43 [2025-01-23T19:34:43.947Z] 8.52% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 17.01% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 25.52% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 34.01% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 42.53% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 51.02% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 59.53% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 68.02% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 76.54% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 85.03% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] 93.54% done, estimate finish Thu Jan 23 19:34:43 2025
19:34:43 [2025-01-23T19:34:43.947Z] Total translation table size: 2048
19:34:43 [2025-01-23T19:34:43.947Z] Total rockridge attributes bytes: 2842
19:34:43 [2025-01-23T19:34:43.947Z] Total directory bytes: 12288
19:34:43 [2025-01-23T19:34:43.947Z] Path table size(bytes): 96
19:34:43 [2025-01-23T19:34:43.947Z] Done with: The File(s) Block(s) 58611
19:34:43 [2025-01-23T19:34:43.947Z] Writing: Ending Padblock Start Block 58655
19:34:43 [2025-01-23T19:34:43.947Z] Done with: Ending Padblock Block(s) 150
19:34:43 [2025-01-23T19:34:43.947Z] Max brk space used 1b000
19:34:43 [2025-01-23T19:34:43.947Z] 58805 extents written (114 MB)
19:34:43 [2025-01-23T19:34:43.947Z] 2025-01-23 19:34:43,809 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250123.dev.0-live.x86_64.iso.minimal']
19:34:43 [2025-01-23T19:34:43.947Z] 2025-01-23 19:34:43,852 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250123.dev.0/x86_64/fedora-coreos-42.20250123.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250123.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250123.dev.0-live.x86_64.iso.minimal', '--consume']
19:35:01 [2025-01-23T19:35:01.957Z] + RUST_BACKTRACE=full
19:35:01 [2025-01-23T19:35:01.957Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/fecffcb5c66539cbe796c9725b1b9defae8a4f62c0a036b18209fcbcd11f5220.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.20250123.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250123.dev.0-live.x86_64.iso.minimal --consume
19:35:01 [2025-01-23T19:35:01.957Z] Packing minimal ISO
19:35:01 [2025-01-23T19:35:01.957Z] Matched 17 files of 17
19:35:01 [2025-01-23T19:35:01.957Z] Total bytes skipped: 120014239
19:35:01 [2025-01-23T19:35:01.957Z] Total bytes written: 572001
19:35:01 [2025-01-23T19:35:01.957Z] Total bytes written (compressed): 2808
19:35:01 [2025-01-23T19:35:01.957Z] Verifying that packed image matches digest
19:35:01 [2025-01-23T19:35:01.957Z] Packing successful!
19:35:01 [2025-01-23T19:35:01.957Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:35:05 [2025-01-23T19:35:05.207Z] Updated: builds/42.20250123.dev.0/x86_64/meta.json