Console Output

19:30:49 [2024-10-25T19:30:49.289Z] + set -xeuo pipefail
19:30:49 [2024-10-25T19:30:49.289Z] ++ umask
19:30:49 [2024-10-25T19:30:49.289Z] + '[' 0022 = 0000 ']'
19:30:49 [2024-10-25T19:30:49.289Z] + cosa buildextend-live --fast
19:30:49 [2024-10-25T19:30:49.289Z] Targeting build: 42.20241025.dev.0
19:30:49 [2024-10-25T19:30:49.542Z] 2024-10-25 19:30:49,364 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', 'c2c90a83bcfb252a24285f897a723c24cce3b7f7376c2859b95df5275cdf2722', '/usr/lib/modules']
19:30:49 [2024-10-25T19:30:49.542Z] 2024-10-25 19:30:49,374 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.20241025gitae90f6a6170d.42.fc42.x86_64/vmlinuz', 'c2c90a83bcfb252a24285f897a723c24cce3b7f7376c2859b95df5275cdf2722', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
19:30:49 [2024-10-25T19:30:49.542Z] 2024-10-25 19:30:49,429 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.20241025gitae90f6a6170d.42.fc42.x86_64/initramfs.img', 'c2c90a83bcfb252a24285f897a723c24cce3b7f7376c2859b95df5275cdf2722', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
19:30:49 [2024-10-25T19:30:49.794Z] 2024-10-25 19:30:49,630 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', 'c2c90a83bcfb252a24285f897a723c24cce3b7f7376c2859b95df5275cdf2722', '/usr/share/coreos-installer/example-config.yaml']
19:30:49 [2024-10-25T19:30:49.794Z] 2024-10-25 19:30:49,648 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', 'c2c90a83bcfb252a24285f897a723c24cce3b7f7376c2859b95df5275cdf2722', '/tmp/tmpss4_pk73']
19:30:49 [2024-10-25T19:30:49.794Z] Generating osmet file for 512b metal image
19:30:49 [2024-10-25T19:30:49.794Z] 2024-10-25 19:30:49,665 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20241025.dev.0', '--checksum', 'bf133adc93fffd5fd1a70faf86a167d953caa33863a93d5a8597a1ddc5f4c853', '--output', '/var/tmp/coreos-installer-output', '--fast']
19:31:07 [2024-10-25T19:31:07.820Z] + RUST_BACKTRACE=full
19:31:07 [2024-10-25T19:31:07.820Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/46332326a2d6a7d19c0539f5ec7fb8bc35180f76e5e459ca862e63e6e9c9697b.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20241025.dev.0' --checksum bf133adc93fffd5fd1a70faf86a167d953caa33863a93d5a8597a1ddc5f4c853 --output /var/tmp/coreos-installer-output --fast
19:31:07 [2024-10-25T19:31:07.820Z] Total OSTree objects scanned from /root: 17710 (17704 mapped, 6 empty)
19:31:07 [2024-10-25T19:31:07.820Z] Total OSTree objects found in /boot: 316
19:31:07 [2024-10-25T19:31:07.820Z] Duplicate extents dropped: 0
19:31:07 [2024-10-25T19:31:07.820Z] Overlapping extents clamped: 0
19:31:07 [2024-10-25T19:31:07.820Z] Total /root extents: 17705
19:31:07 [2024-10-25T19:31:07.820Z] Duplicate extents dropped: 0
19:31:07 [2024-10-25T19:31:07.820Z] Overlapping extents clamped: 0
19:31:07 [2024-10-25T19:31:07.820Z] Total /boot extents: 321
19:31:07 [2024-10-25T19:31:07.820Z] Packing image
19:31:25 [2024-10-25T19:31:25.835Z] Total bytes skipped: 1675931648
19:31:25 [2024-10-25T19:31:25.835Z] Total bytes written: 1096503296
19:31:25 [2024-10-25T19:31:25.835Z] Total bytes written (compressed): 25805024
19:31:25 [2024-10-25T19:31:25.835Z] Verifying that repacked image matches digest
19:31:33 [2024-10-25T19:31:33.896Z] Packing successful!
19:31:33 [2024-10-25T19:31:33.896Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:31:33 [2024-10-25T19:31:33.896Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
19:31:34 [2024-10-25T19:31:34.814Z] Generating osmet file for 4k metal image
19:31:34 [2024-10-25T19:31:34.814Z] 2024-10-25 19:31:34,530 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-42.20241025.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 42.20241025.dev.0', '--checksum', 'c0f69a2dd4316fb1695561e876fcddf395c4d69696f15f4234298c8f1c3360dc', '--output', '/var/tmp/coreos-installer-output', '--fast']
19:31:53 [2024-10-25T19:31:53.030Z] + RUST_BACKTRACE=full
19:31:53 [2024-10-25T19:31:53.030Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/46332326a2d6a7d19c0539f5ec7fb8bc35180f76e5e459ca862e63e6e9c9697b.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 42.20241025.dev.0' --checksum c0f69a2dd4316fb1695561e876fcddf395c4d69696f15f4234298c8f1c3360dc --output /var/tmp/coreos-installer-output --fast
19:31:53 [2024-10-25T19:31:53.030Z] Total OSTree objects scanned from /root: 17710 (17704 mapped, 6 empty)
19:31:53 [2024-10-25T19:31:53.030Z] Total OSTree objects found in /boot: 3
19:31:53 [2024-10-25T19:31:53.030Z] Duplicate extents dropped: 0
19:31:53 [2024-10-25T19:31:53.030Z] Overlapping extents clamped: 0
19:31:53 [2024-10-25T19:31:53.030Z] Total /root extents: 17706
19:31:53 [2024-10-25T19:31:53.030Z] Duplicate extents dropped: 0
19:31:53 [2024-10-25T19:31:53.030Z] Overlapping extents clamped: 0
19:31:53 [2024-10-25T19:31:53.030Z] Total /boot extents: 4
19:31:53 [2024-10-25T19:31:53.030Z] Packing image
19:32:05 [2024-10-25T19:32:05.174Z] Total bytes skipped: 1665064960
19:32:05 [2024-10-25T19:32:05.174Z] Total bytes written: 1107369984
19:32:05 [2024-10-25T19:32:05.174Z] Total bytes written (compressed): 25838800
19:32:05 [2024-10-25T19:32:05.174Z] Verifying that repacked image matches digest
19:32:15 [2024-10-25T19:32:15.084Z] Packing successful!
19:32:15 [2024-10-25T19:32:15.084Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:32:15 [2024-10-25T19:32:15.084Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
19:32:16 [2024-10-25T19:32:16.004Z] Compressing squashfs with lz4
19:32:16 [2024-10-25T19:32:16.004Z] 2024-10-25 19:32:15,936 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
19:32:16 [2024-10-25T19:32:16.300Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
19:32:16 [2024-10-25T19:32:16.300Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
19:32:16 [2024-10-25T19:32:16.300Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6
19:32:16 [2024-10-25T19:32:16.300Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/image.squashfs
19:32:16 [2024-10-25T19:32:16.300Z] + coreos_gf_run_mount builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:16 [2024-10-25T19:32:16.300Z] + local mntarg=mount
19:32:16 [2024-10-25T19:32:16.300Z] + '[' builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw = ro ']'
19:32:16 [2024-10-25T19:32:16.301Z] + coreos_gf_run builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:16 [2024-10-25T19:32:16.301Z] + '[' -n '' ']'
19:32:16 [2024-10-25T19:32:16.301Z] + coreos_gf_launch builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:16 [2024-10-25T19:32:16.301Z] + '[' -n '' ']'
19:32:16 [2024-10-25T19:32:16.301Z] ++ guestfish --listen -a builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:16 [2024-10-25T19:32:16.301Z] + eval 'GUESTFISH_PID=12574; export GUESTFISH_PID'
19:32:16 [2024-10-25T19:32:16.301Z] ++ GUESTFISH_PID=12574
19:32:16 [2024-10-25T19:32:16.301Z] ++ export GUESTFISH_PID
19:32:16 [2024-10-25T19:32:16.301Z] + '[' -z 12574 ']'
19:32:16 [2024-10-25T19:32:16.301Z] ++ kola ncpu
19:32:16 [2024-10-25T19:32:16.301Z] + coreos_gf set-smp 6
19:32:16 [2024-10-25T19:32:16.301Z] + guestfish --remote -- set-smp 6
19:32:16 [2024-10-25T19:32:16.301Z] + coreos_gf run
19:32:16 [2024-10-25T19:32:16.301Z] + guestfish --remote -- run
19:32:18 [2024-10-25T19:32:18.179Z] + GUESTFISH_RUNNING=1
19:32:18 [2024-10-25T19:32:18.179Z] ++ coreos_gf findfs-label root
19:32:18 [2024-10-25T19:32:18.179Z] ++ guestfish --remote -- findfs-label root
19:32:18 [2024-10-25T19:32:18.179Z] + root=/dev/sda4
19:32:18 [2024-10-25T19:32:18.179Z] + coreos_gf mount /dev/sda4 /
19:32:18 [2024-10-25T19:32:18.179Z] + guestfish --remote -- mount /dev/sda4 /
19:32:18 [2024-10-25T19:32:18.734Z] + local boot
19:32:18 [2024-10-25T19:32:18.734Z] ++ coreos_gf findfs-label boot
19:32:18 [2024-10-25T19:32:18.734Z] ++ guestfish --remote -- findfs-label boot
19:32:18 [2024-10-25T19:32:18.734Z] + boot=/dev/sda3
19:32:18 [2024-10-25T19:32:18.734Z] + coreos_gf mount /dev/sda3 /boot
19:32:18 [2024-10-25T19:32:18.734Z] + guestfish --remote -- mount /dev/sda3 /boot
19:32:18 [2024-10-25T19:32:18.734Z] + local partitions
19:32:18 [2024-10-25T19:32:18.734Z] + local label
19:32:18 [2024-10-25T19:32:18.734Z] ++ coreos_gf list-partitions
19:32:18 [2024-10-25T19:32:18.734Z] ++ guestfish --remote -- list-partitions
19:32:18 [2024-10-25T19:32:18.734Z] + partitions='/dev/sda1
19:32:18 [2024-10-25T19:32:18.734Z] /dev/sda2
19:32:18 [2024-10-25T19:32:18.734Z] /dev/sda3
19:32:18 [2024-10-25T19:32:18.734Z] /dev/sda4'
19:32:18 [2024-10-25T19:32:18.734Z] + for pt in $partitions
19:32:18 [2024-10-25T19:32:18.734Z] ++ coreos_gf vfs-label /dev/sda1
19:32:18 [2024-10-25T19:32:18.734Z] ++ guestfish --remote -- vfs-label /dev/sda1
19:32:18 [2024-10-25T19:32:18.734Z] + label=
19:32:18 [2024-10-25T19:32:18.734Z] + '[' '' == EFI-SYSTEM ']'
19:32:18 [2024-10-25T19:32:18.734Z] + for pt in $partitions
19:32:18 [2024-10-25T19:32:18.734Z] ++ coreos_gf vfs-label /dev/sda2
19:32:18 [2024-10-25T19:32:18.734Z] ++ guestfish --remote -- vfs-label /dev/sda2
19:32:18 [2024-10-25T19:32:18.734Z] + label=EFI-SYSTEM
19:32:18 [2024-10-25T19:32:18.734Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
19:32:18 [2024-10-25T19:32:18.734Z] + coreos_gf mount /dev/sda2 /boot/efi
19:32:18 [2024-10-25T19:32:18.734Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
19:32:18 [2024-10-25T19:32:18.734Z] + for pt in $partitions
19:32:18 [2024-10-25T19:32:18.734Z] ++ coreos_gf vfs-label /dev/sda3
19:32:18 [2024-10-25T19:32:18.734Z] ++ guestfish --remote -- vfs-label /dev/sda3
19:32:18 [2024-10-25T19:32:18.988Z] + label=boot
19:32:18 [2024-10-25T19:32:18.988Z] + '[' boot == EFI-SYSTEM ']'
19:32:18 [2024-10-25T19:32:18.988Z] + for pt in $partitions
19:32:18 [2024-10-25T19:32:18.988Z] ++ coreos_gf vfs-label /dev/sda4
19:32:18 [2024-10-25T19:32:18.988Z] ++ guestfish --remote -- vfs-label /dev/sda4
19:32:18 [2024-10-25T19:32:18.988Z] + label=root
19:32:18 [2024-10-25T19:32:18.988Z] + '[' root == EFI-SYSTEM ']'
19:32:18 [2024-10-25T19:32:18.989Z] ++ coreos_gf ls /ostree/deploy
19:32:18 [2024-10-25T19:32:18.989Z] ++ guestfish --remote -- ls /ostree/deploy
19:32:18 [2024-10-25T19:32:18.989Z] + stateroot=/ostree/deploy/fedora-coreos
19:32:18 [2024-10-25T19:32:18.989Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
19:32:18 [2024-10-25T19:32:18.989Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
19:32:18 [2024-10-25T19:32:18.989Z] ++ grep -v .origin
19:32:18 [2024-10-25T19:32:18.989Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/46332326a2d6a7d19c0539f5ec7fb8bc35180f76e5e459ca862e63e6e9c9697b.0
19:32:18 [2024-10-25T19:32:18.989Z] + export stateroot deploydir
19:32:18 [2024-10-25T19:32:18.989Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/config
19:32:18 [2024-10-25T19:32:18.989Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/config
19:32:18 [2024-10-25T19:32:18.989Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/config
19:32:18 [2024-10-25T19:32:18.989Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/config.new /ostree/repo/config
19:32:18 [2024-10-25T19:32:18.989Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/config.new /ostree/repo/config
19:32:18 [2024-10-25T19:32:18.989Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
19:32:18 [2024-10-25T19:32:18.989Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
19:32:18 [2024-10-25T19:32:18.989Z] + kernel_binary=/boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64
19:32:18 [2024-10-25T19:32:18.989Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
19:32:18 [2024-10-25T19:32:18.989Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
19:32:18 [2024-10-25T19:32:18.989Z] + kernel_hmac=/boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/.vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64.hmac
19:32:18 [2024-10-25T19:32:18.989Z] ++ basename /boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/.vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64.hmac
19:32:18 [2024-10-25T19:32:18.989Z] + coreos_gf ln /boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/.vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64.hmac /boot/.vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64.hmac
19:32:18 [2024-10-25T19:32:18.989Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/.vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64.hmac /boot/.vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64.hmac
19:32:18 [2024-10-25T19:32:18.989Z] ++ basename /boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64
19:32:18 [2024-10-25T19:32:18.989Z] + coreos_gf ln /boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64 /boot/vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64
19:32:18 [2024-10-25T19:32:18.989Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-bb20b0413fb9879727c3e755d44c31f83f9d5e163d1faad802781cc5ae31f3d3/vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64 /boot/vmlinuz-6.12.0-0.rc4.20241025gitae90f6a6170d.42.fc42.x86_64
19:32:19 [2024-10-25T19:32:19.242Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/image.squashfs compress:lz4
19:32:19 [2024-10-25T19:32:19.242Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/image.squashfs compress:lz4
19:32:29 [2024-10-25T19:32:29.158Z] + coreos_gf_shutdown
19:32:29 [2024-10-25T19:32:29.158Z] + coreos_gf umount-all
19:32:29 [2024-10-25T19:32:29.158Z] + guestfish --remote -- umount-all
19:32:29 [2024-10-25T19:32:29.158Z] + coreos_gf exit
19:32:29 [2024-10-25T19:32:29.158Z] + guestfish --remote -- exit
19:32:29 [2024-10-25T19:32:29.158Z] + GUESTFISH_RUNNING=
19:32:29 [2024-10-25T19:32:29.158Z] + GUESTFISH_PID=
19:32:29 [2024-10-25T19:32:29.158Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
19:32:29 [2024-10-25T19:32:29.158Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.wrbtj6 -rf
19:32:29 [2024-10-25T19:32:29.158Z] + _coreos_gf_cleanup
19:32:29 [2024-10-25T19:32:29.158Z] + guestfish --remote -- exit
19:32:29 [2024-10-25T19:32:29.158Z] + :
19:32:34 [2024-10-25T19:32:34.382Z] 2024-10-25 19:32:33,975 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw']
19:32:34 [2024-10-25T19:32:34.382Z] + coreos_gf_run_mount builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:34 [2024-10-25T19:32:34.382Z] + local mntarg=mount
19:32:34 [2024-10-25T19:32:34.382Z] + '[' builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw = ro ']'
19:32:34 [2024-10-25T19:32:34.382Z] + coreos_gf_run builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:34 [2024-10-25T19:32:34.382Z] + '[' -n '' ']'
19:32:34 [2024-10-25T19:32:34.382Z] + coreos_gf_launch builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:34 [2024-10-25T19:32:34.382Z] + '[' -n '' ']'
19:32:34 [2024-10-25T19:32:34.382Z] ++ guestfish --listen -a builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw --ro
19:32:34 [2024-10-25T19:32:34.382Z] + eval 'GUESTFISH_PID=12743; export GUESTFISH_PID'
19:32:34 [2024-10-25T19:32:34.382Z] ++ GUESTFISH_PID=12743
19:32:34 [2024-10-25T19:32:34.382Z] ++ export GUESTFISH_PID
19:32:34 [2024-10-25T19:32:34.382Z] + '[' -z 12743 ']'
19:32:34 [2024-10-25T19:32:34.382Z] ++ kola ncpu
19:32:34 [2024-10-25T19:32:34.382Z] + coreos_gf set-smp 6
19:32:34 [2024-10-25T19:32:34.382Z] + guestfish --remote -- set-smp 6
19:32:34 [2024-10-25T19:32:34.382Z] + coreos_gf run
19:32:34 [2024-10-25T19:32:34.382Z] + guestfish --remote -- run
19:32:36 [2024-10-25T19:32:36.258Z] + GUESTFISH_RUNNING=1
19:32:36 [2024-10-25T19:32:36.258Z] ++ coreos_gf findfs-label root
19:32:36 [2024-10-25T19:32:36.258Z] ++ guestfish --remote -- findfs-label root
19:32:36 [2024-10-25T19:32:36.258Z] + root=/dev/sda4
19:32:36 [2024-10-25T19:32:36.258Z] + coreos_gf mount /dev/sda4 /
19:32:36 [2024-10-25T19:32:36.258Z] + guestfish --remote -- mount /dev/sda4 /
19:32:36 [2024-10-25T19:32:36.513Z] + local boot
19:32:36 [2024-10-25T19:32:36.513Z] ++ coreos_gf findfs-label boot
19:32:36 [2024-10-25T19:32:36.513Z] ++ guestfish --remote -- findfs-label boot
19:32:36 [2024-10-25T19:32:36.766Z] + boot=/dev/sda3
19:32:36 [2024-10-25T19:32:36.766Z] + coreos_gf mount /dev/sda3 /boot
19:32:36 [2024-10-25T19:32:36.766Z] + guestfish --remote -- mount /dev/sda3 /boot
19:32:36 [2024-10-25T19:32:36.766Z] + local partitions
19:32:36 [2024-10-25T19:32:36.766Z] + local label
19:32:36 [2024-10-25T19:32:36.766Z] ++ coreos_gf list-partitions
19:32:36 [2024-10-25T19:32:36.766Z] ++ guestfish --remote -- list-partitions
19:32:36 [2024-10-25T19:32:36.766Z] + partitions='/dev/sda1
19:32:36 [2024-10-25T19:32:36.766Z] /dev/sda2
19:32:36 [2024-10-25T19:32:36.766Z] /dev/sda3
19:32:36 [2024-10-25T19:32:36.766Z] /dev/sda4'
19:32:36 [2024-10-25T19:32:36.766Z] + for pt in $partitions
19:32:36 [2024-10-25T19:32:36.766Z] ++ coreos_gf vfs-label /dev/sda1
19:32:36 [2024-10-25T19:32:36.766Z] ++ guestfish --remote -- vfs-label /dev/sda1
19:32:36 [2024-10-25T19:32:36.766Z] + label=
19:32:36 [2024-10-25T19:32:36.766Z] + '[' '' == EFI-SYSTEM ']'
19:32:36 [2024-10-25T19:32:36.766Z] + for pt in $partitions
19:32:36 [2024-10-25T19:32:36.766Z] ++ coreos_gf vfs-label /dev/sda2
19:32:36 [2024-10-25T19:32:36.766Z] ++ guestfish --remote -- vfs-label /dev/sda2
19:32:36 [2024-10-25T19:32:36.766Z] + label=EFI-SYSTEM
19:32:36 [2024-10-25T19:32:36.766Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
19:32:36 [2024-10-25T19:32:36.766Z] + coreos_gf mount /dev/sda2 /boot/efi
19:32:36 [2024-10-25T19:32:36.766Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
19:32:36 [2024-10-25T19:32:36.766Z] + for pt in $partitions
19:32:36 [2024-10-25T19:32:36.766Z] ++ coreos_gf vfs-label /dev/sda3
19:32:36 [2024-10-25T19:32:36.766Z] ++ guestfish --remote -- vfs-label /dev/sda3
19:32:37 [2024-10-25T19:32:37.019Z] + label=boot
19:32:37 [2024-10-25T19:32:37.019Z] + '[' boot == EFI-SYSTEM ']'
19:32:37 [2024-10-25T19:32:37.019Z] + for pt in $partitions
19:32:37 [2024-10-25T19:32:37.019Z] ++ coreos_gf vfs-label /dev/sda4
19:32:37 [2024-10-25T19:32:37.019Z] ++ guestfish --remote -- vfs-label /dev/sda4
19:32:37 [2024-10-25T19:32:37.019Z] + label=root
19:32:37 [2024-10-25T19:32:37.019Z] + '[' root == EFI-SYSTEM ']'
19:32:37 [2024-10-25T19:32:37.019Z] ++ coreos_gf ls /ostree/deploy
19:32:37 [2024-10-25T19:32:37.019Z] ++ guestfish --remote -- ls /ostree/deploy
19:32:37 [2024-10-25T19:32:37.019Z] + stateroot=/ostree/deploy/fedora-coreos
19:32:37 [2024-10-25T19:32:37.019Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
19:32:37 [2024-10-25T19:32:37.019Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
19:32:37 [2024-10-25T19:32:37.019Z] ++ grep -v .origin
19:32:37 [2024-10-25T19:32:37.019Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/46332326a2d6a7d19c0539f5ec7fb8bc35180f76e5e459ca862e63e6e9c9697b.0
19:32:37 [2024-10-25T19:32:37.019Z] + export stateroot deploydir
19:32:37 [2024-10-25T19:32:37.019Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
19:32:37 [2024-10-25T19:32:37.019Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
19:32:37 [2024-10-25T19:32:37.019Z] + sed -e '/^options/!d' -e 's/^options\s*//'
19:32:37 [2024-10-25T19:32:37.019Z] + coreos_gf_shutdown
19:32:37 [2024-10-25T19:32:37.019Z] + coreos_gf umount-all
19:32:37 [2024-10-25T19:32:37.019Z] + guestfish --remote -- umount-all
19:32:37 [2024-10-25T19:32:37.019Z] + coreos_gf exit
19:32:37 [2024-10-25T19:32:37.019Z] + guestfish --remote -- exit
19:32:37 [2024-10-25T19:32:37.274Z] + GUESTFISH_RUNNING=
19:32:37 [2024-10-25T19:32:37.274Z] + GUESTFISH_PID=
19:32:37 [2024-10-25T19:32:37.279Z] + _coreos_gf_cleanup
19:32:37 [2024-10-25T19:32:37.279Z] + guestfish --remote -- exit
19:32:37 [2024-10-25T19:32:37.279Z] + :
19:32:37 [2024-10-25T19:32:37.279Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-42.20241025.dev.0
19:32:37 [2024-10-25T19:32:37.279Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
19:32:37 [2024-10-25T19:32:37.279Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
19:32:37 [2024-10-25T19:32:37.279Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
19:32:37 [2024-10-25T19:32:37.532Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
19:32:37 [2024-10-25T19:32:37.532Z] 2024-10-25 19:32:37,296 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', 'c2c90a83bcfb252a24285f897a723c24cce3b7f7376c2859b95df5275cdf2722', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
19:32:37 [2024-10-25T19:32:37.785Z] 2024-10-25 19:32:37,753 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmp6wqx9w19.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
19:32:39 [2024-10-25T19:32:39.662Z] 2024-10-25 19:32:39,478 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20241025.dev.0', '-volset', 'fedora-coreos-42.20241025.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.20241025.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
19:32:39 [2024-10-25T19:32:39.663Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
19:32:39 [2024-10-25T19:32:39.663Z] genisoimage 1.1.11 (Linux)
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
19:32:39 [2024-10-25T19:32:39.663Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Initial Padblock                        Start Block 0
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Initial Padblock                        Block(s)    16
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Primary Volume Descriptor               Start Block 16
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Primary Volume Descriptor               Block(s)    1
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Eltorito Volume Descriptor              Start Block 17
19:32:39 [2024-10-25T19:32:39.663Z] Size of boot image is 4 sectors -> No emulation
19:32:39 [2024-10-25T19:32:39.663Z] Size of boot image is 13192 sectors -> No emulation
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Eltorito Volume Descriptor              Block(s)    1
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Joliet Volume Descriptor                Start Block 18
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Joliet Volume Descriptor                Block(s)    1
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   End Volume Descriptor                   Start Block 19
19:32:39 [2024-10-25T19:32:39.663Z] Done with: End Volume Descriptor                   Block(s)    1
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Version block                           Start Block 20
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Version block                           Block(s)    1
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Path table                              Start Block 21
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Path table                              Block(s)    4
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Joliet path table                       Start Block 25
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Joliet path table                       Block(s)    4
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Directory tree                          Start Block 29
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Directory tree                          Block(s)    7
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Joliet directory tree                   Start Block 36
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Joliet directory tree                   Block(s)    7
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Directory tree cleanup                  Start Block 43
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Directory tree cleanup                  Block(s)    0
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   Extension record                        Start Block 43
19:32:39 [2024-10-25T19:32:39.663Z] Done with: Extension record                        Block(s)    1
19:32:39 [2024-10-25T19:32:39.663Z] Writing:   The File(s)                             Start Block 44
19:32:39 [2024-10-25T19:32:39.663Z]   0.91% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   1.83% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   2.74% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   3.65% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   4.56% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   5.47% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   6.38% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   7.30% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.663Z]   8.21% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]   9.12% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  10.03% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  10.94% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  11.85% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  12.77% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  13.68% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  14.59% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  15.50% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  16.41% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  17.32% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  18.24% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  19.15% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  20.06% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  20.97% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  21.88% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  22.79% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  23.71% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  24.62% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  25.53% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  26.44% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  27.35% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  28.26% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:39 [2024-10-25T19:32:39.916Z]  29.18% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  30.09% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  31.00% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  31.91% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  32.82% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  33.73% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  34.65% done, estimate finish Fri Oct 25 19:32:39 2024
19:32:40 [2024-10-25T19:32:40.169Z]  35.56% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  36.47% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  37.38% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  38.29% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  39.20% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  40.12% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  41.03% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  41.94% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  42.85% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  43.76% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  44.67% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.169Z]  45.59% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.423Z]  46.50% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.423Z]  47.41% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.423Z]  48.32% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.423Z]  49.23% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:40 [2024-10-25T19:32:40.423Z]  50.14% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  51.06% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  51.97% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  52.88% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  53.79% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  54.70% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  55.61% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  56.53% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.423Z]  57.44% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  58.35% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  59.26% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  60.17% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  61.08% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  62.00% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  62.91% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.424Z]  63.82% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  64.73% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  65.64% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  66.55% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  67.47% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  68.38% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  69.29% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  70.20% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  71.11% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  72.02% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  72.94% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  73.85% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  74.76% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  75.67% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  76.58% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  77.49% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  78.41% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  79.32% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  80.23% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  81.14% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.676Z]  82.05% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  82.97% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  83.88% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  84.79% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  85.70% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  86.61% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  87.53% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  88.44% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  89.35% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  90.26% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  91.17% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  92.08% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  93.00% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  93.91% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  94.82% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  95.73% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  96.64% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  97.55% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:40 [2024-10-25T19:32:40.929Z]  98.46% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:41 [2024-10-25T19:32:41.182Z]  99.38% done, estimate finish Fri Oct 25 19:32:40 2024
19:32:41 [2024-10-25T19:32:41.182Z] Total translation table size: 2048
19:32:41 [2024-10-25T19:32:41.182Z] Total rockridge attributes bytes: 3006
19:32:41 [2024-10-25T19:32:41.182Z] Total directory bytes: 12288
19:32:41 [2024-10-25T19:32:41.182Z] Path table size(bytes): 96
19:32:41 [2024-10-25T19:32:41.182Z] Done with: The File(s)                             Block(s)    548235
19:32:41 [2024-10-25T19:32:41.182Z] Writing:   Ending Padblock                         Start Block 548279
19:32:41 [2024-10-25T19:32:41.182Z] Done with: Ending Padblock                         Block(s)    150
19:32:41 [2024-10-25T19:32:41.182Z] Max brk space used 1c000
19:32:41 [2024-10-25T19:32:41.182Z] 548429 extents written (1071 MB)
19:32:41 [2024-10-25T19:32:41.182Z] 2024-10-25 19:32:40,941 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241025.dev.0-live.x86_64.iso']
19:32:41 [2024-10-25T19:32:41.182Z] isohybrid: Warning: more than 1024 cylinders: 1072
19:32:41 [2024-10-25T19:32:41.182Z] isohybrid: Not all BIOSes will be able to boot this device
19:32:41 [2024-10-25T19:32:41.738Z] 2024-10-25 19:32:41,448 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-42.20241025.dev.0', '-volset', 'fedora-coreos-42.20241025.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.20241025.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
19:32:41 [2024-10-25T19:32:41.738Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
19:32:41 [2024-10-25T19:32:41.738Z] genisoimage 1.1.11 (Linux)
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
19:32:41 [2024-10-25T19:32:41.738Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Initial Padblock                        Start Block 0
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Initial Padblock                        Block(s)    16
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Primary Volume Descriptor               Start Block 16
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Primary Volume Descriptor               Block(s)    1
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Eltorito Volume Descriptor              Start Block 17
19:32:41 [2024-10-25T19:32:41.738Z] Size of boot image is 4 sectors -> No emulation
19:32:41 [2024-10-25T19:32:41.738Z] Size of boot image is 13192 sectors -> No emulation
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Eltorito Volume Descriptor              Block(s)    1
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Joliet Volume Descriptor                Start Block 18
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Joliet Volume Descriptor                Block(s)    1
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   End Volume Descriptor                   Start Block 19
19:32:41 [2024-10-25T19:32:41.738Z] Done with: End Volume Descriptor                   Block(s)    1
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Version block                           Start Block 20
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Version block                           Block(s)    1
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Path table                              Start Block 21
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Path table                              Block(s)    4
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Joliet path table                       Start Block 25
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Joliet path table                       Block(s)    4
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Directory tree                          Start Block 29
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Directory tree                          Block(s)    7
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Joliet directory tree                   Start Block 36
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Joliet directory tree                   Block(s)    7
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Directory tree cleanup                  Start Block 43
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Directory tree cleanup                  Block(s)    0
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   Extension record                        Start Block 43
19:32:41 [2024-10-25T19:32:41.738Z] Done with: Extension record                        Block(s)    1
19:32:41 [2024-10-25T19:32:41.738Z] Writing:   The File(s)                             Start Block 44
19:32:41 [2024-10-25T19:32:41.738Z]   8.56% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  17.09% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  25.64% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  34.16% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  42.71% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  51.24% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  59.79% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  68.31% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  76.87% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  85.39% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.738Z]  93.94% done, estimate finish Fri Oct 25 19:32:41 2024
19:32:41 [2024-10-25T19:32:41.739Z] Total translation table size: 2048
19:32:41 [2024-10-25T19:32:41.739Z] Total rockridge attributes bytes: 2842
19:32:41 [2024-10-25T19:32:41.739Z] Total directory bytes: 12288
19:32:41 [2024-10-25T19:32:41.739Z] Path table size(bytes): 96
19:32:41 [2024-10-25T19:32:41.739Z] Done with: The File(s)                             Block(s)    58368
19:32:41 [2024-10-25T19:32:41.739Z] Writing:   Ending Padblock                         Start Block 58412
19:32:41 [2024-10-25T19:32:41.739Z] Done with: Ending Padblock                         Block(s)    150
19:32:41 [2024-10-25T19:32:41.739Z] Max brk space used 1b000
19:32:41 [2024-10-25T19:32:41.739Z] 58562 extents written (114 MB)
19:32:41 [2024-10-25T19:32:41.739Z] 2024-10-25 19:32:41,553 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241025.dev.0-live.x86_64.iso.minimal']
19:32:41 [2024-10-25T19:32:41.739Z] 2024-10-25 19:32:41,595 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/42.20241025.dev.0/x86_64/fedora-coreos-42.20241025.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241025.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241025.dev.0-live.x86_64.iso.minimal', '--consume']
19:32:59 [2024-10-25T19:32:59.748Z] + RUST_BACKTRACE=full
19:32:59 [2024-10-25T19:32:59.748Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/46332326a2d6a7d19c0539f5ec7fb8bc35180f76e5e459ca862e63e6e9c9697b.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.20241025.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-42.20241025.dev.0-live.x86_64.iso.minimal --consume
19:32:59 [2024-10-25T19:32:59.748Z] Packing minimal ISO
19:32:59 [2024-10-25T19:32:59.748Z] Matched 17 files of 17
19:32:59 [2024-10-25T19:32:59.748Z] Total bytes skipped: 119515443
19:32:59 [2024-10-25T19:32:59.748Z] Total bytes written: 1070797
19:32:59 [2024-10-25T19:32:59.748Z] Total bytes written (compressed): 2864
19:32:59 [2024-10-25T19:32:59.748Z] Verifying that packed image matches digest
19:32:59 [2024-10-25T19:32:59.748Z] Packing successful!
19:32:59 [2024-10-25T19:32:59.748Z] + '[' -f /var/tmp/coreos-installer-output ']'
19:33:03 [2024-10-25T19:33:03.896Z] Updated: builds/42.20241025.dev.0/x86_64/meta.json