Console Output

11:25:59 [2025-02-07T11:25:59.481Z] + set -xeuo pipefail
11:25:59 [2025-02-07T11:25:59.481Z] ++ umask
11:25:59 [2025-02-07T11:25:59.481Z] + '[' 0022 = 0000 ']'
11:25:59 [2025-02-07T11:25:59.481Z] + cosa buildextend-live --fast
11:25:59 [2025-02-07T11:25:59.481Z] Targeting build: 42.20250207.dev.0
11:25:59 [2025-02-07T11:25:59.735Z] 2025-02-07 11:25:59,530 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', 'bb7c038ad6279c754bb92f4f98de5b8f69dc1c1e87824ee18d5ed90613652389', '/usr/lib/modules']
11:25:59 [2025-02-07T11:25:59.735Z] 2025-02-07 11:25:59,539 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.rc1.15.fc42.x86_64/vmlinuz', 'bb7c038ad6279c754bb92f4f98de5b8f69dc1c1e87824ee18d5ed90613652389', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
11:25:59 [2025-02-07T11:25:59.735Z] 2025-02-07 11:25:59,589 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.rc1.15.fc42.x86_64/initramfs.img', 'bb7c038ad6279c754bb92f4f98de5b8f69dc1c1e87824ee18d5ed90613652389', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
11:25:59 [2025-02-07T11:25:59.989Z] 2025-02-07 11:25:59,801 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', 'bb7c038ad6279c754bb92f4f98de5b8f69dc1c1e87824ee18d5ed90613652389', '/usr/share/coreos-installer/example-config.yaml']
11:25:59 [2025-02-07T11:25:59.989Z] 2025-02-07 11:25:59,819 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', 'bb7c038ad6279c754bb92f4f98de5b8f69dc1c1e87824ee18d5ed90613652389', '/tmp/tmpq2g_kgm7']
11:25:59 [2025-02-07T11:25:59.989Z] Generating osmet file for 512b metal image
11:25:59 [2025-02-07T11:25:59.989Z] 2025-02-07 11:25:59,836 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43', '--checksum', 'c937a5558d7abe0cc972dafded0e4e34908d4727959a6c191a753531c5966572', '--output', '/var/tmp/coreos-installer-output', '--fast']
11:26:21 [2025-02-07T11:26:21.845Z] + RUST_BACKTRACE=full
11:26:21 [2025-02-07T11:26:21.845Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/5b37595dd66b519bd51f838cf8b74e71bb06b6eec903b23e92bb82d7b56c8b02.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43' --checksum c937a5558d7abe0cc972dafded0e4e34908d4727959a6c191a753531c5966572 --output /var/tmp/coreos-installer-output --fast
11:26:53 [2025-02-07T11:26:53.833Z] Total OSTree objects scanned from /root: 17842 (17836 mapped, 6 empty)
11:26:53 [2025-02-07T11:26:53.833Z] Total OSTree objects found in /boot: 313
11:26:53 [2025-02-07T11:26:53.833Z] Duplicate extents dropped: 0
11:26:53 [2025-02-07T11:26:53.833Z] Overlapping extents clamped: 0
11:26:53 [2025-02-07T11:26:53.833Z] Total /root extents: 17836
11:26:53 [2025-02-07T11:26:53.833Z] Duplicate extents dropped: 0
11:26:53 [2025-02-07T11:26:53.833Z] Overlapping extents clamped: 0
11:26:53 [2025-02-07T11:26:53.833Z] Total /boot extents: 318
11:26:53 [2025-02-07T11:26:53.833Z] Packing image
11:27:15 [2025-02-07T11:27:15.701Z] Total bytes skipped: 1664378880
11:27:15 [2025-02-07T11:27:15.701Z] Total bytes written: 1089181696
11:27:15 [2025-02-07T11:27:15.701Z] Total bytes written (compressed): 25612188
11:27:15 [2025-02-07T11:27:15.701Z] Verifying that repacked image matches digest
11:27:25 [2025-02-07T11:27:25.627Z] Packing successful!
11:27:25 [2025-02-07T11:27:25.627Z] + '[' -f /var/tmp/coreos-installer-output ']'
11:27:25 [2025-02-07T11:27:25.627Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
11:27:26 [2025-02-07T11:27:26.546Z] Generating osmet file for 4k metal image
11:27:26 [2025-02-07T11:27:26.546Z] 2025-02-07 11:27:26,377 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20250207.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43', '--checksum', 'a67fd7de308ee83873116e7d645a0d63cd60ea6d1adc014049530b4880b7a4b8', '--output', '/var/tmp/coreos-installer-output', '--fast']
11:27:44 [2025-02-07T11:27:44.558Z] + RUST_BACKTRACE=full
11:27:44 [2025-02-07T11:27:44.559Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/5b37595dd66b519bd51f838cf8b74e71bb06b6eec903b23e92bb82d7b56c8b02.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43' --checksum a67fd7de308ee83873116e7d645a0d63cd60ea6d1adc014049530b4880b7a4b8 --output /var/tmp/coreos-installer-output --fast
11:27:44 [2025-02-07T11:27:44.559Z] Total OSTree objects scanned from /root: 17842 (17836 mapped, 6 empty)
11:27:44 [2025-02-07T11:27:44.559Z] Total OSTree objects found in /boot: 3
11:27:44 [2025-02-07T11:27:44.559Z] Duplicate extents dropped: 0
11:27:44 [2025-02-07T11:27:44.559Z] Overlapping extents clamped: 0
11:27:44 [2025-02-07T11:27:44.559Z] Total /root extents: 17836
11:27:44 [2025-02-07T11:27:44.559Z] Duplicate extents dropped: 0
11:27:44 [2025-02-07T11:27:44.559Z] Overlapping extents clamped: 0
11:27:44 [2025-02-07T11:27:44.559Z] Total /boot extents: 4
11:27:44 [2025-02-07T11:27:44.559Z] Packing image
11:27:59 [2025-02-07T11:27:59.376Z] Total bytes skipped: 1653530624
11:27:59 [2025-02-07T11:27:59.376Z] Total bytes written: 1100029952
11:27:59 [2025-02-07T11:27:59.376Z] Total bytes written (compressed): 25263636
11:27:59 [2025-02-07T11:27:59.376Z] Verifying that repacked image matches digest
11:28:05 [2025-02-07T11:28:05.900Z] Packing successful!
11:28:05 [2025-02-07T11:28:05.900Z] + '[' -f /var/tmp/coreos-installer-output ']'
11:28:05 [2025-02-07T11:28:05.900Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
11:28:07 [2025-02-07T11:28:07.257Z] Compressing squashfs with lz4
11:28:07 [2025-02-07T11:28:07.257Z] 2025-02-07 11:28:07,041 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
11:28:07 [2025-02-07T11:28:07.257Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
11:28:07 [2025-02-07T11:28:07.257Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
11:28:07 [2025-02-07T11:28:07.257Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG
11:28:07 [2025-02-07T11:28:07.257Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/image.squashfs
11:28:07 [2025-02-07T11:28:07.257Z] + coreos_gf_run_mount builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:07 [2025-02-07T11:28:07.257Z] + local mntarg=mount
11:28:07 [2025-02-07T11:28:07.257Z] + '[' builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw = ro ']'
11:28:07 [2025-02-07T11:28:07.257Z] + coreos_gf_run builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:07 [2025-02-07T11:28:07.257Z] + '[' -n '' ']'
11:28:07 [2025-02-07T11:28:07.257Z] + coreos_gf_launch builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:07 [2025-02-07T11:28:07.257Z] + '[' -n '' ']'
11:28:07 [2025-02-07T11:28:07.257Z] ++ guestfish --listen -a builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:07 [2025-02-07T11:28:07.510Z] + eval 'GUESTFISH_PID=5224; export GUESTFISH_PID'
11:28:07 [2025-02-07T11:28:07.510Z] ++ GUESTFISH_PID=5224
11:28:07 [2025-02-07T11:28:07.510Z] ++ export GUESTFISH_PID
11:28:07 [2025-02-07T11:28:07.510Z] + '[' -z 5224 ']'
11:28:07 [2025-02-07T11:28:07.510Z] ++ kola ncpu
11:28:07 [2025-02-07T11:28:07.510Z] + coreos_gf set-smp 6
11:28:07 [2025-02-07T11:28:07.510Z] + guestfish --remote -- set-smp 6
11:28:07 [2025-02-07T11:28:07.510Z] + coreos_gf run
11:28:07 [2025-02-07T11:28:07.510Z] + guestfish --remote -- run
11:28:12 [2025-02-07T11:28:12.744Z] + GUESTFISH_RUNNING=1
11:28:12 [2025-02-07T11:28:12.744Z] ++ coreos_gf findfs-label root
11:28:12 [2025-02-07T11:28:12.744Z] ++ guestfish --remote -- findfs-label root
11:28:12 [2025-02-07T11:28:12.744Z] + root=/dev/sda4
11:28:12 [2025-02-07T11:28:12.744Z] + coreos_gf mount /dev/sda4 /
11:28:12 [2025-02-07T11:28:12.744Z] + guestfish --remote -- mount /dev/sda4 /
11:28:13 [2025-02-07T11:28:13.301Z] + local boot
11:28:13 [2025-02-07T11:28:13.301Z] ++ coreos_gf findfs-label boot
11:28:13 [2025-02-07T11:28:13.301Z] ++ guestfish --remote -- findfs-label boot
11:28:13 [2025-02-07T11:28:13.301Z] + boot=/dev/sda3
11:28:13 [2025-02-07T11:28:13.301Z] + coreos_gf mount /dev/sda3 /boot
11:28:13 [2025-02-07T11:28:13.301Z] + guestfish --remote -- mount /dev/sda3 /boot
11:28:13 [2025-02-07T11:28:13.301Z] + local partitions
11:28:13 [2025-02-07T11:28:13.301Z] + local label
11:28:13 [2025-02-07T11:28:13.301Z] ++ coreos_gf list-partitions
11:28:13 [2025-02-07T11:28:13.301Z] ++ guestfish --remote -- list-partitions
11:28:13 [2025-02-07T11:28:13.554Z] + partitions='/dev/sda1
11:28:13 [2025-02-07T11:28:13.554Z] /dev/sda2
11:28:13 [2025-02-07T11:28:13.554Z] /dev/sda3
11:28:13 [2025-02-07T11:28:13.554Z] /dev/sda4'
11:28:13 [2025-02-07T11:28:13.554Z] + for pt in $partitions
11:28:13 [2025-02-07T11:28:13.554Z] ++ coreos_gf vfs-label /dev/sda1
11:28:13 [2025-02-07T11:28:13.554Z] ++ guestfish --remote -- vfs-label /dev/sda1
11:28:13 [2025-02-07T11:28:13.554Z] + label=
11:28:13 [2025-02-07T11:28:13.554Z] + '[' '' == EFI-SYSTEM ']'
11:28:13 [2025-02-07T11:28:13.554Z] + for pt in $partitions
11:28:13 [2025-02-07T11:28:13.554Z] ++ coreos_gf vfs-label /dev/sda2
11:28:13 [2025-02-07T11:28:13.554Z] ++ guestfish --remote -- vfs-label /dev/sda2
11:28:13 [2025-02-07T11:28:13.554Z] + label=EFI-SYSTEM
11:28:13 [2025-02-07T11:28:13.554Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
11:28:13 [2025-02-07T11:28:13.554Z] + coreos_gf mount /dev/sda2 /boot/efi
11:28:13 [2025-02-07T11:28:13.554Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
11:28:13 [2025-02-07T11:28:13.554Z] + for pt in $partitions
11:28:13 [2025-02-07T11:28:13.554Z] ++ coreos_gf vfs-label /dev/sda3
11:28:13 [2025-02-07T11:28:13.554Z] ++ guestfish --remote -- vfs-label /dev/sda3
11:28:13 [2025-02-07T11:28:13.554Z] + label=boot
11:28:13 [2025-02-07T11:28:13.554Z] + '[' boot == EFI-SYSTEM ']'
11:28:13 [2025-02-07T11:28:13.554Z] + for pt in $partitions
11:28:13 [2025-02-07T11:28:13.554Z] ++ coreos_gf vfs-label /dev/sda4
11:28:13 [2025-02-07T11:28:13.554Z] ++ guestfish --remote -- vfs-label /dev/sda4
11:28:13 [2025-02-07T11:28:13.554Z] + label=root
11:28:13 [2025-02-07T11:28:13.554Z] + '[' root == EFI-SYSTEM ']'
11:28:13 [2025-02-07T11:28:13.554Z] ++ coreos_gf ls /ostree/deploy
11:28:13 [2025-02-07T11:28:13.554Z] ++ guestfish --remote -- ls /ostree/deploy
11:28:13 [2025-02-07T11:28:13.554Z] + stateroot=/ostree/deploy/fedora-coreos
11:28:13 [2025-02-07T11:28:13.554Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
11:28:13 [2025-02-07T11:28:13.554Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
11:28:13 [2025-02-07T11:28:13.554Z] ++ grep -v .origin
11:28:13 [2025-02-07T11:28:13.807Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/5b37595dd66b519bd51f838cf8b74e71bb06b6eec903b23e92bb82d7b56c8b02.0
11:28:13 [2025-02-07T11:28:13.807Z] + export stateroot deploydir
11:28:13 [2025-02-07T11:28:13.807Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/config
11:28:13 [2025-02-07T11:28:13.807Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/config
11:28:13 [2025-02-07T11:28:13.807Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/config
11:28:13 [2025-02-07T11:28:13.807Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/config.new /ostree/repo/config
11:28:13 [2025-02-07T11:28:13.807Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/config.new /ostree/repo/config
11:28:13 [2025-02-07T11:28:13.807Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
11:28:13 [2025-02-07T11:28:13.807Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
11:28:13 [2025-02-07T11:28:13.807Z] + kernel_binary=/boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/vmlinuz-6.14.0-0.rc1.15.fc42.x86_64
11:28:13 [2025-02-07T11:28:13.807Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
11:28:13 [2025-02-07T11:28:13.807Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
11:28:13 [2025-02-07T11:28:13.807Z] + kernel_hmac=/boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/.vmlinuz-6.14.0-0.rc1.15.fc42.x86_64.hmac
11:28:13 [2025-02-07T11:28:13.807Z] ++ basename /boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/.vmlinuz-6.14.0-0.rc1.15.fc42.x86_64.hmac
11:28:13 [2025-02-07T11:28:13.807Z] + coreos_gf ln /boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/.vmlinuz-6.14.0-0.rc1.15.fc42.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc1.15.fc42.x86_64.hmac
11:28:13 [2025-02-07T11:28:13.807Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/.vmlinuz-6.14.0-0.rc1.15.fc42.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc1.15.fc42.x86_64.hmac
11:28:13 [2025-02-07T11:28:13.807Z] ++ basename /boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/vmlinuz-6.14.0-0.rc1.15.fc42.x86_64
11:28:13 [2025-02-07T11:28:13.807Z] + coreos_gf ln /boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/vmlinuz-6.14.0-0.rc1.15.fc42.x86_64 /boot/vmlinuz-6.14.0-0.rc1.15.fc42.x86_64
11:28:13 [2025-02-07T11:28:13.807Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-7c8205dedb45e73d762b7f4f640532455f84c1b3da6144b5a060b3d87218385f/vmlinuz-6.14.0-0.rc1.15.fc42.x86_64 /boot/vmlinuz-6.14.0-0.rc1.15.fc42.x86_64
11:28:13 [2025-02-07T11:28:13.807Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/image.squashfs compress:lz4
11:28:13 [2025-02-07T11:28:13.807Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/image.squashfs compress:lz4
11:28:21 [2025-02-07T11:28:21.866Z] + coreos_gf_shutdown
11:28:21 [2025-02-07T11:28:21.866Z] + coreos_gf umount-all
11:28:21 [2025-02-07T11:28:21.866Z] + guestfish --remote -- umount-all
11:28:22 [2025-02-07T11:28:22.121Z] + coreos_gf exit
11:28:22 [2025-02-07T11:28:22.121Z] + guestfish --remote -- exit
11:28:22 [2025-02-07T11:28:22.617Z] + GUESTFISH_RUNNING=
11:28:22 [2025-02-07T11:28:22.617Z] + GUESTFISH_PID=
11:28:22 [2025-02-07T11:28:22.617Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
11:28:22 [2025-02-07T11:28:22.617Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.2ZF7WG -rf
11:28:22 [2025-02-07T11:28:22.617Z] + _coreos_gf_cleanup
11:28:22 [2025-02-07T11:28:22.617Z] + guestfish --remote -- exit
11:28:22 [2025-02-07T11:28:22.617Z] + :
11:28:27 [2025-02-07T11:28:27.842Z] 2025-02-07 11:28:27,188 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw']
11:28:27 [2025-02-07T11:28:27.842Z] + coreos_gf_run_mount builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:27 [2025-02-07T11:28:27.842Z] + local mntarg=mount
11:28:27 [2025-02-07T11:28:27.842Z] + '[' builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw = ro ']'
11:28:27 [2025-02-07T11:28:27.842Z] + coreos_gf_run builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:27 [2025-02-07T11:28:27.842Z] + '[' -n '' ']'
11:28:27 [2025-02-07T11:28:27.842Z] + coreos_gf_launch builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:27 [2025-02-07T11:28:27.842Z] + '[' -n '' ']'
11:28:27 [2025-02-07T11:28:27.842Z] ++ guestfish --listen -a builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw --ro
11:28:27 [2025-02-07T11:28:27.842Z] + eval 'GUESTFISH_PID=5542; export GUESTFISH_PID'
11:28:27 [2025-02-07T11:28:27.842Z] ++ GUESTFISH_PID=5542
11:28:27 [2025-02-07T11:28:27.842Z] ++ export GUESTFISH_PID
11:28:27 [2025-02-07T11:28:27.842Z] + '[' -z 5542 ']'
11:28:27 [2025-02-07T11:28:27.842Z] ++ kola ncpu
11:28:27 [2025-02-07T11:28:27.842Z] + coreos_gf set-smp 6
11:28:27 [2025-02-07T11:28:27.842Z] + guestfish --remote -- set-smp 6
11:28:27 [2025-02-07T11:28:27.842Z] + coreos_gf run
11:28:27 [2025-02-07T11:28:27.842Z] + guestfish --remote -- run
11:28:29 [2025-02-07T11:28:29.206Z] + GUESTFISH_RUNNING=1
11:28:29 [2025-02-07T11:28:29.206Z] ++ coreos_gf findfs-label root
11:28:29 [2025-02-07T11:28:29.206Z] ++ guestfish --remote -- findfs-label root
11:28:29 [2025-02-07T11:28:29.206Z] + root=/dev/sda4
11:28:29 [2025-02-07T11:28:29.206Z] + coreos_gf mount /dev/sda4 /
11:28:29 [2025-02-07T11:28:29.206Z] + guestfish --remote -- mount /dev/sda4 /
11:28:29 [2025-02-07T11:28:29.762Z] + local boot
11:28:29 [2025-02-07T11:28:29.762Z] ++ coreos_gf findfs-label boot
11:28:29 [2025-02-07T11:28:29.762Z] ++ guestfish --remote -- findfs-label boot
11:28:29 [2025-02-07T11:28:29.762Z] + boot=/dev/sda3
11:28:29 [2025-02-07T11:28:29.762Z] + coreos_gf mount /dev/sda3 /boot
11:28:29 [2025-02-07T11:28:29.762Z] + guestfish --remote -- mount /dev/sda3 /boot
11:28:29 [2025-02-07T11:28:29.762Z] + local partitions
11:28:29 [2025-02-07T11:28:29.762Z] + local label
11:28:29 [2025-02-07T11:28:29.762Z] ++ coreos_gf list-partitions
11:28:29 [2025-02-07T11:28:29.762Z] ++ guestfish --remote -- list-partitions
11:28:30 [2025-02-07T11:28:30.016Z] + partitions='/dev/sda1
11:28:30 [2025-02-07T11:28:30.016Z] /dev/sda2
11:28:30 [2025-02-07T11:28:30.016Z] /dev/sda3
11:28:30 [2025-02-07T11:28:30.016Z] /dev/sda4'
11:28:30 [2025-02-07T11:28:30.016Z] + for pt in $partitions
11:28:30 [2025-02-07T11:28:30.016Z] ++ coreos_gf vfs-label /dev/sda1
11:28:30 [2025-02-07T11:28:30.016Z] ++ guestfish --remote -- vfs-label /dev/sda1
11:28:30 [2025-02-07T11:28:30.016Z] + label=
11:28:30 [2025-02-07T11:28:30.016Z] + '[' '' == EFI-SYSTEM ']'
11:28:30 [2025-02-07T11:28:30.016Z] + for pt in $partitions
11:28:30 [2025-02-07T11:28:30.016Z] ++ coreos_gf vfs-label /dev/sda2
11:28:30 [2025-02-07T11:28:30.016Z] ++ guestfish --remote -- vfs-label /dev/sda2
11:28:30 [2025-02-07T11:28:30.016Z] + label=EFI-SYSTEM
11:28:30 [2025-02-07T11:28:30.016Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
11:28:30 [2025-02-07T11:28:30.016Z] + coreos_gf mount /dev/sda2 /boot/efi
11:28:30 [2025-02-07T11:28:30.016Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
11:28:30 [2025-02-07T11:28:30.016Z] + for pt in $partitions
11:28:30 [2025-02-07T11:28:30.016Z] ++ coreos_gf vfs-label /dev/sda3
11:28:30 [2025-02-07T11:28:30.016Z] ++ guestfish --remote -- vfs-label /dev/sda3
11:28:30 [2025-02-07T11:28:30.016Z] + label=boot
11:28:30 [2025-02-07T11:28:30.016Z] + '[' boot == EFI-SYSTEM ']'
11:28:30 [2025-02-07T11:28:30.016Z] + for pt in $partitions
11:28:30 [2025-02-07T11:28:30.016Z] ++ coreos_gf vfs-label /dev/sda4
11:28:30 [2025-02-07T11:28:30.016Z] ++ guestfish --remote -- vfs-label /dev/sda4
11:28:30 [2025-02-07T11:28:30.016Z] + label=root
11:28:30 [2025-02-07T11:28:30.016Z] + '[' root == EFI-SYSTEM ']'
11:28:30 [2025-02-07T11:28:30.016Z] ++ coreos_gf ls /ostree/deploy
11:28:30 [2025-02-07T11:28:30.016Z] ++ guestfish --remote -- ls /ostree/deploy
11:28:30 [2025-02-07T11:28:30.016Z] + stateroot=/ostree/deploy/fedora-coreos
11:28:30 [2025-02-07T11:28:30.016Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
11:28:30 [2025-02-07T11:28:30.016Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
11:28:30 [2025-02-07T11:28:30.016Z] ++ grep -v .origin
11:28:30 [2025-02-07T11:28:30.269Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/5b37595dd66b519bd51f838cf8b74e71bb06b6eec903b23e92bb82d7b56c8b02.0
11:28:30 [2025-02-07T11:28:30.269Z] + export stateroot deploydir
11:28:30 [2025-02-07T11:28:30.269Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
11:28:30 [2025-02-07T11:28:30.269Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
11:28:30 [2025-02-07T11:28:30.269Z] + sed -e '/^options/!d' -e 's/^options\s*//'
11:28:30 [2025-02-07T11:28:30.269Z] + coreos_gf_shutdown
11:28:30 [2025-02-07T11:28:30.269Z] + coreos_gf umount-all
11:28:30 [2025-02-07T11:28:30.269Z] + guestfish --remote -- umount-all
11:28:30 [2025-02-07T11:28:30.269Z] + coreos_gf exit
11:28:30 [2025-02-07T11:28:30.269Z] + guestfish --remote -- exit
11:28:30 [2025-02-07T11:28:30.269Z] + GUESTFISH_RUNNING=
11:28:30 [2025-02-07T11:28:30.269Z] + GUESTFISH_PID=
11:28:30 [2025-02-07T11:28:30.269Z] + _coreos_gf_cleanup
11:28:30 [2025-02-07T11:28:30.269Z] + guestfish --remote -- exit
11:28:30 [2025-02-07T11:28:30.269Z] + :
11:28:30 [2025-02-07T11:28:30.269Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20250207.dev.0
11:28:30 [2025-02-07T11:28:30.269Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
11:28:30 [2025-02-07T11:28:30.269Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
11:28:30 [2025-02-07T11:28:30.269Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
11:28:30 [2025-02-07T11:28:30.269Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
11:28:30 [2025-02-07T11:28:30.270Z] 2025-02-07 11:28:30,269 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', 'bb7c038ad6279c754bb92f4f98de5b8f69dc1c1e87824ee18d5ed90613652389', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
11:28:30 [2025-02-07T11:28:30.522Z] 2025-02-07 11:28:30,417 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpq39lk2_s.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
11:28:32 [2025-02-07T11:28:32.399Z] 2025-02-07 11:28:32,275 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250207.dev.0', '-volset', 'fedora-coreos-42.20250207.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.20250207.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
11:28:32 [2025-02-07T11:28:32.399Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
11:28:32 [2025-02-07T11:28:32.399Z] genisoimage 1.1.11 (Linux)
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
11:28:32 [2025-02-07T11:28:32.399Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Initial Padblock                        Start Block 0
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Initial Padblock                        Block(s)    16
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Primary Volume Descriptor               Start Block 16
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Primary Volume Descriptor               Block(s)    1
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Eltorito Volume Descriptor              Start Block 17
11:28:32 [2025-02-07T11:28:32.399Z] Size of boot image is 4 sectors -> No emulation
11:28:32 [2025-02-07T11:28:32.399Z] Size of boot image is 13104 sectors -> No emulation
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Eltorito Volume Descriptor              Block(s)    1
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Joliet Volume Descriptor                Start Block 18
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Joliet Volume Descriptor                Block(s)    1
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   End Volume Descriptor                   Start Block 19
11:28:32 [2025-02-07T11:28:32.399Z] Done with: End Volume Descriptor                   Block(s)    1
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Version block                           Start Block 20
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Version block                           Block(s)    1
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Path table                              Start Block 21
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Path table                              Block(s)    4
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Joliet path table                       Start Block 25
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Joliet path table                       Block(s)    4
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Directory tree                          Start Block 29
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Directory tree                          Block(s)    7
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Joliet directory tree                   Start Block 36
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Joliet directory tree                   Block(s)    7
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Directory tree cleanup                  Start Block 43
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Directory tree cleanup                  Block(s)    0
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   Extension record                        Start Block 43
11:28:32 [2025-02-07T11:28:32.399Z] Done with: Extension record                        Block(s)    1
11:28:32 [2025-02-07T11:28:32.399Z] Writing:   The File(s)                             Start Block 44
11:28:32 [2025-02-07T11:28:32.399Z]   0.91% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   1.83% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   2.74% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   3.66% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   4.57% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   5.49% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   6.40% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   7.31% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   8.23% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]   9.14% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]  10.05% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]  10.97% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.399Z]  11.88% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  12.80% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  13.71% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  14.63% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  15.54% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  16.45% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  17.37% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  18.28% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  19.20% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  20.11% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  21.02% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  21.94% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  22.85% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  23.77% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.652Z]  24.68% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  25.59% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  26.51% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  27.42% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  28.34% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  29.25% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  30.16% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  31.08% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  31.99% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  32.91% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  33.82% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  34.74% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  35.65% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.653Z]  36.56% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  37.48% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  38.39% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  39.30% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  40.22% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  41.13% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  42.05% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  42.96% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  43.88% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  44.79% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  45.70% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  46.62% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  47.53% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  48.44% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  49.36% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  50.27% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  51.19% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  52.10% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  53.02% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  53.93% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  54.84% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  55.76% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  56.67% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:32 [2025-02-07T11:28:32.909Z]  57.58% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  58.50% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  59.41% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  60.33% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  61.24% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  62.16% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  63.07% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  63.98% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  64.90% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  65.81% done, estimate finish Fri Feb  7 11:28:32 2025
11:28:33 [2025-02-07T11:28:33.220Z]  66.73% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  67.64% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  68.55% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  69.47% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  70.38% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  71.30% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  72.21% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  73.12% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  74.04% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  74.95% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  75.87% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  76.78% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  77.69% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  78.61% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  79.52% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  80.44% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  81.35% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  82.27% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  83.18% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  84.09% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.220Z]  85.01% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  85.92% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  86.83% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  87.75% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  88.66% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  89.58% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  90.49% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  91.41% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  92.32% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  93.23% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.473Z]  94.15% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z]  95.06% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z]  95.97% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z]  96.89% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z]  97.80% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z]  98.72% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z]  99.63% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:33 [2025-02-07T11:28:33.483Z] Total translation table size: 2048
11:28:33 [2025-02-07T11:28:33.483Z] Total rockridge attributes bytes: 3006
11:28:33 [2025-02-07T11:28:33.483Z] Total directory bytes: 12288
11:28:33 [2025-02-07T11:28:33.483Z] Path table size(bytes): 96
11:28:33 [2025-02-07T11:28:33.483Z] Done with: The File(s)                             Block(s)    546827
11:28:33 [2025-02-07T11:28:33.483Z] Writing:   Ending Padblock                         Start Block 546871
11:28:33 [2025-02-07T11:28:33.483Z] Done with: Ending Padblock                         Block(s)    150
11:28:33 [2025-02-07T11:28:33.483Z] Max brk space used 1c000
11:28:33 [2025-02-07T11:28:33.483Z] 547021 extents written (1068 MB)
11:28:33 [2025-02-07T11:28:33.483Z] 2025-02-07 11:28:33,407 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250207.dev.0-live.x86_64.iso']
11:28:33 [2025-02-07T11:28:33.483Z] isohybrid: Warning: more than 1024 cylinders: 1069
11:28:33 [2025-02-07T11:28:33.483Z] isohybrid: Not all BIOSes will be able to boot this device
11:28:34 [2025-02-07T11:28:34.040Z] 2025-02-07 11:28:33,858 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20250207.dev.0', '-volset', 'fedora-coreos-42.20250207.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.20250207.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
11:28:34 [2025-02-07T11:28:34.040Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
11:28:34 [2025-02-07T11:28:34.040Z] genisoimage 1.1.11 (Linux)
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
11:28:34 [2025-02-07T11:28:34.040Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Initial Padblock                        Start Block 0
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Initial Padblock                        Block(s)    16
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Primary Volume Descriptor               Start Block 16
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Primary Volume Descriptor               Block(s)    1
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Eltorito Volume Descriptor              Start Block 17
11:28:34 [2025-02-07T11:28:34.040Z] Size of boot image is 4 sectors -> No emulation
11:28:34 [2025-02-07T11:28:34.040Z] Size of boot image is 13104 sectors -> No emulation
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Eltorito Volume Descriptor              Block(s)    1
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Joliet Volume Descriptor                Start Block 18
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Joliet Volume Descriptor                Block(s)    1
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   End Volume Descriptor                   Start Block 19
11:28:34 [2025-02-07T11:28:34.040Z] Done with: End Volume Descriptor                   Block(s)    1
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Version block                           Start Block 20
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Version block                           Block(s)    1
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Path table                              Start Block 21
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Path table                              Block(s)    4
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Joliet path table                       Start Block 25
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Joliet path table                       Block(s)    4
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Directory tree                          Start Block 29
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Directory tree                          Block(s)    7
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Joliet directory tree                   Start Block 36
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Joliet directory tree                   Block(s)    7
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Directory tree cleanup                  Start Block 43
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Directory tree cleanup                  Block(s)    0
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   Extension record                        Start Block 43
11:28:34 [2025-02-07T11:28:34.040Z] Done with: Extension record                        Block(s)    1
11:28:34 [2025-02-07T11:28:34.040Z] Writing:   The File(s)                             Start Block 44
11:28:34 [2025-02-07T11:28:34.040Z]   8.40% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  16.77% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  25.18% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  33.55% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  41.95% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  50.32% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  58.72% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  67.10% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  75.50% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  83.87% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.040Z]  92.28% done, estimate finish Fri Feb  7 11:28:33 2025
11:28:34 [2025-02-07T11:28:34.295Z] Total translation table size: 2048
11:28:34 [2025-02-07T11:28:34.295Z] Total rockridge attributes bytes: 2842
11:28:34 [2025-02-07T11:28:34.295Z] Total directory bytes: 12288
11:28:34 [2025-02-07T11:28:34.295Z] Path table size(bytes): 96
11:28:34 [2025-02-07T11:28:34.295Z] Done with: The File(s)                             Block(s)    59420
11:28:34 [2025-02-07T11:28:34.295Z] Writing:   Ending Padblock                         Start Block 59464
11:28:34 [2025-02-07T11:28:34.295Z] Done with: Ending Padblock                         Block(s)    150
11:28:34 [2025-02-07T11:28:34.295Z] Max brk space used 1b000
11:28:34 [2025-02-07T11:28:34.295Z] 59614 extents written (116 MB)
11:28:34 [2025-02-07T11:28:34.295Z] 2025-02-07 11:28:34,164 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250207.dev.0-live.x86_64.iso.minimal']
11:28:34 [2025-02-07T11:28:34.295Z] 2025-02-07 11:28:34,204 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20250207.dev.0/x86_64/fedora-coreos-42.20250207.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250207.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250207.dev.0-live.x86_64.iso.minimal', '--consume']
11:28:52 [2025-02-07T11:28:52.303Z] + RUST_BACKTRACE=full
11:28:52 [2025-02-07T11:28:52.303Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/5b37595dd66b519bd51f838cf8b74e71bb06b6eec903b23e92bb82d7b56c8b02.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.20250207.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20250207.dev.0-live.x86_64.iso.minimal --consume
11:28:52 [2025-02-07T11:28:52.303Z] Packing minimal ISO
11:28:52 [2025-02-07T11:28:52.303Z] Matched 17 files of 17
11:28:52 [2025-02-07T11:28:52.303Z] Total bytes skipped: 121669839
11:28:52 [2025-02-07T11:28:52.303Z] Total bytes written: 1013553
11:28:52 [2025-02-07T11:28:52.303Z] Total bytes written (compressed): 2852
11:28:52 [2025-02-07T11:28:52.303Z] Verifying that packed image matches digest
11:28:52 [2025-02-07T11:28:52.555Z] Packing successful!
11:28:52 [2025-02-07T11:28:52.555Z] + '[' -f /var/tmp/coreos-installer-output ']'
11:29:19 [2025-02-07T11:29:19.007Z] Updated: builds/42.20250207.dev.0/x86_64/meta.json