Console Output

16:20:25 [2024-10-23T16:20:25.439Z] + set -xeuo pipefail
16:20:25 [2024-10-23T16:20:25.439Z] ++ umask
16:20:25 [2024-10-23T16:20:25.439Z] + '[' 0022 = 0000 ']'
16:20:25 [2024-10-23T16:20:25.439Z] + cosa buildextend-live --fast
16:20:25 [2024-10-23T16:20:25.439Z] Targeting build: 40.20241023.dev.0
16:20:25 [2024-10-23T16:20:25.692Z] 2024-10-23 16:20:25,507 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', 'fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049', '/usr/lib/modules']
16:20:25 [2024-10-23T16:20:25.692Z] 2024-10-23 16:20:25,516 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.11.3-200.fc40.x86_64/vmlinuz', 'fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:20:25 [2024-10-23T16:20:25.692Z] 2024-10-23 16:20:25,566 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.11.3-200.fc40.x86_64/initramfs.img', 'fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:20:25 [2024-10-23T16:20:25.945Z] 2024-10-23 16:20:25,770 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', 'fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049', '/usr/share/coreos-installer/example-config.yaml']
16:20:25 [2024-10-23T16:20:25.945Z] 2024-10-23 16:20:25,788 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', 'fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049', '/tmp/tmpff_xr44n']
16:20:25 [2024-10-23T16:20:25.945Z] Generating osmet file for 512b metal image
16:20:25 [2024-10-23T16:20:25.945Z] 2024-10-23 16:20:25,805 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 40.20241023.dev.0', '--checksum', '3111e873c4f160759580ee3ea3e2045b6f98a01b6213adeccba175973bff92a0', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:20:43 [2024-10-23T16:20:43.947Z] + RUST_BACKTRACE=full
16:20:43 [2024-10-23T16:20:43.947Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 40.20241023.dev.0' --checksum 3111e873c4f160759580ee3ea3e2045b6f98a01b6213adeccba175973bff92a0 --output /var/tmp/coreos-installer-output --fast
16:20:44 [2024-10-23T16:20:44.503Z] Total OSTree objects scanned from /root: 17934 (17928 mapped, 6 empty)
16:20:44 [2024-10-23T16:20:44.503Z] Total OSTree objects found in /boot: 312
16:20:44 [2024-10-23T16:20:44.504Z] Duplicate extents dropped: 0
16:20:44 [2024-10-23T16:20:44.504Z] Overlapping extents clamped: 0
16:20:44 [2024-10-23T16:20:44.504Z] Total /root extents: 17929
16:20:44 [2024-10-23T16:20:44.504Z] Duplicate extents dropped: 0
16:20:44 [2024-10-23T16:20:44.504Z] Overlapping extents clamped: 0
16:20:44 [2024-10-23T16:20:44.504Z] Total /boot extents: 317
16:20:44 [2024-10-23T16:20:44.504Z] Packing image
16:20:59 [2024-10-23T16:20:59.307Z] Total bytes skipped: 1678257152
16:20:59 [2024-10-23T16:20:59.307Z] Total bytes written: 1099420672
16:20:59 [2024-10-23T16:20:59.307Z] Total bytes written (compressed): 23162888
16:20:59 [2024-10-23T16:20:59.307Z] Verifying that repacked image matches digest
16:21:09 [2024-10-23T16:21:09.229Z] Packing successful!
16:21:09 [2024-10-23T16:21:09.229Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:21:09 [2024-10-23T16:21:09.229Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:21:11 [2024-10-23T16:21:11.110Z] Generating osmet file for 4k metal image
16:21:11 [2024-10-23T16:21:11.110Z] 2024-10-23 16:21:10,651 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-40.20241023.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 40.20241023.dev.0', '--checksum', '51f4422559f7c741b3f16f3f1ae26111817cae5f6c3e03ebf2e0b57d7f07d0b5', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:21:29 [2024-10-23T16:21:29.112Z] + RUST_BACKTRACE=full
16:21:29 [2024-10-23T16:21:29.112Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 40.20241023.dev.0' --checksum 51f4422559f7c741b3f16f3f1ae26111817cae5f6c3e03ebf2e0b57d7f07d0b5 --output /var/tmp/coreos-installer-output --fast
16:21:29 [2024-10-23T16:21:29.112Z] Total OSTree objects scanned from /root: 17934 (17928 mapped, 6 empty)
16:21:29 [2024-10-23T16:21:29.112Z] Total OSTree objects found in /boot: 3
16:21:29 [2024-10-23T16:21:29.112Z] Duplicate extents dropped: 0
16:21:29 [2024-10-23T16:21:29.112Z] Overlapping extents clamped: 0
16:21:29 [2024-10-23T16:21:29.112Z] Total /root extents: 17929
16:21:29 [2024-10-23T16:21:29.112Z] Duplicate extents dropped: 0
16:21:29 [2024-10-23T16:21:29.112Z] Overlapping extents clamped: 0
16:21:29 [2024-10-23T16:21:29.112Z] Total /boot extents: 6
16:21:29 [2024-10-23T16:21:29.112Z] Packing image
16:21:41 [2024-10-23T16:21:41.257Z] Total bytes skipped: 1668288512
16:21:41 [2024-10-23T16:21:41.257Z] Total bytes written: 1109389312
16:21:41 [2024-10-23T16:21:41.257Z] Total bytes written (compressed): 22742572
16:21:41 [2024-10-23T16:21:41.257Z] Verifying that repacked image matches digest
16:21:51 [2024-10-23T16:21:51.174Z] Packing successful!
16:21:51 [2024-10-23T16:21:51.174Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:21:51 [2024-10-23T16:21:51.174Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:21:52 [2024-10-23T16:21:52.098Z] Compressing squashfs with lz4
16:21:52 [2024-10-23T16:21:52.098Z] 2024-10-23 16:21:51,801 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
16:21:52 [2024-10-23T16:21:52.098Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:21:52 [2024-10-23T16:21:52.098Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
16:21:52 [2024-10-23T16:21:52.098Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF
16:21:52 [2024-10-23T16:21:52.098Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/image.squashfs
16:21:52 [2024-10-23T16:21:52.098Z] + coreos_gf_run_mount builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:21:52 [2024-10-23T16:21:52.098Z] + local mntarg=mount
16:21:52 [2024-10-23T16:21:52.098Z] + '[' builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw = ro ']'
16:21:52 [2024-10-23T16:21:52.098Z] + coreos_gf_run builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:21:52 [2024-10-23T16:21:52.098Z] + '[' -n '' ']'
16:21:52 [2024-10-23T16:21:52.098Z] + coreos_gf_launch builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:21:52 [2024-10-23T16:21:52.098Z] + '[' -n '' ']'
16:21:52 [2024-10-23T16:21:52.098Z] ++ guestfish --listen -a builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:21:52 [2024-10-23T16:21:52.098Z] + eval 'GUESTFISH_PID=12012; export GUESTFISH_PID'
16:21:52 [2024-10-23T16:21:52.098Z] ++ GUESTFISH_PID=12012
16:21:52 [2024-10-23T16:21:52.098Z] ++ export GUESTFISH_PID
16:21:52 [2024-10-23T16:21:52.098Z] + '[' -z 12012 ']'
16:21:52 [2024-10-23T16:21:52.098Z] ++ kola ncpu
16:21:52 [2024-10-23T16:21:52.098Z] + coreos_gf set-smp 6
16:21:52 [2024-10-23T16:21:52.098Z] + guestfish --remote -- set-smp 6
16:21:52 [2024-10-23T16:21:52.098Z] + coreos_gf run
16:21:52 [2024-10-23T16:21:52.098Z] + guestfish --remote -- run
16:21:53 [2024-10-23T16:21:53.974Z] + GUESTFISH_RUNNING=1
16:21:53 [2024-10-23T16:21:53.974Z] ++ coreos_gf findfs-label root
16:21:53 [2024-10-23T16:21:53.974Z] ++ guestfish --remote -- findfs-label root
16:21:53 [2024-10-23T16:21:53.974Z] + root=/dev/sda4
16:21:53 [2024-10-23T16:21:53.974Z] + coreos_gf mount /dev/sda4 /
16:21:53 [2024-10-23T16:21:53.974Z] + guestfish --remote -- mount /dev/sda4 /
16:21:54 [2024-10-23T16:21:54.534Z] + local boot
16:21:54 [2024-10-23T16:21:54.534Z] ++ coreos_gf findfs-label boot
16:21:54 [2024-10-23T16:21:54.534Z] ++ guestfish --remote -- findfs-label boot
16:21:54 [2024-10-23T16:21:54.534Z] + boot=/dev/sda3
16:21:54 [2024-10-23T16:21:54.534Z] + coreos_gf mount /dev/sda3 /boot
16:21:54 [2024-10-23T16:21:54.534Z] + guestfish --remote -- mount /dev/sda3 /boot
16:21:54 [2024-10-23T16:21:54.534Z] + local partitions
16:21:54 [2024-10-23T16:21:54.534Z] + local label
16:21:54 [2024-10-23T16:21:54.534Z] ++ coreos_gf list-partitions
16:21:54 [2024-10-23T16:21:54.534Z] ++ guestfish --remote -- list-partitions
16:21:54 [2024-10-23T16:21:54.534Z] + partitions='/dev/sda1
16:21:54 [2024-10-23T16:21:54.534Z] /dev/sda2
16:21:54 [2024-10-23T16:21:54.534Z] /dev/sda3
16:21:54 [2024-10-23T16:21:54.534Z] /dev/sda4'
16:21:54 [2024-10-23T16:21:54.534Z] + for pt in $partitions
16:21:54 [2024-10-23T16:21:54.534Z] ++ coreos_gf vfs-label /dev/sda1
16:21:54 [2024-10-23T16:21:54.534Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:21:54 [2024-10-23T16:21:54.534Z] + label=
16:21:54 [2024-10-23T16:21:54.534Z] + '[' '' == EFI-SYSTEM ']'
16:21:54 [2024-10-23T16:21:54.534Z] + for pt in $partitions
16:21:54 [2024-10-23T16:21:54.534Z] ++ coreos_gf vfs-label /dev/sda2
16:21:54 [2024-10-23T16:21:54.534Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:21:54 [2024-10-23T16:21:54.788Z] + label=EFI-SYSTEM
16:21:54 [2024-10-23T16:21:54.788Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:21:54 [2024-10-23T16:21:54.788Z] + coreos_gf mount /dev/sda2 /boot/efi
16:21:54 [2024-10-23T16:21:54.788Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:21:54 [2024-10-23T16:21:54.788Z] + for pt in $partitions
16:21:54 [2024-10-23T16:21:54.788Z] ++ coreos_gf vfs-label /dev/sda3
16:21:54 [2024-10-23T16:21:54.788Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:21:54 [2024-10-23T16:21:54.788Z] + label=boot
16:21:54 [2024-10-23T16:21:54.788Z] + '[' boot == EFI-SYSTEM ']'
16:21:54 [2024-10-23T16:21:54.789Z] + for pt in $partitions
16:21:54 [2024-10-23T16:21:54.789Z] ++ coreos_gf vfs-label /dev/sda4
16:21:54 [2024-10-23T16:21:54.789Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:21:54 [2024-10-23T16:21:54.789Z] + label=root
16:21:54 [2024-10-23T16:21:54.789Z] + '[' root == EFI-SYSTEM ']'
16:21:54 [2024-10-23T16:21:54.789Z] ++ coreos_gf ls /ostree/deploy
16:21:54 [2024-10-23T16:21:54.789Z] ++ guestfish --remote -- ls /ostree/deploy
16:21:54 [2024-10-23T16:21:54.789Z] + stateroot=/ostree/deploy/fedora-coreos
16:21:54 [2024-10-23T16:21:54.789Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:21:54 [2024-10-23T16:21:54.789Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:21:54 [2024-10-23T16:21:54.789Z] ++ grep -v .origin
16:21:54 [2024-10-23T16:21:54.789Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049.0
16:21:54 [2024-10-23T16:21:54.789Z] + export stateroot deploydir
16:21:54 [2024-10-23T16:21:54.789Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/config
16:21:54 [2024-10-23T16:21:54.789Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/config
16:21:54 [2024-10-23T16:21:54.789Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/config
16:21:54 [2024-10-23T16:21:54.789Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/config.new /ostree/repo/config
16:21:54 [2024-10-23T16:21:54.789Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/config.new /ostree/repo/config
16:21:55 [2024-10-23T16:21:55.042Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
16:21:55 [2024-10-23T16:21:55.042Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
16:21:55 [2024-10-23T16:21:55.042Z] + kernel_binary=/boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/vmlinuz-6.11.3-200.fc40.x86_64
16:21:55 [2024-10-23T16:21:55.042Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
16:21:55 [2024-10-23T16:21:55.042Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
16:21:55 [2024-10-23T16:21:55.042Z] + kernel_hmac=/boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/.vmlinuz-6.11.3-200.fc40.x86_64.hmac
16:21:55 [2024-10-23T16:21:55.042Z] ++ basename /boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/.vmlinuz-6.11.3-200.fc40.x86_64.hmac
16:21:55 [2024-10-23T16:21:55.042Z] + coreos_gf ln /boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/.vmlinuz-6.11.3-200.fc40.x86_64.hmac /boot/.vmlinuz-6.11.3-200.fc40.x86_64.hmac
16:21:55 [2024-10-23T16:21:55.042Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/.vmlinuz-6.11.3-200.fc40.x86_64.hmac /boot/.vmlinuz-6.11.3-200.fc40.x86_64.hmac
16:21:55 [2024-10-23T16:21:55.042Z] ++ basename /boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/vmlinuz-6.11.3-200.fc40.x86_64
16:21:55 [2024-10-23T16:21:55.042Z] + coreos_gf ln /boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/vmlinuz-6.11.3-200.fc40.x86_64 /boot/vmlinuz-6.11.3-200.fc40.x86_64
16:21:55 [2024-10-23T16:21:55.042Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-d4863af533132602245b7eb7ce7b51910593e021a3bf9527fdf7277080615689/vmlinuz-6.11.3-200.fc40.x86_64 /boot/vmlinuz-6.11.3-200.fc40.x86_64
16:21:55 [2024-10-23T16:21:55.042Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/image.squashfs compress:lz4
16:21:55 [2024-10-23T16:21:55.042Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/image.squashfs compress:lz4
16:22:03 [2024-10-23T16:22:03.112Z] + coreos_gf_shutdown
16:22:03 [2024-10-23T16:22:03.112Z] + coreos_gf umount-all
16:22:03 [2024-10-23T16:22:03.112Z] + guestfish --remote -- umount-all
16:22:03 [2024-10-23T16:22:03.367Z] + coreos_gf exit
16:22:03 [2024-10-23T16:22:03.367Z] + guestfish --remote -- exit
16:22:03 [2024-10-23T16:22:03.923Z] + GUESTFISH_RUNNING=
16:22:03 [2024-10-23T16:22:03.923Z] + GUESTFISH_PID=
16:22:03 [2024-10-23T16:22:03.923Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:22:03 [2024-10-23T16:22:03.923Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.H9LhoF -rf
16:22:03 [2024-10-23T16:22:03.923Z] + _coreos_gf_cleanup
16:22:03 [2024-10-23T16:22:03.923Z] + guestfish --remote -- exit
16:22:03 [2024-10-23T16:22:03.923Z] + :
16:22:09 [2024-10-23T16:22:09.144Z] 2024-10-23 16:22:08,925 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw']
16:22:09 [2024-10-23T16:22:09.144Z] + coreos_gf_run_mount builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:22:09 [2024-10-23T16:22:09.144Z] + local mntarg=mount
16:22:09 [2024-10-23T16:22:09.144Z] + '[' builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw = ro ']'
16:22:09 [2024-10-23T16:22:09.144Z] + coreos_gf_run builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:22:09 [2024-10-23T16:22:09.144Z] + '[' -n '' ']'
16:22:09 [2024-10-23T16:22:09.144Z] + coreos_gf_launch builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:22:09 [2024-10-23T16:22:09.144Z] + '[' -n '' ']'
16:22:09 [2024-10-23T16:22:09.144Z] ++ guestfish --listen -a builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw --ro
16:22:09 [2024-10-23T16:22:09.144Z] + eval 'GUESTFISH_PID=12153; export GUESTFISH_PID'
16:22:09 [2024-10-23T16:22:09.144Z] ++ GUESTFISH_PID=12153
16:22:09 [2024-10-23T16:22:09.144Z] ++ export GUESTFISH_PID
16:22:09 [2024-10-23T16:22:09.144Z] + '[' -z 12153 ']'
16:22:09 [2024-10-23T16:22:09.144Z] ++ kola ncpu
16:22:09 [2024-10-23T16:22:09.397Z] + coreos_gf set-smp 6
16:22:09 [2024-10-23T16:22:09.397Z] + guestfish --remote -- set-smp 6
16:22:09 [2024-10-23T16:22:09.397Z] + coreos_gf run
16:22:09 [2024-10-23T16:22:09.397Z] + guestfish --remote -- run
16:22:10 [2024-10-23T16:22:10.754Z] + GUESTFISH_RUNNING=1
16:22:10 [2024-10-23T16:22:10.754Z] ++ coreos_gf findfs-label root
16:22:10 [2024-10-23T16:22:10.754Z] ++ guestfish --remote -- findfs-label root
16:22:11 [2024-10-23T16:22:11.008Z] + root=/dev/sda4
16:22:11 [2024-10-23T16:22:11.008Z] + coreos_gf mount /dev/sda4 /
16:22:11 [2024-10-23T16:22:11.008Z] + guestfish --remote -- mount /dev/sda4 /
16:22:11 [2024-10-23T16:22:11.563Z] + local boot
16:22:11 [2024-10-23T16:22:11.563Z] ++ coreos_gf findfs-label boot
16:22:11 [2024-10-23T16:22:11.563Z] ++ guestfish --remote -- findfs-label boot
16:22:11 [2024-10-23T16:22:11.563Z] + boot=/dev/sda3
16:22:11 [2024-10-23T16:22:11.563Z] + coreos_gf mount /dev/sda3 /boot
16:22:11 [2024-10-23T16:22:11.563Z] + guestfish --remote -- mount /dev/sda3 /boot
16:22:11 [2024-10-23T16:22:11.563Z] + local partitions
16:22:11 [2024-10-23T16:22:11.563Z] + local label
16:22:11 [2024-10-23T16:22:11.563Z] ++ coreos_gf list-partitions
16:22:11 [2024-10-23T16:22:11.563Z] ++ guestfish --remote -- list-partitions
16:22:11 [2024-10-23T16:22:11.563Z] + partitions='/dev/sda1
16:22:11 [2024-10-23T16:22:11.563Z] /dev/sda2
16:22:11 [2024-10-23T16:22:11.563Z] /dev/sda3
16:22:11 [2024-10-23T16:22:11.563Z] /dev/sda4'
16:22:11 [2024-10-23T16:22:11.563Z] + for pt in $partitions
16:22:11 [2024-10-23T16:22:11.563Z] ++ coreos_gf vfs-label /dev/sda1
16:22:11 [2024-10-23T16:22:11.563Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:22:11 [2024-10-23T16:22:11.563Z] + label=
16:22:11 [2024-10-23T16:22:11.563Z] + '[' '' == EFI-SYSTEM ']'
16:22:11 [2024-10-23T16:22:11.563Z] + for pt in $partitions
16:22:11 [2024-10-23T16:22:11.563Z] ++ coreos_gf vfs-label /dev/sda2
16:22:11 [2024-10-23T16:22:11.563Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:22:11 [2024-10-23T16:22:11.563Z] + label=EFI-SYSTEM
16:22:11 [2024-10-23T16:22:11.563Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:22:11 [2024-10-23T16:22:11.563Z] + coreos_gf mount /dev/sda2 /boot/efi
16:22:11 [2024-10-23T16:22:11.563Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:22:11 [2024-10-23T16:22:11.815Z] + for pt in $partitions
16:22:11 [2024-10-23T16:22:11.815Z] ++ coreos_gf vfs-label /dev/sda3
16:22:11 [2024-10-23T16:22:11.815Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:22:11 [2024-10-23T16:22:11.815Z] + label=boot
16:22:11 [2024-10-23T16:22:11.815Z] + '[' boot == EFI-SYSTEM ']'
16:22:11 [2024-10-23T16:22:11.815Z] + for pt in $partitions
16:22:11 [2024-10-23T16:22:11.815Z] ++ coreos_gf vfs-label /dev/sda4
16:22:11 [2024-10-23T16:22:11.815Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:22:11 [2024-10-23T16:22:11.815Z] + label=root
16:22:11 [2024-10-23T16:22:11.815Z] + '[' root == EFI-SYSTEM ']'
16:22:11 [2024-10-23T16:22:11.815Z] ++ coreos_gf ls /ostree/deploy
16:22:11 [2024-10-23T16:22:11.815Z] ++ guestfish --remote -- ls /ostree/deploy
16:22:11 [2024-10-23T16:22:11.815Z] + stateroot=/ostree/deploy/fedora-coreos
16:22:11 [2024-10-23T16:22:11.815Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:22:11 [2024-10-23T16:22:11.815Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:22:11 [2024-10-23T16:22:11.815Z] ++ grep -v .origin
16:22:11 [2024-10-23T16:22:11.815Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049.0
16:22:11 [2024-10-23T16:22:11.815Z] + export stateroot deploydir
16:22:11 [2024-10-23T16:22:11.815Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
16:22:11 [2024-10-23T16:22:11.815Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
16:22:11 [2024-10-23T16:22:11.815Z] + sed -e '/^options/!d' -e 's/^options\s*//'
16:22:11 [2024-10-23T16:22:11.815Z] + coreos_gf_shutdown
16:22:11 [2024-10-23T16:22:11.815Z] + coreos_gf umount-all
16:22:11 [2024-10-23T16:22:11.815Z] + guestfish --remote -- umount-all
16:22:12 [2024-10-23T16:22:12.074Z] + coreos_gf exit
16:22:12 [2024-10-23T16:22:12.074Z] + guestfish --remote -- exit
16:22:12 [2024-10-23T16:22:12.074Z] + GUESTFISH_RUNNING=
16:22:12 [2024-10-23T16:22:12.074Z] + GUESTFISH_PID=
16:22:12 [2024-10-23T16:22:12.074Z] + _coreos_gf_cleanup
16:22:12 [2024-10-23T16:22:12.074Z] + guestfish --remote -- exit
16:22:12 [2024-10-23T16:22:12.074Z] + :
16:22:12 [2024-10-23T16:22:12.074Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-40.20241023.dev.0
16:22:12 [2024-10-23T16:22:12.074Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
16:22:12 [2024-10-23T16:22:12.327Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
16:22:12 [2024-10-23T16:22:12.327Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
16:22:12 [2024-10-23T16:22:12.327Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
16:22:12 [2024-10-23T16:22:12.327Z] 2024-10-23 16:22:12,215 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', 'fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
16:22:12 [2024-10-23T16:22:12.884Z] 2024-10-23 16:22:12,816 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpelnav81f.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
16:22:14 [2024-10-23T16:22:14.771Z] 2024-10-23 16:22:14,671 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-40.20241023.dev.0', '-volset', 'fedora-coreos-40.20241023.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-40.20241023.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:22:14 [2024-10-23T16:22:14.771Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:22:14 [2024-10-23T16:22:14.771Z] genisoimage 1.1.11 (Linux)
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:22:14 [2024-10-23T16:22:14.771Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Initial Padblock                        Start Block 0
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Initial Padblock                        Block(s)    16
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Primary Volume Descriptor               Start Block 16
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Primary Volume Descriptor               Block(s)    1
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:22:14 [2024-10-23T16:22:14.771Z] Size of boot image is 4 sectors -> No emulation
16:22:14 [2024-10-23T16:22:14.771Z] Size of boot image is 12996 sectors -> No emulation
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   End Volume Descriptor                   Start Block 19
16:22:14 [2024-10-23T16:22:14.771Z] Done with: End Volume Descriptor                   Block(s)    1
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Version block                           Start Block 20
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Version block                           Block(s)    1
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Path table                              Start Block 21
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Path table                              Block(s)    4
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Joliet path table                       Start Block 25
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Joliet path table                       Block(s)    4
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Directory tree                          Start Block 29
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Directory tree                          Block(s)    7
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Joliet directory tree                   Start Block 36
16:22:14 [2024-10-23T16:22:14.771Z] Done with: Joliet directory tree                   Block(s)    7
16:22:14 [2024-10-23T16:22:14.771Z] Writing:   Directory tree cleanup                  Start Block 43
16:22:14 [2024-10-23T16:22:14.772Z] Done with: Directory tree cleanup                  Block(s)    0
16:22:14 [2024-10-23T16:22:14.772Z] Writing:   Extension record                        Start Block 43
16:22:14 [2024-10-23T16:22:14.772Z] Done with: Extension record                        Block(s)    1
16:22:14 [2024-10-23T16:22:14.772Z] Writing:   The File(s)                             Start Block 44
16:22:14 [2024-10-23T16:22:14.772Z]   0.89% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:14 [2024-10-23T16:22:14.772Z]   1.78% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:14 [2024-10-23T16:22:14.772Z]   2.66% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:14 [2024-10-23T16:22:14.772Z]   3.55% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:14 [2024-10-23T16:22:14.772Z]   4.44% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]   5.33% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]   6.22% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]   7.11% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]   7.99% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]   8.88% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]   9.77% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  10.66% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  11.55% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  12.43% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  13.32% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  14.21% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  15.10% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  15.98% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  16.87% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  17.76% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  18.65% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  19.54% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  20.43% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  21.31% done, estimate finish Wed Oct 23 16:22:14 2024
16:22:15 [2024-10-23T16:22:15.024Z]  22.20% done, estimate finish Wed Oct 23 16:22:18 2024
16:22:15 [2024-10-23T16:22:15.024Z]  23.09% done, estimate finish Wed Oct 23 16:22:18 2024
16:22:15 [2024-10-23T16:22:15.277Z]  23.98% done, estimate finish Wed Oct 23 16:22:18 2024
16:22:15 [2024-10-23T16:22:15.277Z]  24.86% done, estimate finish Wed Oct 23 16:22:18 2024
16:22:15 [2024-10-23T16:22:15.277Z]  25.75% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.277Z]  26.64% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.277Z]  27.53% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.277Z]  28.42% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.277Z]  29.31% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.277Z]  30.19% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.282Z]  31.08% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.282Z]  31.97% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.282Z]  32.86% done, estimate finish Wed Oct 23 16:22:17 2024
16:22:15 [2024-10-23T16:22:15.282Z]  33.74% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.282Z]  34.63% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.282Z]  35.52% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.282Z]  36.41% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.282Z]  37.30% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.282Z]  38.19% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.282Z]  39.07% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  39.96% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  40.85% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  41.74% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  42.62% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  43.51% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  44.40% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  45.29% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  46.18% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  47.07% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  47.95% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  48.84% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  49.73% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:15 [2024-10-23T16:22:15.535Z]  50.62% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.535Z]  51.50% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.535Z]  52.39% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.535Z]  53.28% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.535Z]  54.17% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.535Z]  55.06% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  55.95% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  56.83% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  57.72% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  58.61% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  59.50% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  60.38% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  61.27% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  62.16% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  63.05% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  63.94% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  64.83% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  65.71% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  66.60% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  67.49% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  68.38% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  69.26% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:15 [2024-10-23T16:22:15.789Z]  70.15% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  71.04% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  71.93% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  72.82% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  73.71% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  74.59% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  75.48% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  76.37% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  77.26% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  78.14% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  79.03% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  79.92% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  80.81% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  81.70% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  82.59% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  83.47% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  84.36% done, estimate finish Wed Oct 23 16:22:15 2024
16:22:16 [2024-10-23T16:22:16.046Z]  85.25% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.046Z]  86.14% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.046Z]  87.02% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.298Z]  87.91% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.298Z]  88.80% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  89.69% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  90.58% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  91.46% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  92.35% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  93.24% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  94.13% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  95.02% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  95.90% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  96.79% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  97.68% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  98.57% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z]  99.45% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.299Z] Total translation table size: 2048
16:22:16 [2024-10-23T16:22:16.299Z] Total rockridge attributes bytes: 3006
16:22:16 [2024-10-23T16:22:16.299Z] Total directory bytes: 12288
16:22:16 [2024-10-23T16:22:16.299Z] Path table size(bytes): 96
16:22:16 [2024-10-23T16:22:16.299Z] Done with: The File(s)                             Block(s)    562880
16:22:16 [2024-10-23T16:22:16.299Z] Writing:   Ending Padblock                         Start Block 562924
16:22:16 [2024-10-23T16:22:16.299Z] Done with: Ending Padblock                         Block(s)    150
16:22:16 [2024-10-23T16:22:16.299Z] Max brk space used 1c000
16:22:16 [2024-10-23T16:22:16.299Z] 563074 extents written (1099 MB)
16:22:16 [2024-10-23T16:22:16.299Z] 2024-10-23 16:22:16,263 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-40.20241023.dev.0-live.x86_64.iso']
16:22:16 [2024-10-23T16:22:16.299Z] isohybrid: Warning: more than 1024 cylinders: 1100
16:22:16 [2024-10-23T16:22:16.299Z] isohybrid: Not all BIOSes will be able to boot this device
16:22:16 [2024-10-23T16:22:16.854Z] 2024-10-23 16:22:16,730 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-40.20241023.dev.0', '-volset', 'fedora-coreos-40.20241023.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-40.20241023.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:22:16 [2024-10-23T16:22:16.854Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:22:16 [2024-10-23T16:22:16.854Z] genisoimage 1.1.11 (Linux)
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:22:16 [2024-10-23T16:22:16.854Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Initial Padblock                        Start Block 0
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Initial Padblock                        Block(s)    16
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Primary Volume Descriptor               Start Block 16
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Primary Volume Descriptor               Block(s)    1
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:22:16 [2024-10-23T16:22:16.854Z] Size of boot image is 4 sectors -> No emulation
16:22:16 [2024-10-23T16:22:16.854Z] Size of boot image is 12996 sectors -> No emulation
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   End Volume Descriptor                   Start Block 19
16:22:16 [2024-10-23T16:22:16.854Z] Done with: End Volume Descriptor                   Block(s)    1
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Version block                           Start Block 20
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Version block                           Block(s)    1
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Path table                              Start Block 21
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Path table                              Block(s)    4
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Joliet path table                       Start Block 25
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Joliet path table                       Block(s)    4
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Directory tree                          Start Block 29
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Directory tree                          Block(s)    7
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Joliet directory tree                   Start Block 36
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Joliet directory tree                   Block(s)    7
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Directory tree cleanup                  Start Block 43
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Directory tree cleanup                  Block(s)    0
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Extension record                        Start Block 43
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Extension record                        Block(s)    1
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   The File(s)                             Start Block 44
16:22:16 [2024-10-23T16:22:16.854Z]   8.68% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  17.32% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  25.99% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  34.63% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  43.29% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  51.94% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  60.60% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  69.24% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  77.91% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  86.57% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z]  95.21% done, estimate finish Wed Oct 23 16:22:16 2024
16:22:16 [2024-10-23T16:22:16.854Z] Total translation table size: 2048
16:22:16 [2024-10-23T16:22:16.854Z] Total rockridge attributes bytes: 2842
16:22:16 [2024-10-23T16:22:16.854Z] Total directory bytes: 12288
16:22:16 [2024-10-23T16:22:16.854Z] Path table size(bytes): 96
16:22:16 [2024-10-23T16:22:16.854Z] Done with: The File(s)                             Block(s)    57580
16:22:16 [2024-10-23T16:22:16.854Z] Writing:   Ending Padblock                         Start Block 57624
16:22:16 [2024-10-23T16:22:16.854Z] Done with: Ending Padblock                         Block(s)    150
16:22:16 [2024-10-23T16:22:16.854Z] Max brk space used 1b000
16:22:16 [2024-10-23T16:22:16.854Z] 57774 extents written (112 MB)
16:22:16 [2024-10-23T16:22:16.854Z] 2024-10-23 16:22:16,838 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-40.20241023.dev.0-live.x86_64.iso.minimal']
16:22:17 [2024-10-23T16:22:17.108Z] 2024-10-23 16:22:16,872 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/40.20241023.dev.0/x86_64/fedora-coreos-40.20241023.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-40.20241023.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-40.20241023.dev.0-live.x86_64.iso.minimal', '--consume']
16:22:35 [2024-10-23T16:22:35.122Z] + RUST_BACKTRACE=full
16:22:35 [2024-10-23T16:22:35.122Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/fb71d7e61d300c70127673edab16cdc07162ed48691b9a4c4df1d9c087428049.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-40.20241023.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-40.20241023.dev.0-live.x86_64.iso.minimal --consume
16:22:35 [2024-10-23T16:22:35.122Z] Packing minimal ISO
16:22:35 [2024-10-23T16:22:35.122Z] Matched 17 files of 17
16:22:35 [2024-10-23T16:22:35.122Z] Total bytes skipped: 117900535
16:22:35 [2024-10-23T16:22:35.122Z] Total bytes written: 588553
16:22:35 [2024-10-23T16:22:35.122Z] Total bytes written (compressed): 2804
16:22:35 [2024-10-23T16:22:35.122Z] Verifying that packed image matches digest
16:22:35 [2024-10-23T16:22:35.122Z] Packing successful!
16:22:35 [2024-10-23T16:22:35.122Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:22:38 [2024-10-23T16:22:38.370Z] Updated: builds/40.20241023.dev.0/x86_64/meta.json