[Bug 2099890] Re: [Ubuntu24.04 x86_64] :: Ubuntu Installer crash during guest reinstallation with multipath disks

Frank Heimes 2099890 at bugs.launchpad.net
Wed Mar 5 09:52:39 UTC 2025


*** This bug is a duplicate of bug 2093352 ***
    https://bugs.launchpad.net/bugs/2093352

After having this discussed with our installer team, we strongly assume
that this is not related to qemu, but related to subiquity and that this
is highly likely a duplicate of LP#2093352.

** Also affects: ubuntu-z-systems
   Importance: Undecided
       Status: New

** Changed in: qemu (Ubuntu)
       Status: New => Invalid

** Also affects: subiquity (Ubuntu)
   Importance: Undecided
       Status: New

** Changed in: ubuntu-z-systems
       Status: New => Triaged

** Changed in: subiquity (Ubuntu)
       Status: New => Triaged

** This bug has been marked a duplicate of bug 2093352
   autoinstall multipath device path handling

-- 
You received this bug notification because you are a member of Ubuntu
Foundations Bugs, which is subscribed to subiquity in Ubuntu.
https://bugs.launchpad.net/bugs/2099890

Title:
  [Ubuntu24.04 x86_64] :: Ubuntu Installer crash during guest
  reinstallation with multipath disks

Status in Ubuntu on IBM z Systems:
  Triaged
Status in qemu package in Ubuntu:
  Invalid
Status in subiquity package in Ubuntu:
  Triaged

Bug description:
  == Comment: #0 - Amit Machhiwal <Amit.Machhiwal at ibm.com> - 2025-02-24 04:40:51 ==
  ---Problem Description---
  Ubuntu installer crashes when trying to reinstall a guest from an ISO on top of an existing installation on Qemu (KVM) and multipath disk setup.

  ubuntu at ubuntu:~$ hostnamectl
   Static hostname: ubuntu
         Icon name: computer-vm
           Chassis: vm ????
        Machine ID: baa73d67121a4d04ad2a7eb0cdf963c0
           Boot ID: fc953ab9915f4aeeba7873fd2cf3514f
    Virtualization: kvm
  Operating System: Ubuntu 24.04.1 LTS               
            Kernel: Linux 6.8.0-53-generic
      Architecture: x86-64
   Hardware Vendor: QEMU
    Hardware Model: Standard PC _i440FX + PIIX, 1996_
  Firmware Version: 1.16.3-3.fc41
     Firmware Date: Tue 2014-04-01
      Firmware Age: 10y 10month 3w 4d 
   
  Machine Type = Qemu 
   
  ---Debugger---
  A debugger is not configured
   
  ---Steps to Reproduce---
   Steps to reproduce:
  -------------------
  1. Download the Ubuntu 24.04.1 iso from the below location:
      https://ubuntu.bsr.one/releases/24.04.1/ubuntu-24.04.1-live-server-amd64.iso

  2. Create a qcow2 for provisioning a Ubuntu 24.04.1 guest
  	qemu-img create -f qcow2 /home/amachhiw/images/multipath-disk.qcow2 10G

  3. Provision a guest with multipath disk configuration by running the following
     Qemu command line. The guest provisioning goes fine as expected.
      qemu-system-x86_64 \
         -enable-kvm \
         -m 4G \
         -smp 2 \
         -boot menu=on \
         -device virtio-scsi-pci,id=scsi \
         -drive if=none,id=mpatha,file=/home/amachhiw/images/multipath-disk.qcow2,format=qcow2,file.locking=off \
         -device scsi-hd,drive=mpatha,serial=MPIO \
         -drive if=none,id=mpathb,file=/home/amachhiw/images/multipath-disk.qcow2,format=qcow2,file.locking=off \
         -drive file=/home/amachhiw/images/ubuntu-24.04.1-live-server-amd64.iso,media=cdrom \
         -device scsi-hd,drive=mpathb,serial=MPIO \
         -net nic,model=virtio \
         -net user,hostfwd=::15447-:22 \
         -nographic

  5. Try a re-provision of the guest:
      a. Once provisioning completes and reach to the login prompt, just login and
         reboot.
      b. Keep hitting F12 for getting into the boot menu and boot from the cdrom

  6. Follow the on-screen instructions for proceeding on the installer.
     Eventually, during the installation, the installer crashes with the below

      Traceback (most recent call last):
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
          ret = args.func(args)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
          return log_time("TIMED %s: " % msg, func, *args, **kwargs)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
          return func(*args, **kwargs)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 127, in block_meta
          return meta_custom(args)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2278, in meta_custom
          handler(command, storage_config_dict, context)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 1585, in lvm_partition_handler
          util.subp(cmd)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
          return _subp(*args, **kwargs)
        File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
          raise ProcessExecutionError(stdout=out, stderr=err,
      curtin.util.ProcessExecutionError: Unexpected error while running command.
      Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
      Exit code: 5

  Attaching the relevant logs.

  Note: Similar installer crash is observed when a PPC guest re-installation is
  attempted with Qemu+multipath disks and details are put here:

      https://bugs.launchpad.net/subiquity/+bug/2080474/comments/41

   
  ---uname output---
  Linux ubuntu 6.8.0-53-generic #55-Ubuntu SMP PREEMPT_DYNAMIC Fri Jan 17 15:37:52 UTC 2025 x86_64 x86_64 x86_64 GNU/Linux
   
  Contact Information = Amit Machihwal (amachhiw at linux.ibm.com) 
   
  *Additional Instructions for Amit Machihwal (amachhiw at linux.ibm.com): 
  -Post a private note with access information to the machine that the bug is occuring on.

  == Comment: #1 - SEETEENA THOUFEEK <sthoufee at in.ibm.com> - 2025-02-24
  05:04:47 ==

  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_blockdev_sector_size: info:
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          "sda": {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ALIGNMENT": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ALN": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-GRAN": "4096",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-MAX": "1073741824",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ZERO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "FSTYPE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "GROUP": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "KNAME": "sda",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LABEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LOG-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MAJ:MIN": "8:0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MIN-IO": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODE": "brw-rw----",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODEL": "QEMU HARDDISK",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MOUNTPOINT": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "NAME": "sda",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OPT-IO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OWNER": "root",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "PHY-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RM": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ROTA": "1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RQ-SIZE": "256",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "SIZE": "10737418240",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "STATE": "running",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "TYPE": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "UUID": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "device_path": "/dev/sda"
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          },
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          "sda1": {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ALIGNMENT": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ALN": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-GRAN": "4096",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-MAX": "1073741824",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ZERO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "FSTYPE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "GROUP": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "KNAME": "sda1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LABEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LOG-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MAJ:MIN": "8:1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MIN-IO": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODE": "brw-rw----",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MOUNTPOINT": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "NAME": "sda1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OPT-IO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OWNER": "root",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "PHY-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RM": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ROTA": "1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RQ-SIZE": "256",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "SIZE": "1048576",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "STATE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "TYPE": "part",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "UUID": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "device_path": "/dev/sda1"
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          },
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          "sda2": {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ALIGNMENT": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ALN": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-GRAN": "4096",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-MAX": "1073741824",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ZERO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "FSTYPE": "ext4",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "GROUP": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "KNAME": "sda2",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LABEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LOG-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MAJ:MIN": "8:2",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MIN-IO": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODE": "brw-rw----",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MOUNTPOINT": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "NAME": "sda2",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OPT-IO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OWNER": "root",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "PHY-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RM": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ROTA": "1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RQ-SIZE": "256",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "SIZE": "1879048192",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "STATE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "TYPE": "part",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "UUID": "7371f6f1-8b9f-4607-80ae-e83b937f8492",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "device_path": "/dev/sda2"
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          }
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         }
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_blockdev_sector_size: (log=512, phys=512)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         sda logical_block_size_bytes: 512
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         previous partition number for 'partition-2' found to be '2'
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         partition_kname=sda2
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         calc_partition_info: sda2 size_sectors=3670016 start_sectors=4096
  Feb 20 12:03:41 ubuntu-server subiquity_event.1695[1695]:  executing curtin install partitioning step
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         adding partition 'partition-2' to disk 'disk-sda' (ptable: 'gpt')
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         partnum: 3 offset_sectors: 3674112 length_sectors: 17295359
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Preparing partition location on disk /dev/sda
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Wiping 1M on /dev/sda at offset 1881145344
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['sgdisk', '--new', '3:3674112:20969471', '--typecode=3:8300', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         /dev/sda is multipath device? False
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['blockdev', '--rereadpt', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(): 0.142
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(exists='/dev/sda3'): 0.000
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring partition: partition-2
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring lvm_volgroup: lvm_volgroup-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 8855224320, 'wipe': 'superblock', 'number': 3, 'preserve': False, 'grub_device': False, 'offset': 1881145344, 'id': 'partition-2', 'type': 'partition'})
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': '0QEMU_QEMU_HARDDISK_MPIO', 'path': '/dev/sda', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Processing serial 0QEMU_QEMU_HARDDISK_MPIO via udev to 0QEMU_QEMU_HARDDISK_MPIO
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         lookup_disks found: ['scsi-0QEMU_QEMU_HARDDISK_MPIO', 'scsi-0QEMU_QEMU_HARDDISK_MPIO-part2', 'scsi-0QEMU_QEMU_HARDDISK_MPIO-part1', 'scsi-0QEMU_QEMU_HARDDISK_MPIO-part3']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         /dev/sda is multipath device? False
  Feb 20 12:03:41 ubuntu-server subiquity_event.1695[1695]: installing system
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         /dev/sda is multipath device member? False
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         block.lookup_disk() returning path /dev/sda
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(): 0.046
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         devsync happy - path /dev/sda now exists
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         return volume path /dev/sda
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(): 0.048
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         devsync happy - path /dev/sda now exists
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         return volume path /dev/sda3
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['vgcreate', '--force', '--zero=y', '--yes', 'ubuntu-vg-1', '/dev/sda3'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['pvscan'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['vgscan'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring lvm_volgroup: lvm_volgroup-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring lvm_partition: lvm_partition-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           WARNING: Not using device /dev/sda3 for PV ef8dRO-GHdx-EmlM-fC95-UhbH-CPaj-6XLuf1.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           WARNING: PV ef8dRO-GHdx-EmlM-fC95-UhbH-CPaj-6XLuf1 prefers device /dev/sdb3 because device is used by LV.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           Cannot update volume group ubuntu-vg-1 with duplicate PV devices.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         An error occured handling 'lvm_partition-0': ProcessExecutionError - Unexpected error while running command.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Exit code: 5
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Reason: -
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stdout: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring lvm_partition: lvm_partition-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED BLOCK_META: 7.194
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Traceback (most recent call last):
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             ret = args.func(args)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return func(*args, **kwargs)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 127, in block_meta
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return meta_custom(args)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2278, in meta_custom
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             handler(command, storage_config_dict, context)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 1585, in lvm_partition_handler
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             util.subp(cmd)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return _subp(*args, **kwargs)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             raise ProcessExecutionError(stdout=out, stderr=err,
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Exit code: 5
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Reason: -
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stdout: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Unexpected error while running command.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Exit code: 5
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Reason: -
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stdout: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]: Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_event.1695[1695]:

  == Comment: #2 - SEETEENA THOUFEEK <sthoufee at in.ibm.com> - 2025-02-24
  05:04:55 ==

  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_blockdev_sector_size: info:
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          "sda": {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ALIGNMENT": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ALN": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-GRAN": "4096",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-MAX": "1073741824",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ZERO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "FSTYPE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "GROUP": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "KNAME": "sda",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LABEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LOG-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MAJ:MIN": "8:0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MIN-IO": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODE": "brw-rw----",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODEL": "QEMU HARDDISK",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MOUNTPOINT": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "NAME": "sda",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OPT-IO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OWNER": "root",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "PHY-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RM": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ROTA": "1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RQ-SIZE": "256",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "SIZE": "10737418240",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "STATE": "running",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "TYPE": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "UUID": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "device_path": "/dev/sda"
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          },
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          "sda1": {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ALIGNMENT": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ALN": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-GRAN": "4096",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-MAX": "1073741824",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ZERO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "FSTYPE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "GROUP": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "KNAME": "sda1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LABEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LOG-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MAJ:MIN": "8:1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MIN-IO": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODE": "brw-rw----",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MOUNTPOINT": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "NAME": "sda1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OPT-IO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OWNER": "root",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "PHY-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RM": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ROTA": "1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RQ-SIZE": "256",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "SIZE": "1048576",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "STATE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "TYPE": "part",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "UUID": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "device_path": "/dev/sda1"
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          },
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          "sda2": {
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ALIGNMENT": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ALN": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-GRAN": "4096",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-MAX": "1073741824",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "DISC-ZERO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "FSTYPE": "ext4",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "GROUP": "disk",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "KNAME": "sda2",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LABEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "LOG-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MAJ:MIN": "8:2",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MIN-IO": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODE": "brw-rw----",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MODEL": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "MOUNTPOINT": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "NAME": "sda2",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OPT-IO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "OWNER": "root",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "PHY-SEC": "512",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RM": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RO": "0",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "ROTA": "1",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "RQ-SIZE": "256",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "SIZE": "1879048192",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "STATE": "",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "TYPE": "part",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "UUID": "7371f6f1-8b9f-4607-80ae-e83b937f8492",
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           "device_path": "/dev/sda2"
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:          }
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         }
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_blockdev_sector_size: (log=512, phys=512)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         sda logical_block_size_bytes: 512
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         previous partition number for 'partition-2' found to be '2'
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         partition_kname=sda2
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         calc_partition_info: sda2 size_sectors=3670016 start_sectors=4096
  Feb 20 12:03:41 ubuntu-server subiquity_event.1695[1695]:  executing curtin install partitioning step
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         adding partition 'partition-2' to disk 'disk-sda' (ptable: 'gpt')
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         partnum: 3 offset_sectors: 3674112 length_sectors: 17295359
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Preparing partition location on disk /dev/sda
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Wiping 1M on /dev/sda at offset 1881145344
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['sgdisk', '--new', '3:3674112:20969471', '--typecode=3:8300', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         /dev/sda is multipath device? False
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['blockdev', '--rereadpt', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(): 0.142
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(exists='/dev/sda3'): 0.000
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring partition: partition-2
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring lvm_volgroup: lvm_volgroup-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 8855224320, 'wipe': 'superblock', 'number': 3, 'preserve': False, 'grub_device': False, 'offset': 1881145344, 'id': 'partition-2', 'type': 'partition'})
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': '0QEMU_QEMU_HARDDISK_MPIO', 'path': '/dev/sda', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Processing serial 0QEMU_QEMU_HARDDISK_MPIO via udev to 0QEMU_QEMU_HARDDISK_MPIO
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         lookup_disks found: ['scsi-0QEMU_QEMU_HARDDISK_MPIO', 'scsi-0QEMU_QEMU_HARDDISK_MPIO-part2', 'scsi-0QEMU_QEMU_HARDDISK_MPIO-part1', 'scsi-0QEMU_QEMU_HARDDISK_MPIO-part3']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         /dev/sda is multipath device? False
  Feb 20 12:03:41 ubuntu-server subiquity_event.1695[1695]: installing system
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         /dev/sda is multipath device member? False
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         block.lookup_disk() returning path /dev/sda
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(): 0.046
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         devsync happy - path /dev/sda now exists
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         return volume path /dev/sda
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED udevadm_settle(): 0.048
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         devsync happy - path /dev/sda now exists
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         return volume path /dev/sda3
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['vgcreate', '--force', '--zero=y', '--yes', 'ubuntu-vg-1', '/dev/sda3'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['pvscan'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['vgscan'] with allowed return codes [0] (capture=True)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring lvm_volgroup: lvm_volgroup-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring lvm_partition: lvm_partition-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Running command ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B'] with allowed return codes [0] (capture=False)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           WARNING: Not using device /dev/sda3 for PV ef8dRO-GHdx-EmlM-fC95-UhbH-CPaj-6XLuf1.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           WARNING: PV ef8dRO-GHdx-EmlM-fC95-UhbH-CPaj-6XLuf1 prefers device /dev/sdb3 because device is used by LV.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           Cannot update volume group ubuntu-vg-1 with duplicate PV devices.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         An error occured handling 'lvm_partition-0': ProcessExecutionError - Unexpected error while running command.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Exit code: 5
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Reason: -
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stdout: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring lvm_partition: lvm_partition-0
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         TIMED BLOCK_META: 7.194
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Traceback (most recent call last):
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             ret = args.func(args)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return func(*args, **kwargs)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 127, in block_meta
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return meta_custom(args)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2278, in meta_custom
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             handler(command, storage_config_dict, context)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 1585, in lvm_partition_handler
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             util.subp(cmd)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             return _subp(*args, **kwargs)
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:           File "/snap/subiquity/6066/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:             raise ProcessExecutionError(stdout=out, stderr=err,
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Exit code: 5
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Reason: -
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stdout: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Unexpected error while running command.
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Command: ['lvcreate', 'ubuntu-vg-1', '--name', 'ubuntu-lv', '--zero=y', '--wipesignatures=y', '--yes', '--size', '8854175744B']
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Exit code: 5
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Reason: -
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stdout: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]:         
  Feb 20 12:03:41 ubuntu-server subiquity_log.1695[2886]: Stderr: ''
  Feb 20 12:03:41 ubuntu-server subiquity_event.1695[1695]:

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu-z-systems/+bug/2099890/+subscriptions




More information about the foundations-bugs mailing list