Console Output

18:20:35 [2024-10-28T18:20:35.199Z] + set -xeuo pipefail
18:20:35 [2024-10-28T18:20:35.199Z] ++ umask
18:20:35 [2024-10-28T18:20:35.199Z] + '[' 0022 = 0000 ']'
18:20:35 [2024-10-28T18:20:35.199Z] + cosa buildextend-live --fast
18:20:35 [2024-10-28T18:20:35.199Z] Targeting build: 42.20241028.dev.0
18:20:35 [2024-10-28T18:20:35.452Z] 2024-10-28 18:20:35,260 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', '9444deeda7ba45432cfd2e6f8a0ed75385f1cc6b1f0bb01483038ff50dc01f5a', '/usr/lib/modules']
18:20:35 [2024-10-28T18:20:35.452Z] 2024-10-28 18:20:35,270 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64/vmlinuz', '9444deeda7ba45432cfd2e6f8a0ed75385f1cc6b1f0bb01483038ff50dc01f5a', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
18:20:35 [2024-10-28T18:20:35.452Z] 2024-10-28 18:20:35,318 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64/initramfs.img', '9444deeda7ba45432cfd2e6f8a0ed75385f1cc6b1f0bb01483038ff50dc01f5a', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
18:20:35 [2024-10-28T18:20:35.704Z] 2024-10-28 18:20:35,515 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '9444deeda7ba45432cfd2e6f8a0ed75385f1cc6b1f0bb01483038ff50dc01f5a', '/usr/share/coreos-installer/example-config.yaml']
18:20:35 [2024-10-28T18:20:35.704Z] 2024-10-28 18:20:35,535 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', '9444deeda7ba45432cfd2e6f8a0ed75385f1cc6b1f0bb01483038ff50dc01f5a', '/tmp/tmplsd6p51t']
18:20:35 [2024-10-28T18:20:35.704Z] Generating osmet file for 512b metal image
18:20:35 [2024-10-28T18:20:35.704Z] 2024-10-28 18:20:35,554 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20241028.dev.0', '--checksum', '8d501454a466c852a553881cd879e98bd74e3b5e4e52115f856c76ce95d0db3d', '--output', '/var/tmp/coreos-installer-output', '--fast']
18:20:53 [2024-10-28T18:20:53.710Z] + RUST_BACKTRACE=full
18:20:53 [2024-10-28T18:20:53.710Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/955c5fc598451d409bc16478a17c30694e9a9f50ed556af70ebfd1202b116813.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20241028.dev.0' --checksum 8d501454a466c852a553881cd879e98bd74e3b5e4e52115f856c76ce95d0db3d --output /var/tmp/coreos-installer-output --fast
18:20:53 [2024-10-28T18:20:53.710Z] Total OSTree objects scanned from /root: 17710 (17704 mapped, 6 empty)
18:20:53 [2024-10-28T18:20:53.710Z] Total OSTree objects found in /boot: 316
18:20:53 [2024-10-28T18:20:53.710Z] Duplicate extents dropped: 0
18:20:53 [2024-10-28T18:20:53.710Z] Overlapping extents clamped: 0
18:20:53 [2024-10-28T18:20:53.710Z] Total /root extents: 17705
18:20:53 [2024-10-28T18:20:53.710Z] Duplicate extents dropped: 0
18:20:53 [2024-10-28T18:20:53.710Z] Overlapping extents clamped: 0
18:20:53 [2024-10-28T18:20:53.710Z] Total /boot extents: 321
18:20:53 [2024-10-28T18:20:53.710Z] Packing image
18:21:11 [2024-10-28T18:21:11.720Z] Total bytes skipped: 1677194240
18:21:11 [2024-10-28T18:21:11.720Z] Total bytes written: 1098386432
18:21:11 [2024-10-28T18:21:11.720Z] Total bytes written (compressed): 25839868
18:21:11 [2024-10-28T18:21:11.720Z] Verifying that repacked image matches digest
18:21:26 [2024-10-28T18:21:26.547Z] Packing successful!
18:21:26 [2024-10-28T18:21:26.547Z] + '[' -f /var/tmp/coreos-installer-output ']'
18:21:26 [2024-10-28T18:21:26.547Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
18:21:27 [2024-10-28T18:21:27.906Z] Generating osmet file for 4k metal image
18:21:27 [2024-10-28T18:21:27.906Z] 2024-10-28 18:21:27,691 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20241028.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20241028.dev.0', '--checksum', 'c72f2cd3ff3c4f6d4139f8abfcbe395082b5197342111fe0f173f422b4201e19', '--output', '/var/tmp/coreos-installer-output', '--fast']
18:21:45 [2024-10-28T18:21:45.909Z] + RUST_BACKTRACE=full
18:21:45 [2024-10-28T18:21:45.909Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/955c5fc598451d409bc16478a17c30694e9a9f50ed556af70ebfd1202b116813.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20241028.dev.0' --checksum c72f2cd3ff3c4f6d4139f8abfcbe395082b5197342111fe0f173f422b4201e19 --output /var/tmp/coreos-installer-output --fast
18:21:52 [2024-10-28T18:21:52.419Z] Total OSTree objects scanned from /root: 17710 (17704 mapped, 6 empty)
18:21:52 [2024-10-28T18:21:52.419Z] Total OSTree objects found in /boot: 3
18:21:52 [2024-10-28T18:21:52.419Z] Duplicate extents dropped: 0
18:21:52 [2024-10-28T18:21:52.419Z] Overlapping extents clamped: 0
18:21:52 [2024-10-28T18:21:52.419Z] Total /root extents: 17705
18:21:52 [2024-10-28T18:21:52.419Z] Duplicate extents dropped: 0
18:21:52 [2024-10-28T18:21:52.419Z] Overlapping extents clamped: 0
18:21:52 [2024-10-28T18:21:52.419Z] Total /boot extents: 4
18:21:52 [2024-10-28T18:21:52.419Z] Packing image
18:22:07 [2024-10-28T18:22:07.223Z] Total bytes skipped: 1666326528
18:22:07 [2024-10-28T18:22:07.223Z] Total bytes written: 1109254144
18:22:07 [2024-10-28T18:22:07.223Z] Total bytes written (compressed): 25910380
18:22:07 [2024-10-28T18:22:07.223Z] Verifying that repacked image matches digest
18:22:17 [2024-10-28T18:22:17.140Z] Packing successful!
18:22:17 [2024-10-28T18:22:17.140Z] + '[' -f /var/tmp/coreos-installer-output ']'
18:22:17 [2024-10-28T18:22:17.140Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
18:22:17 [2024-10-28T18:22:17.696Z] Compressing squashfs with lz4
18:22:17 [2024-10-28T18:22:17.696Z] 2024-10-28 18:22:17,523 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
18:22:17 [2024-10-28T18:22:17.696Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
18:22:17 [2024-10-28T18:22:17.696Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
18:22:17 [2024-10-28T18:22:17.696Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0
18:22:17 [2024-10-28T18:22:17.696Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/image.squashfs
18:22:17 [2024-10-28T18:22:17.696Z] + coreos_gf_run_mount builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:17 [2024-10-28T18:22:17.696Z] + local mntarg=mount
18:22:17 [2024-10-28T18:22:17.696Z] + '[' builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw = ro ']'
18:22:17 [2024-10-28T18:22:17.696Z] + coreos_gf_run builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:17 [2024-10-28T18:22:17.696Z] + '[' -n '' ']'
18:22:17 [2024-10-28T18:22:17.696Z] + coreos_gf_launch builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:17 [2024-10-28T18:22:17.696Z] + '[' -n '' ']'
18:22:17 [2024-10-28T18:22:17.696Z] ++ guestfish --listen -a builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:17 [2024-10-28T18:22:17.950Z] + eval 'GUESTFISH_PID=12399; export GUESTFISH_PID'
18:22:17 [2024-10-28T18:22:17.951Z] ++ GUESTFISH_PID=12399
18:22:17 [2024-10-28T18:22:17.951Z] ++ export GUESTFISH_PID
18:22:17 [2024-10-28T18:22:17.951Z] + '[' -z 12399 ']'
18:22:17 [2024-10-28T18:22:17.951Z] ++ kola ncpu
18:22:17 [2024-10-28T18:22:17.951Z] + coreos_gf set-smp 6
18:22:17 [2024-10-28T18:22:17.951Z] + guestfish --remote -- set-smp 6
18:22:17 [2024-10-28T18:22:17.951Z] + coreos_gf run
18:22:17 [2024-10-28T18:22:17.951Z] + guestfish --remote -- run
18:22:19 [2024-10-28T18:22:19.830Z] + GUESTFISH_RUNNING=1
18:22:19 [2024-10-28T18:22:19.830Z] ++ coreos_gf findfs-label root
18:22:19 [2024-10-28T18:22:19.830Z] ++ guestfish --remote -- findfs-label root
18:22:19 [2024-10-28T18:22:19.830Z] + root=/dev/sda4
18:22:19 [2024-10-28T18:22:19.830Z] + coreos_gf mount /dev/sda4 /
18:22:19 [2024-10-28T18:22:19.830Z] + guestfish --remote -- mount /dev/sda4 /
18:22:20 [2024-10-28T18:22:20.385Z] + local boot
18:22:20 [2024-10-28T18:22:20.385Z] ++ coreos_gf findfs-label boot
18:22:20 [2024-10-28T18:22:20.385Z] ++ guestfish --remote -- findfs-label boot
18:22:20 [2024-10-28T18:22:20.385Z] + boot=/dev/sda3
18:22:20 [2024-10-28T18:22:20.385Z] + coreos_gf mount /dev/sda3 /boot
18:22:20 [2024-10-28T18:22:20.385Z] + guestfish --remote -- mount /dev/sda3 /boot
18:22:20 [2024-10-28T18:22:20.638Z] + local partitions
18:22:20 [2024-10-28T18:22:20.638Z] + local label
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf list-partitions
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- list-partitions
18:22:20 [2024-10-28T18:22:20.638Z] + partitions='/dev/sda1
18:22:20 [2024-10-28T18:22:20.638Z] /dev/sda2
18:22:20 [2024-10-28T18:22:20.638Z] /dev/sda3
18:22:20 [2024-10-28T18:22:20.638Z] /dev/sda4'
18:22:20 [2024-10-28T18:22:20.638Z] + for pt in $partitions
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf vfs-label /dev/sda1
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- vfs-label /dev/sda1
18:22:20 [2024-10-28T18:22:20.638Z] + label=
18:22:20 [2024-10-28T18:22:20.638Z] + '[' '' == EFI-SYSTEM ']'
18:22:20 [2024-10-28T18:22:20.638Z] + for pt in $partitions
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf vfs-label /dev/sda2
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- vfs-label /dev/sda2
18:22:20 [2024-10-28T18:22:20.638Z] + label=EFI-SYSTEM
18:22:20 [2024-10-28T18:22:20.638Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
18:22:20 [2024-10-28T18:22:20.638Z] + coreos_gf mount /dev/sda2 /boot/efi
18:22:20 [2024-10-28T18:22:20.638Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
18:22:20 [2024-10-28T18:22:20.638Z] + for pt in $partitions
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf vfs-label /dev/sda3
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- vfs-label /dev/sda3
18:22:20 [2024-10-28T18:22:20.638Z] + label=boot
18:22:20 [2024-10-28T18:22:20.638Z] + '[' boot == EFI-SYSTEM ']'
18:22:20 [2024-10-28T18:22:20.638Z] + for pt in $partitions
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf vfs-label /dev/sda4
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- vfs-label /dev/sda4
18:22:20 [2024-10-28T18:22:20.638Z] + label=root
18:22:20 [2024-10-28T18:22:20.638Z] + '[' root == EFI-SYSTEM ']'
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf ls /ostree/deploy
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- ls /ostree/deploy
18:22:20 [2024-10-28T18:22:20.638Z] + stateroot=/ostree/deploy/fedora-coreos
18:22:20 [2024-10-28T18:22:20.638Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
18:22:20 [2024-10-28T18:22:20.638Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
18:22:20 [2024-10-28T18:22:20.638Z] ++ grep -v .origin
18:22:20 [2024-10-28T18:22:20.897Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/955c5fc598451d409bc16478a17c30694e9a9f50ed556af70ebfd1202b116813.0
18:22:20 [2024-10-28T18:22:20.897Z] + export stateroot deploydir
18:22:20 [2024-10-28T18:22:20.897Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/config
18:22:20 [2024-10-28T18:22:20.897Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/config
18:22:20 [2024-10-28T18:22:20.897Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/config
18:22:20 [2024-10-28T18:22:20.897Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/config.new /ostree/repo/config
18:22:20 [2024-10-28T18:22:20.898Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/config.new /ostree/repo/config
18:22:20 [2024-10-28T18:22:20.898Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
18:22:20 [2024-10-28T18:22:20.898Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
18:22:20 [2024-10-28T18:22:20.898Z] + kernel_binary=/boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64
18:22:20 [2024-10-28T18:22:20.898Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
18:22:20 [2024-10-28T18:22:20.898Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
18:22:20 [2024-10-28T18:22:20.898Z] + kernel_hmac=/boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/.vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64.hmac
18:22:20 [2024-10-28T18:22:20.898Z] ++ basename /boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/.vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64.hmac
18:22:20 [2024-10-28T18:22:20.898Z] + coreos_gf ln /boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/.vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64.hmac /boot/.vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64.hmac
18:22:20 [2024-10-28T18:22:20.898Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/.vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64.hmac /boot/.vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64.hmac
18:22:20 [2024-10-28T18:22:20.898Z] ++ basename /boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64
18:22:20 [2024-10-28T18:22:20.898Z] + coreos_gf ln /boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64 /boot/vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64
18:22:20 [2024-10-28T18:22:20.898Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-964fe2091c78112408d806de05143ba27f2c1903892d660deb6750aa7d556239/vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64 /boot/vmlinuz-6.12.0-0.rc4.20241023gitc2ee9f594da8.41.fc42.x86_64
18:22:20 [2024-10-28T18:22:20.898Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/image.squashfs compress:lz4
18:22:20 [2024-10-28T18:22:20.898Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/image.squashfs compress:lz4
18:22:30 [2024-10-28T18:22:30.812Z] + coreos_gf_shutdown
18:22:30 [2024-10-28T18:22:30.812Z] + coreos_gf umount-all
18:22:30 [2024-10-28T18:22:30.812Z] + guestfish --remote -- umount-all
18:22:30 [2024-10-28T18:22:30.812Z] + coreos_gf exit
18:22:30 [2024-10-28T18:22:30.812Z] + guestfish --remote -- exit
18:22:31 [2024-10-28T18:22:31.367Z] + GUESTFISH_RUNNING=
18:22:31 [2024-10-28T18:22:31.367Z] + GUESTFISH_PID=
18:22:31 [2024-10-28T18:22:31.367Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
18:22:31 [2024-10-28T18:22:31.367Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.HjL1m0 -rf
18:22:31 [2024-10-28T18:22:31.367Z] + _coreos_gf_cleanup
18:22:31 [2024-10-28T18:22:31.367Z] + guestfish --remote -- exit
18:22:31 [2024-10-28T18:22:31.367Z] + :
18:22:46 [2024-10-28T18:22:46.189Z] 2024-10-28 18:22:43,687 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw']
18:22:46 [2024-10-28T18:22:46.189Z] + coreos_gf_run_mount builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:46 [2024-10-28T18:22:46.189Z] + local mntarg=mount
18:22:46 [2024-10-28T18:22:46.189Z] + '[' builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw = ro ']'
18:22:46 [2024-10-28T18:22:46.189Z] + coreos_gf_run builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:46 [2024-10-28T18:22:46.189Z] + '[' -n '' ']'
18:22:46 [2024-10-28T18:22:46.189Z] + coreos_gf_launch builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:46 [2024-10-28T18:22:46.189Z] + '[' -n '' ']'
18:22:46 [2024-10-28T18:22:46.189Z] ++ guestfish --listen -a builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw --ro
18:22:46 [2024-10-28T18:22:46.189Z] + eval 'GUESTFISH_PID=12570; export GUESTFISH_PID'
18:22:46 [2024-10-28T18:22:46.189Z] ++ GUESTFISH_PID=12570
18:22:46 [2024-10-28T18:22:46.189Z] ++ export GUESTFISH_PID
18:22:46 [2024-10-28T18:22:46.189Z] + '[' -z 12570 ']'
18:22:46 [2024-10-28T18:22:46.189Z] ++ kola ncpu
18:22:46 [2024-10-28T18:22:46.189Z] + coreos_gf set-smp 6
18:22:46 [2024-10-28T18:22:46.189Z] + guestfish --remote -- set-smp 6
18:22:46 [2024-10-28T18:22:46.189Z] + coreos_gf run
18:22:46 [2024-10-28T18:22:46.189Z] + guestfish --remote -- run
18:22:46 [2024-10-28T18:22:46.189Z] + GUESTFISH_RUNNING=1
18:22:46 [2024-10-28T18:22:46.189Z] ++ coreos_gf findfs-label root
18:22:46 [2024-10-28T18:22:46.189Z] ++ guestfish --remote -- findfs-label root
18:22:46 [2024-10-28T18:22:46.189Z] + root=/dev/sda4
18:22:46 [2024-10-28T18:22:46.189Z] + coreos_gf mount /dev/sda4 /
18:22:46 [2024-10-28T18:22:46.189Z] + guestfish --remote -- mount /dev/sda4 /
18:22:46 [2024-10-28T18:22:46.745Z] + local boot
18:22:46 [2024-10-28T18:22:46.745Z] ++ coreos_gf findfs-label boot
18:22:46 [2024-10-28T18:22:46.745Z] ++ guestfish --remote -- findfs-label boot
18:22:46 [2024-10-28T18:22:46.745Z] + boot=/dev/sda3
18:22:46 [2024-10-28T18:22:46.745Z] + coreos_gf mount /dev/sda3 /boot
18:22:46 [2024-10-28T18:22:46.745Z] + guestfish --remote -- mount /dev/sda3 /boot
18:22:46 [2024-10-28T18:22:46.745Z] + local partitions
18:22:46 [2024-10-28T18:22:46.745Z] + local label
18:22:46 [2024-10-28T18:22:46.745Z] ++ coreos_gf list-partitions
18:22:46 [2024-10-28T18:22:46.745Z] ++ guestfish --remote -- list-partitions
18:22:46 [2024-10-28T18:22:46.745Z] + partitions='/dev/sda1
18:22:46 [2024-10-28T18:22:46.745Z] /dev/sda2
18:22:46 [2024-10-28T18:22:46.745Z] /dev/sda3
18:22:46 [2024-10-28T18:22:46.745Z] /dev/sda4'
18:22:46 [2024-10-28T18:22:46.745Z] + for pt in $partitions
18:22:46 [2024-10-28T18:22:46.745Z] ++ coreos_gf vfs-label /dev/sda1
18:22:46 [2024-10-28T18:22:46.745Z] ++ guestfish --remote -- vfs-label /dev/sda1
18:22:46 [2024-10-28T18:22:46.998Z] + label=
18:22:46 [2024-10-28T18:22:46.998Z] + '[' '' == EFI-SYSTEM ']'
18:22:46 [2024-10-28T18:22:46.998Z] + for pt in $partitions
18:22:46 [2024-10-28T18:22:46.998Z] ++ coreos_gf vfs-label /dev/sda2
18:22:46 [2024-10-28T18:22:46.998Z] ++ guestfish --remote -- vfs-label /dev/sda2
18:22:46 [2024-10-28T18:22:46.998Z] + label=EFI-SYSTEM
18:22:46 [2024-10-28T18:22:46.998Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
18:22:46 [2024-10-28T18:22:46.998Z] + coreos_gf mount /dev/sda2 /boot/efi
18:22:46 [2024-10-28T18:22:46.998Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
18:22:46 [2024-10-28T18:22:46.998Z] + for pt in $partitions
18:22:46 [2024-10-28T18:22:46.998Z] ++ coreos_gf vfs-label /dev/sda3
18:22:46 [2024-10-28T18:22:46.998Z] ++ guestfish --remote -- vfs-label /dev/sda3
18:22:46 [2024-10-28T18:22:46.998Z] + label=boot
18:22:46 [2024-10-28T18:22:46.998Z] + '[' boot == EFI-SYSTEM ']'
18:22:46 [2024-10-28T18:22:46.998Z] + for pt in $partitions
18:22:46 [2024-10-28T18:22:46.998Z] ++ coreos_gf vfs-label /dev/sda4
18:22:46 [2024-10-28T18:22:46.998Z] ++ guestfish --remote -- vfs-label /dev/sda4
18:22:46 [2024-10-28T18:22:46.998Z] + label=root
18:22:46 [2024-10-28T18:22:46.998Z] + '[' root == EFI-SYSTEM ']'
18:22:46 [2024-10-28T18:22:46.998Z] ++ coreos_gf ls /ostree/deploy
18:22:46 [2024-10-28T18:22:46.998Z] ++ guestfish --remote -- ls /ostree/deploy
18:22:46 [2024-10-28T18:22:46.998Z] + stateroot=/ostree/deploy/fedora-coreos
18:22:46 [2024-10-28T18:22:46.998Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
18:22:46 [2024-10-28T18:22:46.998Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
18:22:46 [2024-10-28T18:22:46.998Z] ++ grep -v .origin
18:22:46 [2024-10-28T18:22:46.998Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/955c5fc598451d409bc16478a17c30694e9a9f50ed556af70ebfd1202b116813.0
18:22:46 [2024-10-28T18:22:46.998Z] + export stateroot deploydir
18:22:46 [2024-10-28T18:22:46.998Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
18:22:46 [2024-10-28T18:22:46.998Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
18:22:46 [2024-10-28T18:22:46.998Z] + sed -e '/^options/!d' -e 's/^options\s*//'
18:22:47 [2024-10-28T18:22:47.250Z] + coreos_gf_shutdown
18:22:47 [2024-10-28T18:22:47.250Z] + coreos_gf umount-all
18:22:47 [2024-10-28T18:22:47.250Z] + guestfish --remote -- umount-all
18:22:47 [2024-10-28T18:22:47.250Z] + coreos_gf exit
18:22:47 [2024-10-28T18:22:47.250Z] + guestfish --remote -- exit
18:22:47 [2024-10-28T18:22:47.250Z] + GUESTFISH_RUNNING=
18:22:47 [2024-10-28T18:22:47.250Z] + GUESTFISH_PID=
18:22:47 [2024-10-28T18:22:47.250Z] + _coreos_gf_cleanup
18:22:47 [2024-10-28T18:22:47.250Z] + guestfish --remote -- exit
18:22:47 [2024-10-28T18:22:47.250Z] + :
18:22:47 [2024-10-28T18:22:47.250Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20241028.dev.0
18:22:47 [2024-10-28T18:22:47.250Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
18:22:47 [2024-10-28T18:22:47.250Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
18:22:47 [2024-10-28T18:22:47.250Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
18:22:47 [2024-10-28T18:22:47.250Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
18:22:47 [2024-10-28T18:22:47.250Z] 2024-10-28 18:22:47,201 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', '9444deeda7ba45432cfd2e6f8a0ed75385f1cc6b1f0bb01483038ff50dc01f5a', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
18:22:47 [2024-10-28T18:22:47.503Z] 2024-10-28 18:22:47,254 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpxmzj5afj.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
18:22:49 [2024-10-28T18:22:49.382Z] 2024-10-28 18:22:49,019 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20241028.dev.0', '-volset', 'fedora-coreos-42.20241028.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
18:22:49 [2024-10-28T18:22:49.382Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
18:22:49 [2024-10-28T18:22:49.382Z] genisoimage 1.1.11 (Linux)
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
18:22:49 [2024-10-28T18:22:49.382Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Initial Padblock                        Start Block 0
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Initial Padblock                        Block(s)    16
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Primary Volume Descriptor               Start Block 16
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Primary Volume Descriptor               Block(s)    1
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Eltorito Volume Descriptor              Start Block 17
18:22:49 [2024-10-28T18:22:49.382Z] Size of boot image is 4 sectors -> No emulation
18:22:49 [2024-10-28T18:22:49.382Z] Size of boot image is 13192 sectors -> No emulation
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Eltorito Volume Descriptor              Block(s)    1
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Joliet Volume Descriptor                Start Block 18
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Joliet Volume Descriptor                Block(s)    1
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   End Volume Descriptor                   Start Block 19
18:22:49 [2024-10-28T18:22:49.382Z] Done with: End Volume Descriptor                   Block(s)    1
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Version block                           Start Block 20
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Version block                           Block(s)    1
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Path table                              Start Block 21
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Path table                              Block(s)    4
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Joliet path table                       Start Block 25
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Joliet path table                       Block(s)    4
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Directory tree                          Start Block 29
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Directory tree                          Block(s)    7
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Joliet directory tree                   Start Block 36
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Joliet directory tree                   Block(s)    7
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Directory tree cleanup                  Start Block 43
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Directory tree cleanup                  Block(s)    0
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   Extension record                        Start Block 43
18:22:49 [2024-10-28T18:22:49.382Z] Done with: Extension record                        Block(s)    1
18:22:49 [2024-10-28T18:22:49.382Z] Writing:   The File(s)                             Start Block 44
18:22:49 [2024-10-28T18:22:49.382Z]   0.91% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   1.82% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   2.73% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   3.65% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   4.56% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   5.47% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   6.38% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   7.29% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   8.20% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]   9.11% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  10.02% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  10.93% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  11.84% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  12.75% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  13.67% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  14.58% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  15.49% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  16.40% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  17.31% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  18.22% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  19.13% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  20.04% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  20.95% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  21.86% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  22.78% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.382Z]  23.68% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  24.60% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  25.51% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  26.42% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  27.33% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  28.24% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  29.15% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  30.06% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  30.97% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  31.88% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  32.79% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  33.71% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  34.62% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  35.53% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.636Z]  36.44% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.641Z]  37.35% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.641Z]  38.26% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.641Z]  39.17% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.641Z]  40.08% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.641Z]  40.99% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  41.90% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  42.82% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  43.72% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  44.64% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  45.55% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  46.46% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  47.37% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  48.28% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  49.19% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  50.10% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  51.01% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  51.92% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  52.83% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  53.75% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  54.66% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  55.57% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  56.48% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:49 [2024-10-28T18:22:49.894Z]  57.39% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  58.30% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  59.21% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  60.12% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  61.03% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  61.94% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  62.86% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  63.77% done, estimate finish Mon Oct 28 18:22:49 2024
18:22:50 [2024-10-28T18:22:50.147Z]  64.68% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  65.59% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  66.50% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  67.41% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  68.32% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  69.23% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  70.14% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  71.05% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  71.96% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.147Z]  72.87% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  73.79% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  74.70% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  75.61% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  76.52% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  77.43% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  78.34% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  79.25% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  80.16% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  81.07% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  81.98% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  82.90% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  83.81% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  84.72% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  85.63% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  86.54% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  87.45% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  88.36% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.400Z]  89.27% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  90.18% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  91.09% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  92.01% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  92.91% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  93.83% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  94.74% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  95.65% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  96.56% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  97.47% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  98.38% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z]  99.29% done, estimate finish Mon Oct 28 18:22:50 2024
18:22:50 [2024-10-28T18:22:50.663Z] Total translation table size: 2048
18:22:50 [2024-10-28T18:22:50.663Z] Total rockridge attributes bytes: 3006
18:22:50 [2024-10-28T18:22:50.663Z] Total directory bytes: 12288
18:22:50 [2024-10-28T18:22:50.663Z] Path table size(bytes): 96
18:22:50 [2024-10-28T18:22:50.663Z] Done with: The File(s)                             Block(s)    548703
18:22:50 [2024-10-28T18:22:50.663Z] Writing:   Ending Padblock                         Start Block 548747
18:22:50 [2024-10-28T18:22:50.663Z] Done with: Ending Padblock                         Block(s)    150
18:22:50 [2024-10-28T18:22:50.663Z] Max brk space used 1c000
18:22:50 [2024-10-28T18:22:50.663Z] 548897 extents written (1072 MB)
18:22:50 [2024-10-28T18:22:50.663Z] 2024-10-28 18:22:50,579 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso']
18:22:50 [2024-10-28T18:22:50.663Z] isohybrid: Warning: more than 1024 cylinders: 1073
18:22:50 [2024-10-28T18:22:50.663Z] isohybrid: Not all BIOSes will be able to boot this device
18:22:51 [2024-10-28T18:22:51.219Z] 2024-10-28 18:22:51,035 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20241028.dev.0', '-volset', 'fedora-coreos-42.20241028.dev.0', '-rational-rock', '-J', '-joliet-long', '-eltorito-boot', 'isolinux/isolinux.bin', '-eltorito-catalog', 'isolinux/boot.cat', '-no-emul-boot', '-boot-load-size', '4', '-boot-info-table', '-eltorito-alt-boot', '-efi-boot', 'images/efiboot.img', '-no-emul-boot', '-o', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
18:22:51 [2024-10-28T18:22:51.219Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
18:22:51 [2024-10-28T18:22:51.219Z] genisoimage 1.1.11 (Linux)
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
18:22:51 [2024-10-28T18:22:51.219Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Initial Padblock                        Start Block 0
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Initial Padblock                        Block(s)    16
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Primary Volume Descriptor               Start Block 16
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Primary Volume Descriptor               Block(s)    1
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Eltorito Volume Descriptor              Start Block 17
18:22:51 [2024-10-28T18:22:51.219Z] Size of boot image is 4 sectors -> No emulation
18:22:51 [2024-10-28T18:22:51.219Z] Size of boot image is 13192 sectors -> No emulation
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Eltorito Volume Descriptor              Block(s)    1
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Joliet Volume Descriptor                Start Block 18
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Joliet Volume Descriptor                Block(s)    1
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   End Volume Descriptor                   Start Block 19
18:22:51 [2024-10-28T18:22:51.219Z] Done with: End Volume Descriptor                   Block(s)    1
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Version block                           Start Block 20
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Version block                           Block(s)    1
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Path table                              Start Block 21
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Path table                              Block(s)    4
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Joliet path table                       Start Block 25
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Joliet path table                       Block(s)    4
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Directory tree                          Start Block 29
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Directory tree                          Block(s)    7
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Joliet directory tree                   Start Block 36
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Joliet directory tree                   Block(s)    7
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Directory tree cleanup                  Start Block 43
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Directory tree cleanup                  Block(s)    0
18:22:51 [2024-10-28T18:22:51.219Z] Writing:   Extension record                        Start Block 43
18:22:51 [2024-10-28T18:22:51.219Z] Done with: Extension record                        Block(s)    1
18:22:51 [2024-10-28T18:22:51.220Z] Writing:   The File(s)                             Start Block 44
18:22:51 [2024-10-28T18:22:51.220Z]   8.56% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  17.09% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  25.64% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  34.17% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  42.72% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  51.24% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  59.80% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  68.32% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.220Z]  76.87% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.225Z]  85.40% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.225Z]  93.94% done, estimate finish Mon Oct 28 18:22:51 2024
18:22:51 [2024-10-28T18:22:51.225Z] Total translation table size: 2048
18:22:51 [2024-10-28T18:22:51.225Z] Total rockridge attributes bytes: 2842
18:22:51 [2024-10-28T18:22:51.225Z] Total directory bytes: 12288
18:22:51 [2024-10-28T18:22:51.225Z] Path table size(bytes): 96
18:22:51 [2024-10-28T18:22:51.225Z] Done with: The File(s)                             Block(s)    58362
18:22:51 [2024-10-28T18:22:51.225Z] Writing:   Ending Padblock                         Start Block 58406
18:22:51 [2024-10-28T18:22:51.225Z] Done with: Ending Padblock                         Block(s)    150
18:22:51 [2024-10-28T18:22:51.225Z] Max brk space used 1b000
18:22:51 [2024-10-28T18:22:51.225Z] 58556 extents written (114 MB)
18:22:51 [2024-10-28T18:22:51.225Z] 2024-10-28 18:22:51,143 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal']
18:22:51 [2024-10-28T18:22:51.225Z] 2024-10-28 18:22:51,178 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241028.dev.0/x86_64/fedora-coreos-42.20241028.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal', '--consume']
18:23:09 [2024-10-28T18:23:09.311Z] + RUST_BACKTRACE=full
18:23:09 [2024-10-28T18:23:09.311Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/955c5fc598451d409bc16478a17c30694e9a9f50ed556af70ebfd1202b116813.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack minimal-iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241028.dev.0-live.x86_64.iso.minimal --consume
18:23:09 [2024-10-28T18:23:09.311Z] Packing minimal ISO
18:23:09 [2024-10-28T18:23:09.311Z] Matched 17 files of 17
18:23:09 [2024-10-28T18:23:09.311Z] Total bytes skipped: 119504195
18:23:09 [2024-10-28T18:23:09.311Z] Total bytes written: 1082045
18:23:09 [2024-10-28T18:23:09.311Z] Total bytes written (compressed): 2884
18:23:09 [2024-10-28T18:23:09.311Z] Verifying that packed image matches digest
18:23:09 [2024-10-28T18:23:09.311Z] Packing successful!
18:23:09 [2024-10-28T18:23:09.311Z] + '[' -f /var/tmp/coreos-installer-output ']'
18:23:14 [2024-10-28T18:23:14.542Z] Updated: builds/42.20241028.dev.0/x86_64/meta.json