Console Output

20:48:28 [2025-01-30T20:48:28.057Z] + set -xeuo pipefail
20:48:28 [2025-01-30T20:48:28.057Z] ++ umask
20:48:28 [2025-01-30T20:48:28.057Z] + '[' 0022 = 0000 ']'
20:48:28 [2025-01-30T20:48:28.057Z] + cosa buildextend-live --fast
20:48:28 [2025-01-30T20:48:28.310Z] Targeting build: 42.20250130.dev.0
20:48:28 [2025-01-30T20:48:28.310Z] 2025-01-30 20:48:28,139 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '09188fb3be0c01e335406e8f43f4affa717b4962dfe5dc9f04ca439370771c60', '/usr/lib/modules']
20:48:28 [2025-01-30T20:48:28.310Z] 2025-01-30 20:48:28,149 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64/vmlinuz', '09188fb3be0c01e335406e8f43f4affa717b4962dfe5dc9f04ca439370771c60', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
20:48:28 [2025-01-30T20:48:28.310Z] 2025-01-30 20:48:28,196 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64/initramfs.img', '09188fb3be0c01e335406e8f43f4affa717b4962dfe5dc9f04ca439370771c60', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
20:48:28 [2025-01-30T20:48:28.563Z] 2025-01-30 20:48:28,396 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '09188fb3be0c01e335406e8f43f4affa717b4962dfe5dc9f04ca439370771c60', '/usr/share/coreos-installer/example-config.yaml']
20:48:28 [2025-01-30T20:48:28.563Z] 2025-01-30 20:48:28,412 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '09188fb3be0c01e335406e8f43f4affa717b4962dfe5dc9f04ca439370771c60', '/tmp/tmpbn72hy89']
20:48:28 [2025-01-30T20:48:28.563Z] Generating osmet file for 512b metal image
20:48:28 [2025-01-30T20:48:28.563Z] 2025-01-30 20:48:28,428 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20250130.dev.0', '--checksum', '27e40f683f0a9f67df51684ce4cb0d22279781dfe1563495b92de2e8d5e3a965', '--output', '/var/tmp/coreos-installer-output', '--fast']
20:48:46 [2025-01-30T20:48:46.566Z] + RUST_BACKTRACE=full
20:48:46 [2025-01-30T20:48:46.566Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/d57ddefc715e2b47cf3c403374e7e8b8a25a621ee74b544631d2886115246a52.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20250130.dev.0' --checksum 27e40f683f0a9f67df51684ce4cb0d22279781dfe1563495b92de2e8d5e3a965 --output /var/tmp/coreos-installer-output --fast
20:48:49 [2025-01-30T20:48:49.065Z] Total OSTree objects scanned from /root: 17843 (17837 mapped, 6 empty)
20:48:49 [2025-01-30T20:48:49.065Z] Total OSTree objects found in /boot: 313
20:48:49 [2025-01-30T20:48:49.065Z] Duplicate extents dropped: 0
20:48:49 [2025-01-30T20:48:49.065Z] Overlapping extents clamped: 0
20:48:49 [2025-01-30T20:48:49.065Z] Total /root extents: 17838
20:48:49 [2025-01-30T20:48:49.065Z] Duplicate extents dropped: 0
20:48:49 [2025-01-30T20:48:49.065Z] Overlapping extents clamped: 0
20:48:49 [2025-01-30T20:48:49.065Z] Total /boot extents: 318
20:48:49 [2025-01-30T20:48:49.065Z] Packing image
20:49:03 [2025-01-30T20:49:03.881Z] Total bytes skipped: 1660949504
20:49:03 [2025-01-30T20:49:03.881Z] Total bytes written: 1088416768
20:49:03 [2025-01-30T20:49:03.881Z] Total bytes written (compressed): 25408908
20:49:03 [2025-01-30T20:49:03.881Z] Verifying that repacked image matches digest
20:49:13 [2025-01-30T20:49:13.788Z] Packing successful!
20:49:13 [2025-01-30T20:49:13.788Z] + '[' -f /var/tmp/coreos-installer-output ']'
20:49:13 [2025-01-30T20:49:13.788Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
20:49:15 [2025-01-30T20:49:15.663Z] Generating osmet file for 4k metal image
20:49:15 [2025-01-30T20:49:15.663Z] 2025-01-30 20:49:15,537 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250130.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20250130.dev.0', '--checksum', 'c371ac06b22fd2d1586d57f9abc48f51493af68c0d11ecf5df4d4b8d370f73b5', '--output', '/var/tmp/coreos-installer-output', '--fast']
20:49:33 [2025-01-30T20:49:33.727Z] + RUST_BACKTRACE=full
20:49:33 [2025-01-30T20:49:33.727Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/d57ddefc715e2b47cf3c403374e7e8b8a25a621ee74b544631d2886115246a52.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20250130.dev.0' --checksum c371ac06b22fd2d1586d57f9abc48f51493af68c0d11ecf5df4d4b8d370f73b5 --output /var/tmp/coreos-installer-output --fast
20:49:36 [2025-01-30T20:49:36.972Z] Total OSTree objects scanned from /root: 17843 (17837 mapped, 6 empty)
20:49:36 [2025-01-30T20:49:36.972Z] Total OSTree objects found in /boot: 3
20:49:36 [2025-01-30T20:49:36.972Z] Duplicate extents dropped: 0
20:49:36 [2025-01-30T20:49:36.972Z] Overlapping extents clamped: 0
20:49:36 [2025-01-30T20:49:36.972Z] Total /root extents: 17839
20:49:36 [2025-01-30T20:49:36.972Z] Duplicate extents dropped: 0
20:49:36 [2025-01-30T20:49:36.973Z] Overlapping extents clamped: 0
20:49:36 [2025-01-30T20:49:36.973Z] Total /boot extents: 4
20:49:36 [2025-01-30T20:49:36.973Z] Packing image
20:49:51 [2025-01-30T20:49:51.788Z] Total bytes skipped: 1650102272
20:49:51 [2025-01-30T20:49:51.788Z] Total bytes written: 1099264000
20:49:51 [2025-01-30T20:49:51.788Z] Total bytes written (compressed): 25414304
20:49:51 [2025-01-30T20:49:51.788Z] Verifying that repacked image matches digest
20:49:58 [2025-01-30T20:49:58.321Z] Packing successful!
20:49:58 [2025-01-30T20:49:58.321Z] + '[' -f /var/tmp/coreos-installer-output ']'
20:49:58 [2025-01-30T20:49:58.321Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
20:49:59 [2025-01-30T20:49:59.695Z] Compressing squashfs with lz4
20:49:59 [2025-01-30T20:49:59.695Z] 2025-01-30 20:49:59,654 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
20:49:59 [2025-01-30T20:49:59.947Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
20:49:59 [2025-01-30T20:49:59.947Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
20:49:59 [2025-01-30T20:49:59.947Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt
20:49:59 [2025-01-30T20:49:59.947Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/image.squashfs
20:49:59 [2025-01-30T20:49:59.947Z] + coreos_gf_run_mount builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:49:59 [2025-01-30T20:49:59.948Z] + local mntarg=mount
20:49:59 [2025-01-30T20:49:59.948Z] + '[' builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw = ro ']'
20:49:59 [2025-01-30T20:49:59.948Z] + coreos_gf_run builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:49:59 [2025-01-30T20:49:59.948Z] + '[' -n '' ']'
20:49:59 [2025-01-30T20:49:59.948Z] + coreos_gf_launch builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:49:59 [2025-01-30T20:49:59.948Z] + '[' -n '' ']'
20:49:59 [2025-01-30T20:49:59.948Z] ++ guestfish --listen -a builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:49:59 [2025-01-30T20:49:59.948Z] + eval 'GUESTFISH_PID=11721; export GUESTFISH_PID'
20:49:59 [2025-01-30T20:49:59.948Z] ++ GUESTFISH_PID=11721
20:49:59 [2025-01-30T20:49:59.948Z] ++ export GUESTFISH_PID
20:49:59 [2025-01-30T20:49:59.948Z] + '[' -z 11721 ']'
20:49:59 [2025-01-30T20:49:59.948Z] ++ kola ncpu
20:49:59 [2025-01-30T20:49:59.948Z] + coreos_gf set-smp 6
20:49:59 [2025-01-30T20:49:59.948Z] + guestfish --remote -- set-smp 6
20:49:59 [2025-01-30T20:49:59.948Z] + coreos_gf run
20:49:59 [2025-01-30T20:49:59.948Z] + guestfish --remote -- run
20:50:01 [2025-01-30T20:50:01.824Z] + GUESTFISH_RUNNING=1
20:50:01 [2025-01-30T20:50:01.824Z] ++ coreos_gf findfs-label root
20:50:01 [2025-01-30T20:50:01.824Z] ++ guestfish --remote -- findfs-label root
20:50:01 [2025-01-30T20:50:01.824Z] + root=/dev/sda4
20:50:01 [2025-01-30T20:50:01.824Z] + coreos_gf mount /dev/sda4 /
20:50:01 [2025-01-30T20:50:01.824Z] + guestfish --remote -- mount /dev/sda4 /
20:50:02 [2025-01-30T20:50:02.381Z] + local boot
20:50:02 [2025-01-30T20:50:02.381Z] ++ coreos_gf findfs-label boot
20:50:02 [2025-01-30T20:50:02.381Z] ++ guestfish --remote -- findfs-label boot
20:50:02 [2025-01-30T20:50:02.381Z] + boot=/dev/sda3
20:50:02 [2025-01-30T20:50:02.381Z] + coreos_gf mount /dev/sda3 /boot
20:50:02 [2025-01-30T20:50:02.381Z] + guestfish --remote -- mount /dev/sda3 /boot
20:50:02 [2025-01-30T20:50:02.381Z] + local partitions
20:50:02 [2025-01-30T20:50:02.381Z] + local label
20:50:02 [2025-01-30T20:50:02.381Z] ++ coreos_gf list-partitions
20:50:02 [2025-01-30T20:50:02.381Z] ++ guestfish --remote -- list-partitions
20:50:02 [2025-01-30T20:50:02.635Z] + partitions='/dev/sda1
20:50:02 [2025-01-30T20:50:02.635Z] /dev/sda2
20:50:02 [2025-01-30T20:50:02.635Z] /dev/sda3
20:50:02 [2025-01-30T20:50:02.635Z] /dev/sda4'
20:50:02 [2025-01-30T20:50:02.635Z] + for pt in $partitions
20:50:02 [2025-01-30T20:50:02.635Z] ++ coreos_gf vfs-label /dev/sda1
20:50:02 [2025-01-30T20:50:02.635Z] ++ guestfish --remote -- vfs-label /dev/sda1
20:50:02 [2025-01-30T20:50:02.635Z] + label=
20:50:02 [2025-01-30T20:50:02.635Z] + '[' '' == EFI-SYSTEM ']'
20:50:02 [2025-01-30T20:50:02.635Z] + for pt in $partitions
20:50:02 [2025-01-30T20:50:02.635Z] ++ coreos_gf vfs-label /dev/sda2
20:50:02 [2025-01-30T20:50:02.635Z] ++ guestfish --remote -- vfs-label /dev/sda2
20:50:02 [2025-01-30T20:50:02.635Z] + label=EFI-SYSTEM
20:50:02 [2025-01-30T20:50:02.635Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
20:50:02 [2025-01-30T20:50:02.635Z] + coreos_gf mount /dev/sda2 /boot/efi
20:50:02 [2025-01-30T20:50:02.635Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
20:50:02 [2025-01-30T20:50:02.635Z] + for pt in $partitions
20:50:02 [2025-01-30T20:50:02.635Z] ++ coreos_gf vfs-label /dev/sda3
20:50:02 [2025-01-30T20:50:02.635Z] ++ guestfish --remote -- vfs-label /dev/sda3
20:50:02 [2025-01-30T20:50:02.635Z] + label=boot
20:50:02 [2025-01-30T20:50:02.635Z] + '[' boot == EFI-SYSTEM ']'
20:50:02 [2025-01-30T20:50:02.635Z] + for pt in $partitions
20:50:02 [2025-01-30T20:50:02.635Z] ++ coreos_gf vfs-label /dev/sda4
20:50:02 [2025-01-30T20:50:02.635Z] ++ guestfish --remote -- vfs-label /dev/sda4
20:50:02 [2025-01-30T20:50:02.890Z] + label=root
20:50:02 [2025-01-30T20:50:02.890Z] + '[' root == EFI-SYSTEM ']'
20:50:02 [2025-01-30T20:50:02.890Z] ++ coreos_gf ls /ostree/deploy
20:50:02 [2025-01-30T20:50:02.890Z] ++ guestfish --remote -- ls /ostree/deploy
20:50:02 [2025-01-30T20:50:02.890Z] + stateroot=/ostree/deploy/fedora-coreos
20:50:02 [2025-01-30T20:50:02.890Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
20:50:02 [2025-01-30T20:50:02.890Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
20:50:02 [2025-01-30T20:50:02.890Z] ++ grep -v .origin
20:50:02 [2025-01-30T20:50:02.890Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/d57ddefc715e2b47cf3c403374e7e8b8a25a621ee74b544631d2886115246a52.0
20:50:02 [2025-01-30T20:50:02.890Z] + export stateroot deploydir
20:50:02 [2025-01-30T20:50:02.890Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/config
20:50:02 [2025-01-30T20:50:02.890Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/config
20:50:02 [2025-01-30T20:50:02.890Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/config
20:50:02 [2025-01-30T20:50:02.890Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/config.new /ostree/repo/config
20:50:02 [2025-01-30T20:50:02.890Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/config.new /ostree/repo/config
20:50:02 [2025-01-30T20:50:02.890Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
20:50:02 [2025-01-30T20:50:02.890Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
20:50:02 [2025-01-30T20:50:02.890Z] + kernel_binary=/boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64
20:50:02 [2025-01-30T20:50:02.890Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
20:50:02 [2025-01-30T20:50:02.890Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
20:50:02 [2025-01-30T20:50:02.890Z] + kernel_hmac=/boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/.vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64.hmac
20:50:02 [2025-01-30T20:50:02.890Z] ++ basename /boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/.vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64.hmac
20:50:02 [2025-01-30T20:50:02.890Z] + coreos_gf ln /boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/.vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64.hmac
20:50:02 [2025-01-30T20:50:02.891Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/.vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64.hmac
20:50:02 [2025-01-30T20:50:02.891Z] ++ basename /boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64
20:50:02 [2025-01-30T20:50:02.891Z] + coreos_gf ln /boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64 /boot/vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64
20:50:02 [2025-01-30T20:50:02.891Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-7d821b7f9002fb0874613566b55ba94167647a26ac5855b111af8c4c51288838/vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64 /boot/vmlinuz-6.14.0-0.rc0.20250129git05dbaf8dd8bf.10.fc42.x86_64
20:50:02 [2025-01-30T20:50:02.891Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/image.squashfs compress:lz4
20:50:02 [2025-01-30T20:50:02.891Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/image.squashfs compress:lz4
20:50:10 [2025-01-30T20:50:10.951Z] + coreos_gf_shutdown
20:50:10 [2025-01-30T20:50:10.952Z] + coreos_gf umount-all
20:50:10 [2025-01-30T20:50:10.952Z] + guestfish --remote -- umount-all
20:50:11 [2025-01-30T20:50:11.204Z] + coreos_gf exit
20:50:11 [2025-01-30T20:50:11.204Z] + guestfish --remote -- exit
20:50:11 [2025-01-30T20:50:11.760Z] + GUESTFISH_RUNNING=
20:50:11 [2025-01-30T20:50:11.760Z] + GUESTFISH_PID=
20:50:11 [2025-01-30T20:50:11.760Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
20:50:11 [2025-01-30T20:50:11.760Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.VbNYlt -rf
20:50:11 [2025-01-30T20:50:11.760Z] + _coreos_gf_cleanup
20:50:11 [2025-01-30T20:50:11.760Z] + guestfish --remote -- exit
20:50:11 [2025-01-30T20:50:11.760Z] + :
20:50:17 [2025-01-30T20:50:17.010Z] 2025-01-30 20:50:16,326 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw']
20:50:17 [2025-01-30T20:50:17.010Z] + coreos_gf_run_mount builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:50:17 [2025-01-30T20:50:17.010Z] + local mntarg=mount
20:50:17 [2025-01-30T20:50:17.010Z] + '[' builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw = ro ']'
20:50:17 [2025-01-30T20:50:17.010Z] + coreos_gf_run builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:50:17 [2025-01-30T20:50:17.010Z] + '[' -n '' ']'
20:50:17 [2025-01-30T20:50:17.010Z] + coreos_gf_launch builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:50:17 [2025-01-30T20:50:17.010Z] + '[' -n '' ']'
20:50:17 [2025-01-30T20:50:17.010Z] ++ guestfish --listen -a builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw --ro
20:50:17 [2025-01-30T20:50:17.010Z] + eval 'GUESTFISH_PID=11861; export GUESTFISH_PID'
20:50:17 [2025-01-30T20:50:17.010Z] ++ GUESTFISH_PID=11861
20:50:17 [2025-01-30T20:50:17.010Z] ++ export GUESTFISH_PID
20:50:17 [2025-01-30T20:50:17.010Z] + '[' -z 11861 ']'
20:50:17 [2025-01-30T20:50:17.010Z] ++ kola ncpu
20:50:17 [2025-01-30T20:50:17.010Z] + coreos_gf set-smp 6
20:50:17 [2025-01-30T20:50:17.010Z] + guestfish --remote -- set-smp 6
20:50:17 [2025-01-30T20:50:17.010Z] + coreos_gf run
20:50:17 [2025-01-30T20:50:17.010Z] + guestfish --remote -- run
20:50:18 [2025-01-30T20:50:18.364Z] + GUESTFISH_RUNNING=1
20:50:18 [2025-01-30T20:50:18.364Z] ++ coreos_gf findfs-label root
20:50:18 [2025-01-30T20:50:18.364Z] ++ guestfish --remote -- findfs-label root
20:50:18 [2025-01-30T20:50:18.364Z] + root=/dev/sda4
20:50:18 [2025-01-30T20:50:18.364Z] + coreos_gf mount /dev/sda4 /
20:50:18 [2025-01-30T20:50:18.364Z] + guestfish --remote -- mount /dev/sda4 /
20:50:19 [2025-01-30T20:50:19.285Z] + local boot
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf findfs-label boot
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- findfs-label boot
20:50:19 [2025-01-30T20:50:19.286Z] + boot=/dev/sda3
20:50:19 [2025-01-30T20:50:19.286Z] + coreos_gf mount /dev/sda3 /boot
20:50:19 [2025-01-30T20:50:19.286Z] + guestfish --remote -- mount /dev/sda3 /boot
20:50:19 [2025-01-30T20:50:19.286Z] + local partitions
20:50:19 [2025-01-30T20:50:19.286Z] + local label
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf list-partitions
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- list-partitions
20:50:19 [2025-01-30T20:50:19.286Z] + partitions='/dev/sda1
20:50:19 [2025-01-30T20:50:19.286Z] /dev/sda2
20:50:19 [2025-01-30T20:50:19.286Z] /dev/sda3
20:50:19 [2025-01-30T20:50:19.286Z] /dev/sda4'
20:50:19 [2025-01-30T20:50:19.286Z] + for pt in $partitions
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf vfs-label /dev/sda1
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- vfs-label /dev/sda1
20:50:19 [2025-01-30T20:50:19.286Z] + label=
20:50:19 [2025-01-30T20:50:19.286Z] + '[' '' == EFI-SYSTEM ']'
20:50:19 [2025-01-30T20:50:19.286Z] + for pt in $partitions
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf vfs-label /dev/sda2
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- vfs-label /dev/sda2
20:50:19 [2025-01-30T20:50:19.286Z] + label=EFI-SYSTEM
20:50:19 [2025-01-30T20:50:19.286Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
20:50:19 [2025-01-30T20:50:19.286Z] + coreos_gf mount /dev/sda2 /boot/efi
20:50:19 [2025-01-30T20:50:19.286Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
20:50:19 [2025-01-30T20:50:19.286Z] + for pt in $partitions
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf vfs-label /dev/sda3
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- vfs-label /dev/sda3
20:50:19 [2025-01-30T20:50:19.286Z] + label=boot
20:50:19 [2025-01-30T20:50:19.286Z] + '[' boot == EFI-SYSTEM ']'
20:50:19 [2025-01-30T20:50:19.286Z] + for pt in $partitions
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf vfs-label /dev/sda4
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- vfs-label /dev/sda4
20:50:19 [2025-01-30T20:50:19.286Z] + label=root
20:50:19 [2025-01-30T20:50:19.286Z] + '[' root == EFI-SYSTEM ']'
20:50:19 [2025-01-30T20:50:19.286Z] ++ coreos_gf ls /ostree/deploy
20:50:19 [2025-01-30T20:50:19.286Z] ++ guestfish --remote -- ls /ostree/deploy
20:50:19 [2025-01-30T20:50:19.548Z] + stateroot=/ostree/deploy/fedora-coreos
20:50:19 [2025-01-30T20:50:19.548Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
20:50:19 [2025-01-30T20:50:19.548Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
20:50:19 [2025-01-30T20:50:19.548Z] ++ grep -v .origin
20:50:19 [2025-01-30T20:50:19.548Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/d57ddefc715e2b47cf3c403374e7e8b8a25a621ee74b544631d2886115246a52.0
20:50:19 [2025-01-30T20:50:19.548Z] + export stateroot deploydir
20:50:19 [2025-01-30T20:50:19.548Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
20:50:19 [2025-01-30T20:50:19.548Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
20:50:19 [2025-01-30T20:50:19.548Z] + sed -e '/^options/!d' -e 's/^options\s*//'
20:50:19 [2025-01-30T20:50:19.548Z] + coreos_gf_shutdown
20:50:19 [2025-01-30T20:50:19.548Z] + coreos_gf umount-all
20:50:19 [2025-01-30T20:50:19.548Z] + guestfish --remote -- umount-all
20:50:19 [2025-01-30T20:50:19.548Z] + coreos_gf exit
20:50:19 [2025-01-30T20:50:19.548Z] + guestfish --remote -- exit
20:50:19 [2025-01-30T20:50:19.801Z] + GUESTFISH_RUNNING=
20:50:19 [2025-01-30T20:50:19.801Z] + GUESTFISH_PID=
20:50:19 [2025-01-30T20:50:19.801Z] + _coreos_gf_cleanup
20:50:19 [2025-01-30T20:50:19.801Z] + guestfish --remote -- exit
20:50:19 [2025-01-30T20:50:19.801Z] + :
20:50:19 [2025-01-30T20:50:19.801Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20250130.dev.0
20:50:19 [2025-01-30T20:50:19.801Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
20:50:19 [2025-01-30T20:50:19.801Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
20:50:19 [2025-01-30T20:50:19.801Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
20:50:19 [2025-01-30T20:50:19.801Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
20:50:19 [2025-01-30T20:50:19.801Z] 2025-01-30 20:50:19,789 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '09188fb3be0c01e335406e8f43f4affa717b4962dfe5dc9f04ca439370771c60', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
20:50:20 [2025-01-30T20:50:20.719Z] 2025-01-30 20:50:20,621 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpm9_z0or8.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
20:50:22 [2025-01-30T20:50:22.596Z] 2025-01-30 20:50:22,469 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250130.dev.0', '-volset', 'fedora-coreos-42.20250130.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
20:50:22 [2025-01-30T20:50:22.596Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
20:50:22 [2025-01-30T20:50:22.596Z] genisoimage 1.1.11 (Linux)
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
20:50:22 [2025-01-30T20:50:22.596Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Initial Padblock                        Start Block 0
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Initial Padblock                        Block(s)    16
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Primary Volume Descriptor               Start Block 16
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Primary Volume Descriptor               Block(s)    1
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Eltorito Volume Descriptor              Start Block 17
20:50:22 [2025-01-30T20:50:22.596Z] Size of boot image is 4 sectors -> No emulation
20:50:22 [2025-01-30T20:50:22.596Z] Size of boot image is 13104 sectors -> No emulation
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Eltorito Volume Descriptor              Block(s)    1
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Joliet Volume Descriptor                Start Block 18
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Joliet Volume Descriptor                Block(s)    1
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   End Volume Descriptor                   Start Block 19
20:50:22 [2025-01-30T20:50:22.596Z] Done with: End Volume Descriptor                   Block(s)    1
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Version block                           Start Block 20
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Version block                           Block(s)    1
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Path table                              Start Block 21
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Path table                              Block(s)    4
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Joliet path table                       Start Block 25
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Joliet path table                       Block(s)    4
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Directory tree                          Start Block 29
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Directory tree                          Block(s)    7
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Joliet directory tree                   Start Block 36
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Joliet directory tree                   Block(s)    7
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Directory tree cleanup                  Start Block 43
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Directory tree cleanup                  Block(s)    0
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   Extension record                        Start Block 43
20:50:22 [2025-01-30T20:50:22.596Z] Done with: Extension record                        Block(s)    1
20:50:22 [2025-01-30T20:50:22.596Z] Writing:   The File(s)                             Start Block 44
20:50:22 [2025-01-30T20:50:22.596Z]   0.92% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   1.83% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   2.75% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   3.66% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   4.58% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   5.49% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   6.41% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   7.32% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   8.24% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]   9.15% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]  10.07% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]  10.98% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]  11.90% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.596Z]  12.81% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  13.73% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  14.64% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  15.56% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  16.47% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  17.39% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  18.31% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  19.22% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  20.14% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  21.05% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  21.97% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  22.88% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  23.80% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  24.71% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  25.63% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  26.54% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  27.46% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  28.37% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  29.29% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  30.20% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  31.12% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  32.03% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  32.95% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  33.87% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  34.78% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:22 [2025-01-30T20:50:22.849Z]  35.70% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  36.61% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  37.53% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  38.44% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  39.36% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  40.27% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  41.19% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  42.10% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  43.02% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  43.93% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  44.85% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  45.76% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  46.68% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  47.59% done, estimate finish Thu Jan 30 20:50:22 2025
20:50:23 [2025-01-30T20:50:23.102Z]  48.51% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:23 [2025-01-30T20:50:23.102Z]  49.42% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:23 [2025-01-30T20:50:23.102Z]  50.34% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.102Z]  51.25% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.102Z]  52.17% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.102Z]  53.08% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.102Z]  54.00% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.102Z]  54.91% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.102Z]  55.83% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  56.74% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  57.66% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  58.57% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  59.49% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  60.40% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  61.32% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  62.23% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  63.15% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  64.07% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  64.98% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  65.90% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  66.81% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  67.73% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  68.64% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  69.56% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  70.47% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  71.39% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  72.30% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  73.22% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  74.13% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  75.05% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.354Z]  75.96% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  76.88% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  77.79% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  78.71% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  79.63% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  80.54% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  81.46% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  82.37% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  83.29% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  84.20% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  85.12% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.606Z]  86.03% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  86.95% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  87.86% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  88.78% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  89.69% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  90.61% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  91.52% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  92.44% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  93.35% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  94.27% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.607Z]  95.18% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.859Z]  96.10% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.859Z]  97.01% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.859Z]  97.93% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.859Z]  98.84% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.859Z]  99.76% done, estimate finish Thu Jan 30 20:50:23 2025
20:50:23 [2025-01-30T20:50:23.859Z] Total translation table size: 2048
20:50:23 [2025-01-30T20:50:23.859Z] Total rockridge attributes bytes: 3006
20:50:23 [2025-01-30T20:50:23.859Z] Total directory bytes: 12288
20:50:23 [2025-01-30T20:50:23.859Z] Path table size(bytes): 96
20:50:23 [2025-01-30T20:50:23.859Z] Done with: The File(s)                             Block(s)    546134
20:50:23 [2025-01-30T20:50:23.859Z] Writing:   Ending Padblock                         Start Block 546178
20:50:23 [2025-01-30T20:50:23.859Z] Done with: Ending Padblock                         Block(s)    150
20:50:23 [2025-01-30T20:50:23.859Z] Max brk space used 1c000
20:50:23 [2025-01-30T20:50:23.859Z] 546328 extents written (1067 MB)
20:50:23 [2025-01-30T20:50:23.859Z] 2025-01-30 20:50:23,658 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso']
20:50:23 [2025-01-30T20:50:23.859Z] isohybrid: Warning: more than 1024 cylinders: 1068
20:50:23 [2025-01-30T20:50:23.859Z] isohybrid: Not all BIOSes will be able to boot this device
20:50:24 [2025-01-30T20:50:24.414Z] 2025-01-30 20:50:24,125 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250130.dev.0', '-volset', 'fedora-coreos-42.20250130.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
20:50:24 [2025-01-30T20:50:24.414Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
20:50:24 [2025-01-30T20:50:24.414Z] genisoimage 1.1.11 (Linux)
20:50:24 [2025-01-30T20:50:24.414Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
20:50:24 [2025-01-30T20:50:24.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
20:50:24 [2025-01-30T20:50:24.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
20:50:24 [2025-01-30T20:50:24.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
20:50:24 [2025-01-30T20:50:24.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
20:50:24 [2025-01-30T20:50:24.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
20:50:24 [2025-01-30T20:50:24.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Initial Padblock                        Start Block 0
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Initial Padblock                        Block(s)    16
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Primary Volume Descriptor               Start Block 16
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Primary Volume Descriptor               Block(s)    1
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Eltorito Volume Descriptor              Start Block 17
20:50:24 [2025-01-30T20:50:24.415Z] Size of boot image is 4 sectors -> No emulation
20:50:24 [2025-01-30T20:50:24.415Z] Size of boot image is 13104 sectors -> No emulation
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Eltorito Volume Descriptor              Block(s)    1
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Joliet Volume Descriptor                Start Block 18
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Joliet Volume Descriptor                Block(s)    1
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   End Volume Descriptor                   Start Block 19
20:50:24 [2025-01-30T20:50:24.415Z] Done with: End Volume Descriptor                   Block(s)    1
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Version block                           Start Block 20
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Version block                           Block(s)    1
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Path table                              Start Block 21
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Path table                              Block(s)    4
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Joliet path table                       Start Block 25
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Joliet path table                       Block(s)    4
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Directory tree                          Start Block 29
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Directory tree                          Block(s)    7
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Joliet directory tree                   Start Block 36
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Joliet directory tree                   Block(s)    7
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Directory tree cleanup                  Start Block 43
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Directory tree cleanup                  Block(s)    0
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Extension record                        Start Block 43
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Extension record                        Block(s)    1
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   The File(s)                             Start Block 44
20:50:24 [2025-01-30T20:50:24.415Z]   8.40% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  16.77% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  25.17% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  33.55% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  41.95% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  50.32% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  58.72% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  67.09% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  75.49% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  83.87% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z]  92.26% done, estimate finish Thu Jan 30 20:50:24 2025
20:50:24 [2025-01-30T20:50:24.415Z] Total translation table size: 2048
20:50:24 [2025-01-30T20:50:24.415Z] Total rockridge attributes bytes: 2842
20:50:24 [2025-01-30T20:50:24.415Z] Total directory bytes: 12288
20:50:24 [2025-01-30T20:50:24.415Z] Path table size(bytes): 96
20:50:24 [2025-01-30T20:50:24.415Z] Done with: The File(s)                             Block(s)    59425
20:50:24 [2025-01-30T20:50:24.415Z] Writing:   Ending Padblock                         Start Block 59469
20:50:24 [2025-01-30T20:50:24.415Z] Done with: Ending Padblock                         Block(s)    150
20:50:24 [2025-01-30T20:50:24.415Z] Max brk space used 1b000
20:50:24 [2025-01-30T20:50:24.415Z] 59619 extents written (116 MB)
20:50:24 [2025-01-30T20:50:24.415Z] 2025-01-30 20:50:24,234 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal']
20:50:24 [2025-01-30T20:50:24.415Z] 2025-01-30 20:50:24,271 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250130.dev.0/x86_64/fedora-coreos-42.20250130.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal', '--consume']
20:50:42 [2025-01-30T20:50:42.436Z] + RUST_BACKTRACE=full
20:50:42 [2025-01-30T20:50:42.436Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/d57ddefc715e2b47cf3c403374e7e8b8a25a621ee74b544631d2886115246a52.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack minimal-iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250130.dev.0-live.x86_64.iso.minimal --consume
20:50:42 [2025-01-30T20:50:42.436Z] Packing minimal ISO
20:50:42 [2025-01-30T20:50:42.436Z] Matched 17 files of 17
20:50:42 [2025-01-30T20:50:42.436Z] Total bytes skipped: 121680975
20:50:42 [2025-01-30T20:50:42.436Z] Total bytes written: 1002417
20:50:42 [2025-01-30T20:50:42.436Z] Total bytes written (compressed): 2868
20:50:42 [2025-01-30T20:50:42.436Z] Verifying that packed image matches digest
20:50:42 [2025-01-30T20:50:42.436Z] Packing successful!
20:50:42 [2025-01-30T20:50:42.436Z] + '[' -f /var/tmp/coreos-installer-output ']'
20:50:46 [2025-01-30T20:50:46.102Z] Updated: builds/42.20250130.dev.0/x86_64/meta.json