Console Output

16:50:12 [2025-02-24T16:50:12.102Z] + set -xeuo pipefail
16:50:12 [2025-02-24T16:50:12.102Z] ++ umask
16:50:12 [2025-02-24T16:50:12.102Z] + '[' 0022 = 0000 ']'
16:50:12 [2025-02-24T16:50:12.102Z] + cosa buildextend-live --fast
16:50:12 [2025-02-24T16:50:12.355Z] Targeting build: 43.20250224.dev.0
16:50:12 [2025-02-24T16:50:12.355Z] 2025-02-24 16:50:12,218 INFO - Running command: ['/usr/bin/ostree', 'ls', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--nul-filenames-only', 'd04de4841b6dbd7188bec4eedb65b0b1a62a8a087362083d228c4ad9a910a2c7', '/usr/lib/modules']
16:50:12 [2025-02-24T16:50:12.355Z] 2025-02-24 16:50:12,228 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64/vmlinuz', 'd04de4841b6dbd7188bec4eedb65b0b1a62a8a087362083d228c4ad9a910a2c7', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:50:12 [2025-02-24T16:50:12.355Z] 2025-02-24 16:50:12,276 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--force-copy', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/modules/6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64/initramfs.img', 'd04de4841b6dbd7188bec4eedb65b0b1a62a8a087362083d228c4ad9a910a2c7', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot']
16:50:12 [2025-02-24T16:50:12.633Z] 2025-02-24 16:50:12,480 INFO - Running command: ['/usr/bin/ostree', 'cat', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', 'd04de4841b6dbd7188bec4eedb65b0b1a62a8a087362083d228c4ad9a910a2c7', '/usr/share/coreos-installer/example-config.yaml']
16:50:12 [2025-02-24T16:50:12.633Z] 2025-02-24 16:50:12,498 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/os-release', 'd04de4841b6dbd7188bec4eedb65b0b1a62a8a087362083d228c4ad9a910a2c7', '/tmp/tmp27la_am4']
16:50:12 [2025-02-24T16:50:12.633Z] Generating osmet file for 512b metal image
16:50:12 [2025-02-24T16:50:12.633Z] 2025-02-24 16:50:12,513 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43.20250224.dev.0', '--checksum', '027d3d3bfd851560a7337e7a09ce61f3909fd02fd027b368588f39973ff91d3e', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:50:30 [2025-02-24T16:50:30.635Z] + RUST_BACKTRACE=full
16:50:30 [2025-02-24T16:50:30.635Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/8aff27f3a2e76336010e795ba4e1875556013afb40f031217cf7425c498f502f.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43.20250224.dev.0' --checksum 027d3d3bfd851560a7337e7a09ce61f3909fd02fd027b368588f39973ff91d3e --output /var/tmp/coreos-installer-output --fast
16:50:30 [2025-02-24T16:50:30.635Z] Total OSTree objects scanned from /root: 17881 (17875 mapped, 6 empty)
16:50:30 [2025-02-24T16:50:30.635Z] Total OSTree objects found in /boot: 317
16:50:30 [2025-02-24T16:50:30.635Z] Duplicate extents dropped: 0
16:50:30 [2025-02-24T16:50:30.635Z] Overlapping extents clamped: 0
16:50:30 [2025-02-24T16:50:30.635Z] Total /root extents: 17875
16:50:30 [2025-02-24T16:50:30.635Z] Duplicate extents dropped: 0
16:50:30 [2025-02-24T16:50:30.635Z] Overlapping extents clamped: 0
16:50:30 [2025-02-24T16:50:30.635Z] Total /boot extents: 322
16:50:30 [2025-02-24T16:50:30.635Z] Packing image
16:50:52 [2025-02-24T16:50:52.478Z] Total bytes skipped: 1640360960
16:50:52 [2025-02-24T16:50:52.478Z] Total bytes written: 1080693760
16:50:52 [2025-02-24T16:50:52.478Z] Total bytes written (compressed): 25558960
16:50:52 [2025-02-24T16:50:52.478Z] Verifying that repacked image matches digest
16:51:02 [2025-02-24T16:51:02.386Z] Packing successful!
16:51:02 [2025-02-24T16:51:02.386Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:51:02 [2025-02-24T16:51:02.386Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:51:04 [2025-02-24T16:51:04.263Z] Generating osmet file for 4k metal image
16:51:04 [2025-02-24T16:51:04.263Z] 2025-02-24 16:51:03,746 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal4k.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/fedora-coreos-43.20250224.dev.0-metal4k.x86_64.raw.osmet', 'pack', 'osmet', '/dev/disk/by-id/virtio-coreos', '--description', 'Fedora CoreOS 43.20250224.dev.0', '--checksum', '30ceca26aa2eab8e0a4b9f2f88ed287ceda19ab238dec0a051ad7dada937d2a2', '--output', '/var/tmp/coreos-installer-output', '--fast']
16:51:22 [2025-02-24T16:51:22.276Z] + RUST_BACKTRACE=full
16:51:22 [2025-02-24T16:51:22.276Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/8aff27f3a2e76336010e795ba4e1875556013afb40f031217cf7425c498f502f.0 env -C /home/jenkins/agent/workspace/test-override coreos-installer pack osmet /dev/disk/by-id/virtio-coreos --description 'Fedora CoreOS 43.20250224.dev.0' --checksum 30ceca26aa2eab8e0a4b9f2f88ed287ceda19ab238dec0a051ad7dada937d2a2 --output /var/tmp/coreos-installer-output --fast
16:51:22 [2025-02-24T16:51:22.276Z] Total OSTree objects scanned from /root: 17881 (17875 mapped, 6 empty)
16:51:22 [2025-02-24T16:51:22.276Z] Total OSTree objects found in /boot: 3
16:51:22 [2025-02-24T16:51:22.276Z] Duplicate extents dropped: 0
16:51:22 [2025-02-24T16:51:22.276Z] Overlapping extents clamped: 0
16:51:22 [2025-02-24T16:51:22.276Z] Total /root extents: 17875
16:51:22 [2025-02-24T16:51:22.276Z] Duplicate extents dropped: 0
16:51:22 [2025-02-24T16:51:22.276Z] Overlapping extents clamped: 0
16:51:22 [2025-02-24T16:51:22.276Z] Total /boot extents: 4
16:51:22 [2025-02-24T16:51:22.276Z] Packing image
16:51:37 [2025-02-24T16:51:37.074Z] Total bytes skipped: 1629487104
16:51:37 [2025-02-24T16:51:37.074Z] Total bytes written: 1091567616
16:51:37 [2025-02-24T16:51:37.074Z] Total bytes written (compressed): 25456048
16:51:37 [2025-02-24T16:51:37.074Z] Verifying that repacked image matches digest
16:51:45 [2025-02-24T16:51:45.139Z] Packing successful!
16:51:45 [2025-02-24T16:51:45.139Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:51:45 [2025-02-24T16:51:45.139Z] + cp /var/tmp/coreos-installer-output /dev/virtio-ports/coreosout
16:51:46 [2025-02-24T16:51:46.493Z] Compressing squashfs with lz4
16:51:46 [2025-02-24T16:51:46.493Z] 2025-02-24 16:51:46,269 INFO - Running command: ['/usr/lib/coreos-assembler/gf-mksquashfs', 'builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs', 'lz4']
16:51:46 [2025-02-24T16:51:46.493Z] +++ dirname /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:51:46 [2025-02-24T16:51:46.493Z] ++ mktemp -tdp /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs gf-mksquashfs.XXXXXX
16:51:46 [2025-02-24T16:51:46.493Z] + tmpd=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1
16:51:46 [2025-02-24T16:51:46.493Z] + tmp_dest=/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/image.squashfs
16:51:46 [2025-02-24T16:51:46.493Z] + coreos_gf_run_mount builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:51:46 [2025-02-24T16:51:46.493Z] + local mntarg=mount
16:51:46 [2025-02-24T16:51:46.493Z] + '[' builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw = ro ']'
16:51:46 [2025-02-24T16:51:46.493Z] + coreos_gf_run builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:51:46 [2025-02-24T16:51:46.493Z] + '[' -n '' ']'
16:51:46 [2025-02-24T16:51:46.493Z] + coreos_gf_launch builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:51:46 [2025-02-24T16:51:46.493Z] + '[' -n '' ']'
16:51:46 [2025-02-24T16:51:46.493Z] ++ guestfish --listen -a builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:51:46 [2025-02-24T16:51:46.746Z] + eval 'GUESTFISH_PID=12269; export GUESTFISH_PID'
16:51:46 [2025-02-24T16:51:46.746Z] ++ GUESTFISH_PID=12269
16:51:46 [2025-02-24T16:51:46.746Z] ++ export GUESTFISH_PID
16:51:46 [2025-02-24T16:51:46.746Z] + '[' -z 12269 ']'
16:51:46 [2025-02-24T16:51:46.746Z] ++ kola ncpu
16:51:46 [2025-02-24T16:51:46.746Z] + coreos_gf set-smp 6
16:51:46 [2025-02-24T16:51:46.746Z] + guestfish --remote -- set-smp 6
16:51:46 [2025-02-24T16:51:46.746Z] + coreos_gf run
16:51:46 [2025-02-24T16:51:46.746Z] + guestfish --remote -- run
16:51:48 [2025-02-24T16:51:48.621Z] + GUESTFISH_RUNNING=1
16:51:48 [2025-02-24T16:51:48.621Z] ++ coreos_gf findfs-label root
16:51:48 [2025-02-24T16:51:48.621Z] ++ guestfish --remote -- findfs-label root
16:51:48 [2025-02-24T16:51:48.621Z] + root=/dev/sda4
16:51:48 [2025-02-24T16:51:48.621Z] + coreos_gf mount /dev/sda4 /
16:51:48 [2025-02-24T16:51:48.621Z] + guestfish --remote -- mount /dev/sda4 /
16:51:49 [2025-02-24T16:51:49.178Z] + local boot
16:51:49 [2025-02-24T16:51:49.178Z] ++ coreos_gf findfs-label boot
16:51:49 [2025-02-24T16:51:49.178Z] ++ guestfish --remote -- findfs-label boot
16:51:49 [2025-02-24T16:51:49.178Z] + boot=/dev/sda3
16:51:49 [2025-02-24T16:51:49.178Z] + coreos_gf mount /dev/sda3 /boot
16:51:49 [2025-02-24T16:51:49.178Z] + guestfish --remote -- mount /dev/sda3 /boot
16:51:49 [2025-02-24T16:51:49.178Z] + local partitions
16:51:49 [2025-02-24T16:51:49.178Z] + local label
16:51:49 [2025-02-24T16:51:49.178Z] ++ coreos_gf list-partitions
16:51:49 [2025-02-24T16:51:49.178Z] ++ guestfish --remote -- list-partitions
16:51:49 [2025-02-24T16:51:49.178Z] + partitions='/dev/sda1
16:51:49 [2025-02-24T16:51:49.178Z] /dev/sda2
16:51:49 [2025-02-24T16:51:49.178Z] /dev/sda3
16:51:49 [2025-02-24T16:51:49.178Z] /dev/sda4'
16:51:49 [2025-02-24T16:51:49.178Z] + for pt in $partitions
16:51:49 [2025-02-24T16:51:49.178Z] ++ coreos_gf vfs-label /dev/sda1
16:51:49 [2025-02-24T16:51:49.178Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:51:49 [2025-02-24T16:51:49.178Z] + label=
16:51:49 [2025-02-24T16:51:49.178Z] + '[' '' == EFI-SYSTEM ']'
16:51:49 [2025-02-24T16:51:49.178Z] + for pt in $partitions
16:51:49 [2025-02-24T16:51:49.178Z] ++ coreos_gf vfs-label /dev/sda2
16:51:49 [2025-02-24T16:51:49.178Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:51:49 [2025-02-24T16:51:49.178Z] + label=EFI-SYSTEM
16:51:49 [2025-02-24T16:51:49.178Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:51:49 [2025-02-24T16:51:49.178Z] + coreos_gf mount /dev/sda2 /boot/efi
16:51:49 [2025-02-24T16:51:49.178Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:51:49 [2025-02-24T16:51:49.178Z] + for pt in $partitions
16:51:49 [2025-02-24T16:51:49.178Z] ++ coreos_gf vfs-label /dev/sda3
16:51:49 [2025-02-24T16:51:49.178Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:51:49 [2025-02-24T16:51:49.432Z] + label=boot
16:51:49 [2025-02-24T16:51:49.432Z] + '[' boot == EFI-SYSTEM ']'
16:51:49 [2025-02-24T16:51:49.432Z] + for pt in $partitions
16:51:49 [2025-02-24T16:51:49.432Z] ++ coreos_gf vfs-label /dev/sda4
16:51:49 [2025-02-24T16:51:49.432Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:51:49 [2025-02-24T16:51:49.432Z] + label=root
16:51:49 [2025-02-24T16:51:49.432Z] + '[' root == EFI-SYSTEM ']'
16:51:49 [2025-02-24T16:51:49.432Z] ++ coreos_gf ls /ostree/deploy
16:51:49 [2025-02-24T16:51:49.432Z] ++ guestfish --remote -- ls /ostree/deploy
16:51:49 [2025-02-24T16:51:49.432Z] + stateroot=/ostree/deploy/fedora-coreos
16:51:49 [2025-02-24T16:51:49.432Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:51:49 [2025-02-24T16:51:49.432Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:51:49 [2025-02-24T16:51:49.432Z] ++ grep -v .origin
16:51:49 [2025-02-24T16:51:49.432Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/8aff27f3a2e76336010e795ba4e1875556013afb40f031217cf7425c498f502f.0
16:51:49 [2025-02-24T16:51:49.432Z] + export stateroot deploydir
16:51:49 [2025-02-24T16:51:49.432Z] + coreos_gf download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/config
16:51:49 [2025-02-24T16:51:49.432Z] + guestfish --remote -- download /ostree/repo/config /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/config
16:51:49 [2025-02-24T16:51:49.432Z] + grep -v readonly=true /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/config
16:51:49 [2025-02-24T16:51:49.432Z] + coreos_gf upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/config.new /ostree/repo/config
16:51:49 [2025-02-24T16:51:49.432Z] + guestfish --remote -- upload /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/config.new /ostree/repo/config
16:51:49 [2025-02-24T16:51:49.432Z] ++ coreos_gf glob-expand '/boot/ostree/*/vmlinuz*'
16:51:49 [2025-02-24T16:51:49.432Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/vmlinuz*'
16:51:49 [2025-02-24T16:51:49.432Z] + kernel_binary=/boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
16:51:49 [2025-02-24T16:51:49.432Z] ++ coreos_gf glob-expand '/boot/ostree/*/.*.hmac'
16:51:49 [2025-02-24T16:51:49.432Z] ++ guestfish --remote -- glob-expand '/boot/ostree/*/.*.hmac'
16:51:49 [2025-02-24T16:51:49.432Z] + kernel_hmac=/boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
16:51:49 [2025-02-24T16:51:49.432Z] ++ basename /boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
16:51:49 [2025-02-24T16:51:49.432Z] + coreos_gf ln /boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
16:51:49 [2025-02-24T16:51:49.432Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac /boot/.vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64.hmac
16:51:49 [2025-02-24T16:51:49.432Z] ++ basename /boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
16:51:49 [2025-02-24T16:51:49.432Z] + coreos_gf ln /boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64 /boot/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
16:51:49 [2025-02-24T16:51:49.432Z] + guestfish --remote -- ln /boot/ostree/fedora-coreos-af6c1e4984b1e4b3049b45aab0da200a09eaf4a2ce771410badcb9f7c0587766/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64 /boot/vmlinuz-6.14.0-0.rc3.20250219git6537cfb395f3.31.fc43.x86_64
16:51:49 [2025-02-24T16:51:49.695Z] + coreos_gf mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/image.squashfs compress:lz4
16:51:49 [2025-02-24T16:51:49.695Z] + guestfish --remote -- mksquashfs / /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/image.squashfs compress:lz4
16:51:59 [2025-02-24T16:51:59.616Z] + coreos_gf_shutdown
16:51:59 [2025-02-24T16:51:59.616Z] + coreos_gf umount-all
16:51:59 [2025-02-24T16:51:59.616Z] + guestfish --remote -- umount-all
16:51:59 [2025-02-24T16:51:59.616Z] + coreos_gf exit
16:51:59 [2025-02-24T16:51:59.616Z] + guestfish --remote -- exit
16:51:59 [2025-02-24T16:51:59.616Z] + GUESTFISH_RUNNING=
16:51:59 [2025-02-24T16:51:59.616Z] + GUESTFISH_PID=
16:51:59 [2025-02-24T16:51:59.616Z] + mv /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1/image.squashfs /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/root.squashfs
16:51:59 [2025-02-24T16:51:59.616Z] + rm /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/initrd-rootfs/gf-mksquashfs.FHMbd1 -rf
16:51:59 [2025-02-24T16:51:59.616Z] + _coreos_gf_cleanup
16:51:59 [2025-02-24T16:51:59.616Z] + guestfish --remote -- exit
16:51:59 [2025-02-24T16:51:59.616Z] + :
16:52:03 [2025-02-24T16:52:03.772Z] 2025-02-24 16:52:03,623 INFO - Running command: ['/usr/lib/coreos-assembler/gf-get-kargs', 'builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw']
16:52:03 [2025-02-24T16:52:03.772Z] + coreos_gf_run_mount builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:52:03 [2025-02-24T16:52:03.772Z] + local mntarg=mount
16:52:03 [2025-02-24T16:52:03.772Z] + '[' builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw = ro ']'
16:52:03 [2025-02-24T16:52:03.772Z] + coreos_gf_run builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:52:03 [2025-02-24T16:52:03.772Z] + '[' -n '' ']'
16:52:03 [2025-02-24T16:52:03.772Z] + coreos_gf_launch builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:52:03 [2025-02-24T16:52:03.772Z] + '[' -n '' ']'
16:52:03 [2025-02-24T16:52:03.772Z] ++ guestfish --listen -a builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw --ro
16:52:04 [2025-02-24T16:52:04.026Z] + eval 'GUESTFISH_PID=12408; export GUESTFISH_PID'
16:52:04 [2025-02-24T16:52:04.026Z] ++ GUESTFISH_PID=12408
16:52:04 [2025-02-24T16:52:04.026Z] ++ export GUESTFISH_PID
16:52:04 [2025-02-24T16:52:04.026Z] + '[' -z 12408 ']'
16:52:04 [2025-02-24T16:52:04.026Z] ++ kola ncpu
16:52:04 [2025-02-24T16:52:04.026Z] + coreos_gf set-smp 6
16:52:04 [2025-02-24T16:52:04.026Z] + guestfish --remote -- set-smp 6
16:52:04 [2025-02-24T16:52:04.026Z] + coreos_gf run
16:52:04 [2025-02-24T16:52:04.026Z] + guestfish --remote -- run
16:52:05 [2025-02-24T16:52:05.908Z] + GUESTFISH_RUNNING=1
16:52:05 [2025-02-24T16:52:05.908Z] ++ coreos_gf findfs-label root
16:52:05 [2025-02-24T16:52:05.908Z] ++ guestfish --remote -- findfs-label root
16:52:05 [2025-02-24T16:52:05.908Z] + root=/dev/sda4
16:52:05 [2025-02-24T16:52:05.908Z] + coreos_gf mount /dev/sda4 /
16:52:05 [2025-02-24T16:52:05.908Z] + guestfish --remote -- mount /dev/sda4 /
16:52:06 [2025-02-24T16:52:06.197Z] + local boot
16:52:06 [2025-02-24T16:52:06.197Z] ++ coreos_gf findfs-label boot
16:52:06 [2025-02-24T16:52:06.197Z] ++ guestfish --remote -- findfs-label boot
16:52:06 [2025-02-24T16:52:06.197Z] + boot=/dev/sda3
16:52:06 [2025-02-24T16:52:06.197Z] + coreos_gf mount /dev/sda3 /boot
16:52:06 [2025-02-24T16:52:06.197Z] + guestfish --remote -- mount /dev/sda3 /boot
16:52:06 [2025-02-24T16:52:06.483Z] + local partitions
16:52:06 [2025-02-24T16:52:06.483Z] + local label
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf list-partitions
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- list-partitions
16:52:06 [2025-02-24T16:52:06.483Z] + partitions='/dev/sda1
16:52:06 [2025-02-24T16:52:06.483Z] /dev/sda2
16:52:06 [2025-02-24T16:52:06.483Z] /dev/sda3
16:52:06 [2025-02-24T16:52:06.483Z] /dev/sda4'
16:52:06 [2025-02-24T16:52:06.483Z] + for pt in $partitions
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf vfs-label /dev/sda1
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- vfs-label /dev/sda1
16:52:06 [2025-02-24T16:52:06.483Z] + label=
16:52:06 [2025-02-24T16:52:06.483Z] + '[' '' == EFI-SYSTEM ']'
16:52:06 [2025-02-24T16:52:06.483Z] + for pt in $partitions
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf vfs-label /dev/sda2
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- vfs-label /dev/sda2
16:52:06 [2025-02-24T16:52:06.483Z] + label=EFI-SYSTEM
16:52:06 [2025-02-24T16:52:06.483Z] + '[' EFI-SYSTEM == EFI-SYSTEM ']'
16:52:06 [2025-02-24T16:52:06.483Z] + coreos_gf mount /dev/sda2 /boot/efi
16:52:06 [2025-02-24T16:52:06.483Z] + guestfish --remote -- mount /dev/sda2 /boot/efi
16:52:06 [2025-02-24T16:52:06.483Z] + for pt in $partitions
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf vfs-label /dev/sda3
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- vfs-label /dev/sda3
16:52:06 [2025-02-24T16:52:06.483Z] + label=boot
16:52:06 [2025-02-24T16:52:06.483Z] + '[' boot == EFI-SYSTEM ']'
16:52:06 [2025-02-24T16:52:06.483Z] + for pt in $partitions
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf vfs-label /dev/sda4
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- vfs-label /dev/sda4
16:52:06 [2025-02-24T16:52:06.483Z] + label=root
16:52:06 [2025-02-24T16:52:06.483Z] + '[' root == EFI-SYSTEM ']'
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf ls /ostree/deploy
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- ls /ostree/deploy
16:52:06 [2025-02-24T16:52:06.483Z] + stateroot=/ostree/deploy/fedora-coreos
16:52:06 [2025-02-24T16:52:06.483Z] ++ coreos_gf ls /ostree/deploy/fedora-coreos/deploy
16:52:06 [2025-02-24T16:52:06.483Z] ++ guestfish --remote -- ls /ostree/deploy/fedora-coreos/deploy
16:52:06 [2025-02-24T16:52:06.483Z] ++ grep -v .origin
16:52:06 [2025-02-24T16:52:06.736Z] + deploydir=/ostree/deploy/fedora-coreos/deploy/8aff27f3a2e76336010e795ba4e1875556013afb40f031217cf7425c498f502f.0
16:52:06 [2025-02-24T16:52:06.736Z] + export stateroot deploydir
16:52:06 [2025-02-24T16:52:06.736Z] + coreos_gf glob read-file '/boot/loader/entries/ostree*conf'
16:52:06 [2025-02-24T16:52:06.736Z] + sed -e '/^options/!d' -e 's/^options\s*//'
16:52:06 [2025-02-24T16:52:06.736Z] + guestfish --remote -- glob read-file '/boot/loader/entries/ostree*conf'
16:52:06 [2025-02-24T16:52:06.736Z] + coreos_gf_shutdown
16:52:06 [2025-02-24T16:52:06.736Z] + coreos_gf umount-all
16:52:06 [2025-02-24T16:52:06.736Z] + guestfish --remote -- umount-all
16:52:06 [2025-02-24T16:52:06.736Z] + coreos_gf exit
16:52:06 [2025-02-24T16:52:06.736Z] + guestfish --remote -- exit
16:52:06 [2025-02-24T16:52:06.736Z] + GUESTFISH_RUNNING=
16:52:06 [2025-02-24T16:52:06.736Z] + GUESTFISH_PID=
16:52:06 [2025-02-24T16:52:06.736Z] + _coreos_gf_cleanup
16:52:06 [2025-02-24T16:52:06.736Z] + guestfish --remote -- exit
16:52:06 [2025-02-24T16:52:06.989Z] + :
16:52:06 [2025-02-24T16:52:06.989Z] Substituting ISO kernel arguments: rw mitigations=auto,nosmt coreos.liveiso=fedora-coreos-43.20250224.dev.0
16:52:06 [2025-02-24T16:52:06.989Z] src/config/live/zipl.prm -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/zipl.prm
16:52:06 [2025-02-24T16:52:06.989Z] src/config/live/EFI/fedora/grub.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora/grub.cfg
16:52:06 [2025-02-24T16:52:06.989Z] src/config/live/isolinux/boot.msg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/boot.msg
16:52:07 [2025-02-24T16:52:07.242Z] src/config/live/isolinux/isolinux.cfg -> /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux/isolinux.cfg
16:52:07 [2025-02-24T16:52:07.242Z] 2025-02-24 16:52:07,022 INFO - Running command: ['/usr/bin/ostree', 'checkout', '--repo', '/home/jenkins/agent/workspace/test-override/tmp/repo', '--user-mode', '--subpath', '/usr/lib/bootupd/updates/EFI', 'd04de4841b6dbd7188bec4eedb65b0b1a62a8a087362083d228c4ad9a910a2c7', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/efi']
16:52:08 [2025-02-24T16:52:08.160Z] 2025-02-24 16:52:08,149 INFO - Running command: ['virt-make-fs', '--type=vfat', '--label=EFI-SYSTEM', '/tmp/tmpqdmil50c.tar', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/efiboot.img']
16:52:11 [2025-02-24T16:52:11.415Z] 2025-02-24 16:52:10,779 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-43.20250224.dev.0', '-volset', 'fedora-coreos-43.20250224.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-43.20250224.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:52:11 [2025-02-24T16:52:11.415Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:52:11 [2025-02-24T16:52:11.415Z] genisoimage 1.1.11 (Linux)
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:52:11 [2025-02-24T16:52:11.415Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Initial Padblock                        Start Block 0
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Initial Padblock                        Block(s)    16
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Primary Volume Descriptor               Start Block 16
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Primary Volume Descriptor               Block(s)    1
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:52:11 [2025-02-24T16:52:11.415Z] Size of boot image is 4 sectors -> No emulation
16:52:11 [2025-02-24T16:52:11.415Z] Size of boot image is 13104 sectors -> No emulation
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   End Volume Descriptor                   Start Block 19
16:52:11 [2025-02-24T16:52:11.415Z] Done with: End Volume Descriptor                   Block(s)    1
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Version block                           Start Block 20
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Version block                           Block(s)    1
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Path table                              Start Block 21
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Path table                              Block(s)    4
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Joliet path table                       Start Block 25
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Joliet path table                       Block(s)    4
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Directory tree                          Start Block 29
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Directory tree                          Block(s)    7
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Joliet directory tree                   Start Block 36
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Joliet directory tree                   Block(s)    7
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Directory tree cleanup                  Start Block 43
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Directory tree cleanup                  Block(s)    0
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   Extension record                        Start Block 43
16:52:11 [2025-02-24T16:52:11.415Z] Done with: Extension record                        Block(s)    1
16:52:11 [2025-02-24T16:52:11.415Z] Writing:   The File(s)                             Start Block 44
16:52:11 [2025-02-24T16:52:11.415Z]   0.92% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   1.84% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   2.76% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   3.68% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   4.60% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   5.52% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   6.44% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   7.36% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   8.28% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]   9.20% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  10.12% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  11.04% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  11.96% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  12.88% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  13.80% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  14.72% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  15.64% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  16.56% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  17.48% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  18.41% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  19.32% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  20.25% done, estimate finish Mon Feb 24 16:52:10 2025
16:52:11 [2025-02-24T16:52:11.415Z]  21.16% done, estimate finish Mon Feb 24 16:52:14 2025
16:52:11 [2025-02-24T16:52:11.415Z]  22.09% done, estimate finish Mon Feb 24 16:52:14 2025
16:52:11 [2025-02-24T16:52:11.415Z]  23.00% done, estimate finish Mon Feb 24 16:52:14 2025
16:52:11 [2025-02-24T16:52:11.415Z]  23.93% done, estimate finish Mon Feb 24 16:52:14 2025
16:52:11 [2025-02-24T16:52:11.415Z]  24.84% done, estimate finish Mon Feb 24 16:52:14 2025
16:52:11 [2025-02-24T16:52:11.415Z]  25.77% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  26.68% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  27.61% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  28.53% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  29.45% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  30.37% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  31.29% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  32.21% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  33.13% done, estimate finish Mon Feb 24 16:52:13 2025
16:52:11 [2025-02-24T16:52:11.415Z]  34.05% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  34.97% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  35.89% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  36.81% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  37.73% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  38.65% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  39.57% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  40.49% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  41.41% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  42.33% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  43.25% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  44.17% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  45.09% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  46.01% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  46.93% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  47.85% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  48.77% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  49.69% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:11 [2025-02-24T16:52:11.415Z]  50.61% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.415Z]  51.53% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.415Z]  52.45% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.415Z]  53.37% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  54.29% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  55.21% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  56.13% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  57.05% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  57.97% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  58.89% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.416Z]  59.81% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  60.73% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  61.65% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  62.57% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  63.49% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  64.41% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  65.33% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  66.25% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  67.17% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  68.09% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  69.01% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  69.93% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  70.85% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  71.77% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  72.69% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  73.61% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  74.53% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  75.45% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  76.37% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  77.29% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  78.21% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  79.13% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  80.05% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  80.97% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  81.89% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  82.81% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  83.73% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  84.66% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  85.57% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  86.50% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  87.41% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  88.34% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  89.25% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.698Z]  90.18% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  91.09% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  92.02% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  92.93% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  93.86% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  94.78% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  95.70% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  96.62% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  97.54% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  98.46% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z]  99.38% done, estimate finish Mon Feb 24 16:52:11 2025
16:52:11 [2025-02-24T16:52:11.952Z] Total translation table size: 2048
16:52:11 [2025-02-24T16:52:11.952Z] Total rockridge attributes bytes: 3006
16:52:11 [2025-02-24T16:52:11.952Z] Total directory bytes: 12288
16:52:11 [2025-02-24T16:52:11.952Z] Path table size(bytes): 96
16:52:11 [2025-02-24T16:52:11.952Z] Done with: The File(s)                             Block(s)    543201
16:52:11 [2025-02-24T16:52:11.952Z] Writing:   Ending Padblock                         Start Block 543245
16:52:11 [2025-02-24T16:52:11.952Z] Done with: Ending Padblock                         Block(s)    150
16:52:11 [2025-02-24T16:52:11.952Z] Max brk space used 1c000
16:52:11 [2025-02-24T16:52:11.952Z] 543395 extents written (1061 MB)
16:52:11 [2025-02-24T16:52:11.952Z] 2025-02-24 16:52:11,793 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250224.dev.0-live.x86_64.iso']
16:52:11 [2025-02-24T16:52:11.952Z] isohybrid: Warning: more than 1024 cylinders: 1062
16:52:11 [2025-02-24T16:52:11.952Z] isohybrid: Not all BIOSes will be able to boot this device
16:52:12 [2025-02-24T16:52:12.508Z] 2025-02-24 16:52:12,282 INFO - Running command: ['/usr/bin/genisoimage', '-verbose', '-V', 'fedora-coreos-43.20250224.dev.0', '-volset', 'fedora-coreos-43.20250224.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-43.20250224.dev.0-live.x86_64.iso.minimal', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live']
16:52:12 [2025-02-24T16:52:12.508Z] I: -input-charset not specified, using utf-8 (detected in locale settings)
16:52:12 [2025-02-24T16:52:12.508Z] genisoimage 1.1.11 (Linux)
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/coreos
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/images/pxeboot
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/isolinux
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI
16:52:12 [2025-02-24T16:52:12.508Z] Scanning /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/live/EFI/fedora
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Initial Padblock                        Start Block 0
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Initial Padblock                        Block(s)    16
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Primary Volume Descriptor               Start Block 16
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Primary Volume Descriptor               Block(s)    1
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Eltorito Volume Descriptor              Start Block 17
16:52:12 [2025-02-24T16:52:12.508Z] Size of boot image is 4 sectors -> No emulation
16:52:12 [2025-02-24T16:52:12.508Z] Size of boot image is 13104 sectors -> No emulation
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Eltorito Volume Descriptor              Block(s)    1
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Joliet Volume Descriptor                Start Block 18
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Joliet Volume Descriptor                Block(s)    1
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   End Volume Descriptor                   Start Block 19
16:52:12 [2025-02-24T16:52:12.508Z] Done with: End Volume Descriptor                   Block(s)    1
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Version block                           Start Block 20
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Version block                           Block(s)    1
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Path table                              Start Block 21
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Path table                              Block(s)    4
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Joliet path table                       Start Block 25
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Joliet path table                       Block(s)    4
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Directory tree                          Start Block 29
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Directory tree                          Block(s)    7
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Joliet directory tree                   Start Block 36
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Joliet directory tree                   Block(s)    7
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Directory tree cleanup                  Start Block 43
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Directory tree cleanup                  Block(s)    0
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Extension record                        Start Block 43
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Extension record                        Block(s)    1
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   The File(s)                             Start Block 44
16:52:12 [2025-02-24T16:52:12.508Z]   8.39% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  16.75% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  25.13% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  33.49% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  41.88% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  50.24% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  58.63% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  66.99% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  75.37% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  83.73% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z]  92.13% done, estimate finish Mon Feb 24 16:52:12 2025
16:52:12 [2025-02-24T16:52:12.508Z] Total translation table size: 2048
16:52:12 [2025-02-24T16:52:12.508Z] Total rockridge attributes bytes: 2842
16:52:12 [2025-02-24T16:52:12.508Z] Total directory bytes: 12288
16:52:12 [2025-02-24T16:52:12.508Z] Path table size(bytes): 96
16:52:12 [2025-02-24T16:52:12.508Z] Done with: The File(s)                             Block(s)    59519
16:52:12 [2025-02-24T16:52:12.508Z] Writing:   Ending Padblock                         Start Block 59563
16:52:12 [2025-02-24T16:52:12.508Z] Done with: Ending Padblock                         Block(s)    150
16:52:12 [2025-02-24T16:52:12.508Z] Max brk space used 1b000
16:52:12 [2025-02-24T16:52:12.508Z] 59713 extents written (116 MB)
16:52:12 [2025-02-24T16:52:12.508Z] 2025-02-24 16:52:12,393 INFO - Running command: ['/usr/bin/isohybrid', '--uefi', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250224.dev.0-live.x86_64.iso.minimal']
16:52:12 [2025-02-24T16:52:12.508Z] 2025-02-24 16:52:12,436 INFO - Running command: ['/usr/lib/coreos-assembler/runvm-coreos-installer', 'builds/43.20250224.dev.0/x86_64/fedora-coreos-43.20250224.dev.0-metal.x86_64.raw', '', 'pack', 'minimal-iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250224.dev.0-live.x86_64.iso', '/home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250224.dev.0-live.x86_64.iso.minimal', '--consume']
16:52:30 [2025-02-24T16:52:30.507Z] + RUST_BACKTRACE=full
16:52:30 [2025-02-24T16:52:30.507Z] + chroot /sysroot/ostree/deploy/fedora-coreos/deploy/8aff27f3a2e76336010e795ba4e1875556013afb40f031217cf7425c498f502f.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-43.20250224.dev.0-live.x86_64.iso /home/jenkins/agent/workspace/test-override/tmp/buildpost-live/fedora-coreos-43.20250224.dev.0-live.x86_64.iso.minimal --consume
16:52:30 [2025-02-24T16:52:30.507Z] Packing minimal ISO
16:52:30 [2025-02-24T16:52:30.507Z] Matched 17 files of 17
16:52:30 [2025-02-24T16:52:30.507Z] Total bytes skipped: 121873979
16:52:30 [2025-02-24T16:52:30.507Z] Total bytes written: 809413
16:52:30 [2025-02-24T16:52:30.507Z] Total bytes written (compressed): 2844
16:52:30 [2025-02-24T16:52:30.507Z] Verifying that packed image matches digest
16:52:30 [2025-02-24T16:52:30.507Z] Packing successful!
16:52:30 [2025-02-24T16:52:30.507Z] + '[' -f /var/tmp/coreos-installer-output ']'
16:52:33 [2025-02-24T16:52:33.751Z] Updated: builds/43.20250224.dev.0/x86_64/meta.json