ubuntu-desktop-provision

ubuntu installation crashes while copying files

Bug #2071347 reported by Roqeeb Obadara on 2024-06-27

This bug report will be marked for expiration in 29 days if no further activity occurs. (find out why)

This bug affects 1 person

Affects		Status	Importance	Assigned to	Milestone
	ubuntu-desktop-provision	Incomplete	Undecided	Unassigned

Bug Description

I keep getting error with no specific cause when installing ubuntu on my hard drive. The error occurs while copying files. The version I'm installing is 24.04.

Revision history for this message

Roqeeb Obadara (obadara16) wrote on 2024-06-27:

Download full text (143.3 KiB)

Jun 27 11:48:03 ubuntu subiquity_event.3661[3661]: subiquity/load_cloud_config/extract_autoinstall: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/load_cloud_config/extract_autoinstall: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Early/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Early/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Reporting/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Reporting/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Error/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Error/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Userdata/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Userdata/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Package/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Package/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Debconf/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Debconf/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Kernel/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Kernel/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Zdev/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Zdev/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Ad/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Ad/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Late/apply_autoinstall_config: 
Jun 27 11:48:06 ubuntu subiquity_event.3661[3661]: subiquity/Late/apply_autoinstall_config: 
Jun 27 11:50:28 ubuntu subiquity_event.3661[3661]: subiquity/Ad/has_support_GET: 
Jun 27 11:50:46 ubuntu subiquity_event.3661[3661]: configuring apt
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: start: cmd-apt-config: curtin command apt-config
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Handling apt to target /tmp/tmpadf557mx/mount with config {'debconf_selections': {'subiquity': ''}, 'disable_components': [], 'disable_suites': ['security'], 'preserve_sources_list': False, 'primary': [{'arches': ['default'], 'uri': 'http://ng.archive.ubuntu.com/ubuntu/'}], 'security': [{'arches': ['amd64', 'i386'], 'uri': 'http://security.ubuntu.com/ubuntu/'}, {'arches': ['s390x', 'arm64', 'armhf', 'powerpc', 'ppc64el', 'riscv64'], 'uri': 'http://ports.ubuntu.com/ubuntu-ports'}]}
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--bind', '/dev', '/tmp/tmpadf557mx/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--bind', '/proc', '/tmp/tmpadf557mx/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--bind', '/run', '/tmp/tmpadf557mx/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--bind', '/sys', '/tmp/tmpadf557mx/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpadf557mx/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--bind', '/tmp/tmpadf557mx/mount/usr/bin/true', '/tmp/tmpadf557mx/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: got primary mirror: http://ng.archive.ubuntu.com/ubuntu/
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: got security mirror: http://security.ubuntu.com/ubuntu/
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Apt Mirror info: {'PRIMARY': 'http://ng.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu/', 'MIRROR': 'http://ng.archive.ubuntu.com/ubuntu/'}
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Applying debconf selections
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Checking if target_proc (/tmp/tmpadf557mx/mount/proc) is a mount
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: It is, so unshare will use --mount-proc=/tmp/tmpadf557mx/mount/proc
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpadf557mx/mount/proc', '--', 'chroot', '/tmp/tmpadf557mx/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64 to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64 to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_InRelease to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_InRelease
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64 to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64 to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Renaming apt list /tmp/tmpadf557mx/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en to /tmp/tmpadf557mx/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: TIMED subp(['udevadm', 'settle']): 0.005
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--make-private', '/tmp/tmpadf557mx/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['umount', '/tmp/tmpadf557mx/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--make-private', '/tmp/tmpadf557mx/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['umount', '/tmp/tmpadf557mx/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--make-private', '/tmp/tmpadf557mx/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['umount', '/tmp/tmpadf557mx/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:50:48 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--make-private', '/tmp/tmpadf557mx/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:50:49 ubuntu subiquity_log.3661[5435]: Running command ['umount', '/tmp/tmpadf557mx/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:50:49 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--make-private', '/tmp/tmpadf557mx/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:50:49 ubuntu subiquity_log.3661[5435]: Running command ['umount', '/tmp/tmpadf557mx/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:50:49 ubuntu subiquity_log.3661[5435]: Running command ['mount', '--make-private', '/tmp/tmpadf557mx/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:50:49 ubuntu subiquity_log.3661[5435]: Running command ['umount', '/tmp/tmpadf557mx/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:50:49 ubuntu subiquity_log.3661[5435]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: start: cmd-apt-config: curtin command apt-config
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Handling apt to target /tmp/tmpn0bpxd06/mount with config {'debconf_selections': {'subiquity': ''}, 'disable_components': [], 'preserve_sources_list': False, 'primary': [{'arches': ['default'], 'uri': 'http://ng.archive.ubuntu.com/ubuntu/'}], 'security': [{'arches': ['amd64', 'i386'], 'uri': 'http://security.ubuntu.com/ubuntu/'}, {'arches': ['s390x', 'arm64', 'armhf', 'powerpc', 'ppc64el', 'riscv64'], 'uri': 'http://ports.ubuntu.com/ubuntu-ports'}]}
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--bind', '/dev', '/tmp/tmpn0bpxd06/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--bind', '/proc', '/tmp/tmpn0bpxd06/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--bind', '/run', '/tmp/tmpn0bpxd06/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--bind', '/sys', '/tmp/tmpn0bpxd06/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpn0bpxd06/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--bind', '/tmp/tmpn0bpxd06/mount/usr/bin/true', '/tmp/tmpn0bpxd06/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: got primary mirror: http://ng.archive.ubuntu.com/ubuntu/
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: got security mirror: http://security.ubuntu.com/ubuntu/
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Apt Mirror info: {'PRIMARY': 'http://ng.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu/', 'MIRROR': 'http://ng.archive.ubuntu.com/ubuntu/'}
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Applying debconf selections
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Checking if target_proc (/tmp/tmpn0bpxd06/mount/proc) is a mount
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: It is, so unshare will use --mount-proc=/tmp/tmpn0bpxd06/mount/proc
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpn0bpxd06/mount/proc', '--', 'chroot', '/tmp/tmpn0bpxd06/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64 to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64 to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_InRelease to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_InRelease
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64 to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64 to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Renaming apt list /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en to /tmp/tmpn0bpxd06/mount/var/lib/apt/lists/ng.archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: TIMED subp(['udevadm', 'settle']): 0.005
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--make-private', '/tmp/tmpn0bpxd06/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['umount', '/tmp/tmpn0bpxd06/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--make-private', '/tmp/tmpn0bpxd06/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['umount', '/tmp/tmpn0bpxd06/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--make-private', '/tmp/tmpn0bpxd06/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['umount', '/tmp/tmpn0bpxd06/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--make-private', '/tmp/tmpn0bpxd06/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['umount', '/tmp/tmpn0bpxd06/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--make-private', '/tmp/tmpn0bpxd06/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['umount', '/tmp/tmpn0bpxd06/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['mount', '--make-private', '/tmp/tmpn0bpxd06/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: Running command ['umount', '/tmp/tmpn0bpxd06/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:50:59 ubuntu subiquity_log.3661[5772]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: start: cmd-in-target: curtin command in-target
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--bind', '/dev', '/tmp/tmpqm14yvav/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--bind', '/proc', '/tmp/tmpqm14yvav/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--bind', '/run', '/tmp/tmpqm14yvav/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--bind', '/sys', '/tmp/tmpqm14yvav/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpqm14yvav/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--bind', '/tmp/tmpqm14yvav/mount/usr/bin/true', '/tmp/tmpqm14yvav/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Checking if target_proc (/tmp/tmpqm14yvav/mount/proc) is a mount
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: It is, so unshare will use --mount-proc=/tmp/tmpqm14yvav/mount/proc
Jun 27 11:51:01 ubuntu subiquity_log.3661[5835]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpqm14yvav/mount/proc', '--', 'chroot', '/tmp/tmpqm14yvav/mount', 'apt-get', 'update'] with allowed return codes [0] (capture=False)
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:1 file:/cdrom noble InRelease
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Ign:1 file:/cdrom noble InRelease
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:2 file:/cdrom noble Release [1,072 B]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:2 file:/cdrom noble Release [1,072 B]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:3 file:/cdrom noble Release.gpg [833 B]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:3 file:/cdrom noble Release.gpg [833 B]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:4 file:/cdrom noble/main amd64 Packages [53.0 kB]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Ign:4 file:/cdrom noble/main amd64 Packages
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:5 file:/cdrom noble/restricted amd64 Packages [15.2 kB]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Ign:5 file:/cdrom noble/restricted amd64 Packages
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:4 file:/cdrom noble/main amd64 Packages [53.0 kB]
Jun 27 11:51:01 ubuntu subiquity_log.3661[5846]: Get:5 file:/cdrom noble/restricted amd64 Packages [15.2 kB]
Jun 27 11:51:01 ubuntu subiquity_event.3661[3661]:  curtin command in-target
Jun 27 11:51:02 ubuntu subiquity_log.3661[5846]: Get:6 http://security.ubuntu.com/ubuntu noble-security InRelease [126 kB]
Jun 27 11:51:02 ubuntu subiquity_log.3661[5846]: Get:7 http://ng.archive.ubuntu.com/ubuntu noble InRelease [256 kB]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:8 http://security.ubuntu.com/ubuntu noble-security/main amd64 Packages [180 kB]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:9 http://security.ubuntu.com/ubuntu noble-security/main Translation-en [46.1 kB]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:10 http://security.ubuntu.com/ubuntu noble-security/main amd64 Components [6,876 B]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:11 http://security.ubuntu.com/ubuntu noble-security/main Icons (48x48) [9,524 B]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:12 http://security.ubuntu.com/ubuntu noble-security/main Icons (64x64) [11.2 kB]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:13 http://security.ubuntu.com/ubuntu noble-security/main Icons (64x64@2) [29 B]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:14 http://security.ubuntu.com/ubuntu noble-security/restricted amd64 Packages [131 kB]
Jun 27 11:51:03 ubuntu subiquity_log.3661[5846]: Get:15 http://ng.archive.ubuntu.com/ubuntu noble-updates InRelease [126 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:16 http://ng.archive.ubuntu.com/ubuntu noble-backports InRelease [126 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:17 http://security.ubuntu.com/ubuntu noble-security/restricted Translation-en [25.4 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:18 http://security.ubuntu.com/ubuntu noble-security/restricted amd64 Components [212 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:19 http://security.ubuntu.com/ubuntu noble-security/restricted Icons (48x48) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:20 http://security.ubuntu.com/ubuntu noble-security/restricted Icons (64x64) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:21 http://security.ubuntu.com/ubuntu noble-security/restricted Icons (64x64@2) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:22 http://security.ubuntu.com/ubuntu noble-security/universe amd64 Packages [61.2 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:23 http://security.ubuntu.com/ubuntu noble-security/universe Translation-en [21.1 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:24 http://security.ubuntu.com/ubuntu noble-security/universe amd64 Components [8,632 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:25 http://security.ubuntu.com/ubuntu noble-security/universe Icons (48x48) [3,763 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:26 http://security.ubuntu.com/ubuntu noble-security/universe Icons (64x64) [4,851 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:27 http://ng.archive.ubuntu.com/ubuntu noble/main amd64 Packages [1,401 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:28 http://security.ubuntu.com/ubuntu noble-security/universe Icons (64x64@2) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:29 http://security.ubuntu.com/ubuntu noble-security/universe amd64 c-n-f Metadata [112 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:30 http://security.ubuntu.com/ubuntu noble-security/multiverse amd64 Packages [10.6 kB]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:31 http://security.ubuntu.com/ubuntu noble-security/multiverse Translation-en [2,808 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:32 http://security.ubuntu.com/ubuntu noble-security/multiverse amd64 Components [208 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:33 http://security.ubuntu.com/ubuntu noble-security/multiverse Icons (48x48) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:34 http://security.ubuntu.com/ubuntu noble-security/multiverse Icons (64x64) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:35 http://security.ubuntu.com/ubuntu noble-security/multiverse Icons (64x64@2) [29 B]
Jun 27 11:51:04 ubuntu subiquity_log.3661[5846]: Get:36 http://security.ubuntu.com/ubuntu noble-security/multiverse amd64 c-n-f Metadata [116 B]
Jun 27 11:51:05 ubuntu subiquity_log.3661[5846]: Get:37 http://ng.archive.ubuntu.com/ubuntu noble/main Translation-en [513 kB]
Jun 27 11:51:05 ubuntu subiquity_log.3661[5846]: Get:38 http://ng.archive.ubuntu.com/ubuntu noble/restricted amd64 Packages [93.9 kB]
Jun 27 11:51:05 ubuntu subiquity_log.3661[5846]: Get:39 http://ng.archive.ubuntu.com/ubuntu noble/restricted Translation-en [18.7 kB]
Jun 27 11:51:05 ubuntu subiquity_log.3661[5846]: Get:40 http://ng.archive.ubuntu.com/ubuntu noble/universe amd64 Packages [15.0 MB]
Jun 27 11:51:15 ubuntu subiquity_log.3661[5846]: Get:41 http://ng.archive.ubuntu.com/ubuntu noble/universe Translation-en [5,982 kB]
Jun 27 11:51:18 ubuntu subiquity_log.3661[5846]: Get:42 http://ng.archive.ubuntu.com/ubuntu noble/universe amd64 Components [3,871 kB]
Jun 27 11:51:20 ubuntu subiquity_log.3661[5846]: Get:43 http://ng.archive.ubuntu.com/ubuntu noble/universe Icons (48x48) [3,717 kB]
Jun 27 11:51:22 ubuntu subiquity_log.3661[5846]: Get:44 http://ng.archive.ubuntu.com/ubuntu noble/universe Icons (64x64) [7,747 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:45 http://ng.archive.ubuntu.com/ubuntu noble/universe Icons (64x64@2) [75.0 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:46 http://ng.archive.ubuntu.com/ubuntu noble/universe amd64 c-n-f Metadata [301 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:47 http://ng.archive.ubuntu.com/ubuntu noble/multiverse amd64 Packages [269 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:48 http://ng.archive.ubuntu.com/ubuntu noble/multiverse Translation-en [118 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:49 http://ng.archive.ubuntu.com/ubuntu noble/multiverse amd64 Components [35.0 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:50 http://ng.archive.ubuntu.com/ubuntu noble/multiverse Icons (48x48) [56.1 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:51 http://ng.archive.ubuntu.com/ubuntu noble/multiverse Icons (64x64) [186 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:52 http://ng.archive.ubuntu.com/ubuntu noble/multiverse Icons (64x64@2) [904 B]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:53 http://ng.archive.ubuntu.com/ubuntu noble/multiverse amd64 c-n-f Metadata [8,328 B]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:54 http://ng.archive.ubuntu.com/ubuntu noble-updates/main amd64 Packages [205 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:55 http://ng.archive.ubuntu.com/ubuntu noble-updates/main Translation-en [54.9 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:56 http://ng.archive.ubuntu.com/ubuntu noble-updates/main amd64 Components [8,564 B]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:57 http://ng.archive.ubuntu.com/ubuntu noble-updates/main Icons (48x48) [12.6 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:58 http://ng.archive.ubuntu.com/ubuntu noble-updates/main Icons (64x64) [15.1 kB]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:59 http://ng.archive.ubuntu.com/ubuntu noble-updates/main Icons (64x64@2) [29 B]
Jun 27 11:51:28 ubuntu subiquity_log.3661[5846]: Get:60 http://ng.archive.ubuntu.com/ubuntu noble-updates/restricted amd64 Packages [135 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:61 http://ng.archive.ubuntu.com/ubuntu noble-updates/restricted Translation-en [25.9 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:62 http://ng.archive.ubuntu.com/ubuntu noble-updates/restricted amd64 Components [212 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:63 http://ng.archive.ubuntu.com/ubuntu noble-updates/restricted Icons (48x48) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:64 http://ng.archive.ubuntu.com/ubuntu noble-updates/restricted Icons (64x64) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:65 http://ng.archive.ubuntu.com/ubuntu noble-updates/restricted Icons (64x64@2) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:66 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe amd64 Packages [91.8 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:67 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe Translation-en [32.5 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:68 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe amd64 Components [45.0 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:69 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe Icons (48x48) [15.6 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:70 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe Icons (64x64) [21.5 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:71 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe Icons (64x64@2) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:72 http://ng.archive.ubuntu.com/ubuntu noble-updates/universe amd64 c-n-f Metadata [112 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:73 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse amd64 Packages [14.1 kB]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:74 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse Translation-en [3,608 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:75 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse amd64 Components [212 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:76 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse Icons (48x48) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:77 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse Icons (64x64) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:78 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse Icons (64x64@2) [29 B]
Jun 27 11:51:29 ubuntu subiquity_log.3661[5846]: Get:79 http://ng.archive.ubuntu.com/ubuntu noble-updates/multiverse amd64 c-n-f Metadata [116 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:80 http://ng.archive.ubuntu.com/ubuntu noble-backports/main amd64 Components [208 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:81 http://ng.archive.ubuntu.com/ubuntu noble-backports/main Icons (48x48) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:82 http://ng.archive.ubuntu.com/ubuntu noble-backports/main Icons (64x64) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:83 http://ng.archive.ubuntu.com/ubuntu noble-backports/main Icons (64x64@2) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:84 http://ng.archive.ubuntu.com/ubuntu noble-backports/main amd64 c-n-f Metadata [112 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:85 http://ng.archive.ubuntu.com/ubuntu noble-backports/restricted amd64 Components [216 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:86 http://ng.archive.ubuntu.com/ubuntu noble-backports/restricted Icons (48x48) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:87 http://ng.archive.ubuntu.com/ubuntu noble-backports/restricted Icons (64x64) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:88 http://ng.archive.ubuntu.com/ubuntu noble-backports/restricted Icons (64x64@2) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:89 http://ng.archive.ubuntu.com/ubuntu noble-backports/restricted amd64 c-n-f Metadata [116 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:90 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe amd64 Packages [6,840 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:91 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe Translation-en [9,652 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:92 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe amd64 Components [17.6 kB]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:93 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe Icons (48x48) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:94 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe Icons (64x64) [2,900 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:95 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe Icons (64x64@2) [29 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:96 http://ng.archive.ubuntu.com/ubuntu noble-backports/universe amd64 c-n-f Metadata [116 B]
Jun 27 11:51:30 ubuntu subiquity_log.3661[5846]: Get:97 http://ng.archive.ubuntu.com/ubuntu noble-backports/multiverse amd64 Components [212 B]
Jun 27 11:51:31 ubuntu subiquity_log.3661[5846]: Get:98 http://ng.archive.ubuntu.com/ubuntu noble-backports/multiverse Icons (48x48) [29 B]
Jun 27 11:51:31 ubuntu subiquity_log.3661[5846]: Get:99 http://ng.archive.ubuntu.com/ubuntu noble-backports/multiverse Icons (64x64) [29 B]
Jun 27 11:51:31 ubuntu subiquity_log.3661[5846]: Get:100 http://ng.archive.ubuntu.com/ubuntu noble-backports/multiverse Icons (64x64@2) [29 B]
Jun 27 11:51:31 ubuntu subiquity_log.3661[5846]: Get:101 http://ng.archive.ubuntu.com/ubuntu noble-backports/multiverse amd64 c-n-f Metadata [116 B]
Jun 27 11:51:39 ubuntu subiquity_log.3661[5846]: Fetched 41.3 MB in 30s (1,399 kB/s)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5846]: Reading package lists...
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: TIMED subp(['udevadm', 'settle']): 0.004
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--make-private', '/tmp/tmpqm14yvav/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['umount', '/tmp/tmpqm14yvav/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--make-private', '/tmp/tmpqm14yvav/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['umount', '/tmp/tmpqm14yvav/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--make-private', '/tmp/tmpqm14yvav/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['umount', '/tmp/tmpqm14yvav/mount/sys'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--make-private', '/tmp/tmpqm14yvav/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['umount', '/tmp/tmpqm14yvav/mount/run'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--make-private', '/tmp/tmpqm14yvav/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['umount', '/tmp/tmpqm14yvav/mount/proc'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['mount', '--make-private', '/tmp/tmpqm14yvav/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: Running command ['umount', '/tmp/tmpqm14yvav/mount/dev'] with allowed return codes [0] (capture=False)
Jun 27 11:51:40 ubuntu subiquity_log.3661[5835]: finish: cmd-in-target: SUCCESS: curtin command in-target
Jun 27 11:51:40 ubuntu subiquity_event.3661[3661]:  curtin command in-target
Jun 27 11:51:40 ubuntu subiquity_event.3661[3661]: configuring apt
Jun 27 11:51:40 ubuntu subiquity_event.3661[3661]: installing system
Jun 27 11:51:40 ubuntu subiquity_event.3661[3661]:  executing curtin install initial step
Jun 27 11:51:41 ubuntu subiquity_log.3661[6220]: /usr/bin/ubuntu-drivers
Jun 27 11:51:41 ubuntu subiquity_log.3661[6221]: /usr/bin/ubuntu-drivers
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: start: cmd-install: curtin command install
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: LANG=en_US.UTF-8
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: 'reporter' not found in config file.
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: Exporting resume data to /tmp/tmpoma74h2z/resume-data.json so that further stages can be executed in a later invocation.
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: {'WORKING_DIR': '/tmp/tmpo81ovzhj/scratch', 'OUTPUT_FSTAB': '/tmp/tmpo81ovzhj/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmpo81ovzhj/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmpo81ovzhj/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmpo81ovzhj/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmpo81ovzhj/state/config'}
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: curtin: Installation finished.
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: Skipping unmount: config disabled target unmounting
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: TIMED INSTALL_COMMAND: 0.004
Jun 27 11:51:42 ubuntu subiquity_log.3661[6213]: finish: cmd-install: SUCCESS: curtin command install
Jun 27 11:51:42 ubuntu subiquity_event.3661[3661]:  executing curtin install initial step
Jun 27 11:51:42 ubuntu subiquity_event.3661[3661]:  executing curtin install partitioning step
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: start: cmd-install: curtin command install
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: unknown type for url 'cp:///tmp/tmpqm14yvav/mount', assuming type 'tgz'
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: LANG=en_US.UTF-8
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: 'reporter' not found in config file.
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: {'WORKING_DIR': '/tmp/tmpo81ovzhj/scratch', 'OUTPUT_FSTAB': '/tmp/tmpo81ovzhj/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmpo81ovzhj/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmpo81ovzhj/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmpo81ovzhj/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmpo81ovzhj/state/config'}
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: start: cmd-install/stage-partitioning: configuring storage
Jun 27 11:51:45 ubuntu subiquity_log.3661[6241]: start: cmd-install/stage-partitioning/builtin: running 'curtin block-meta simple'
Jun 27 11:51:45 ubuntu subiquity_event.3661[3661]:   curtin command install
Jun 27 11:51:45 ubuntu subiquity_event.3661[3661]:    configuring storage
Jun 27 11:51:45 ubuntu subiquity_event.3661[3661]:     running 'curtin block-meta simple'
Jun 27 11:51:46 ubuntu subiquity_log.3661[6241]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device? False
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device member? False
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:51:47 ubuntu subiquity_log.3661[6241]: Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:51:47 ubuntu subiquity_event.3661[3661]:      curtin command block-meta
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.151
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: return volume path /dev/nvme0n1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme0n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device? False
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.023
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: return volume path /dev/nvme0n1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.021
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: return volume path /dev/nvme0n1p1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme0n1', 'size': 254930845696, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device? False
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.015
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: return volume path /dev/nvme0n1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.016
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: return volume path /dev/nvme0n1p2
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: block-meta: extracted devices to clear: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Declared block devices: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: clearing devices=['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm assemble scan results:
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: looking for devices for further assembly
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop14
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop13
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop10
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop11
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop12
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop9
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop8
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: Cannot assemble mbr metadata on /dev/sda1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: Cannot assemble mbr metadata on /dev/sda
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/dm-0
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop7
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop6
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop5
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop4
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop3
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop2
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop1
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: no recogniseable superblock on /dev/loop0
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm: No arrays found in config file or automatically
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: mdadm detail scan after assemble:
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.007
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:17 ubuntu subiquity_event.3661[3661]:       removing previous storage devices
Jun 27 11:52:17 ubuntu subiquity_log.3661[6241]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: TIMED udevadm_settle(): 0.013
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Loading kernel module bcache via modprobe
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Generating device storage trees for path(s): ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/nvme0n1' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/nvme0n1p3' had holders: ['dm-0']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/dm-0' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/dm-0'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: /dev/dm-0 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['dmsetup', 'info', '/dev/dm-0', '-C', '-o', 'uuid', '--noheadings'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Current device storage tree:
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: |-- nvme0n1p3
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: |   `-- dm-0
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: |-- nvme0n1p1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: `-- nvme0n1p2
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: nvme0n1p1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: nvme0n1p2
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Shutdown Plan:
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: {'level': 4, 'device': '/sys/class/block/dm-0', 'dev_type': 'lvm'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: {'level': 4, 'device': '/sys/class/block/nvme0n1p1', 'dev_type': 'partition'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: {'level': 4, 'device': '/sys/class/block/nvme0n1p2', 'dev_type': 'partition'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: {'level': 3, 'device': '/sys/class/block/nvme0n1p3', 'dev_type': 'partition'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: {'level': 2, 'device': '/sys/class/block/nvme0n1', 'dev_type': 'disk'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: shutdown running on holder type: 'lvm' syspath: '/sys/class/block/dm-0'
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['dmsetup', 'splitname', 'ubuntu--vg-ubuntu--lv', '-c', '--noheadings', '--separator', '=', '-o', 'vg_name,lv_name'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Wiping lvm logical volume: /dev/ubuntu-vg/ubuntu-lv
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: wipefs: /dev/ubuntu-vg/ubuntu-lv: cannot flush modified buffers: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: FAIL: removing previous storage devices
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: TIMED BLOCK_META: 31.197
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Traceback (most recent call last):
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     ret = args.func(args)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     return log_time("TIMED %s: " % msg, func, *args, **kwargs)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     return func(*args, **kwargs)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 118, in block_meta
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     meta_clear(devices, state.get('report_stack_prefix', ''))
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2213, in meta_clear
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     clear_holders.clear_holders(devices)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 638, in clear_holders
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     shutdown_function(dev_info['device'])
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 134, in shutdown_lvm
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     block.quick_zero(devname, partitions=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/__init__.py", line 1234, in quick_zero
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     util.subp(['wipefs', '--all', '--force', path])
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     return _subp(*args, **kwargs)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:     raise ProcessExecutionError(stdout=out, stderr=err,
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Exit code: 1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Reason: -
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Stdout: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Stderr: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Unexpected error while running command.
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Exit code: 1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Reason: -
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Stdout: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Stderr: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: builtin command failed
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: finish: cmd-install/stage-partitioning/builtin: FAIL: running 'curtin block-meta simple'
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: builtin took 33.221 seconds
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: stage_partitioning took 33.221 seconds
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: finish: cmd-install/stage-partitioning: FAIL: configuring storage
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: curtin: Installation failed with exception: Unexpected error while running command.
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Command: ['curtin', 'block-meta', 'simple']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Exit code: 3
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Reason: -
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.151
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme0n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.023
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.021
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1p1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme0n1', 'size': 254930845696, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.015
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.016
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1p2
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         block-meta: extracted devices to clear: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Declared block devices: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         clearing devices=['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm assemble scan results:
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: looking for devices for further assembly
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop14
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop13
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop10
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop11
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop12
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop9
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop8
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: Cannot assemble mbr metadata on /dev/sda1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: Cannot assemble mbr metadata on /dev/sda
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/dm-0
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop7
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop6
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop5
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop4
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop3
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop2
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop0
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm: No arrays found in config file or automatically
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         mdadm detail scan after assemble:
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.007
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['pvscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['vgscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.013
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Loading kernel module bcache via modprobe
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Generating device storage trees for path(s): ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p3' had holders: ['dm-0']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/dm-0' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/dm-0'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         /dev/dm-0 is multipath device partition? False
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['dmsetup', 'info', '/dev/dm-0', '-C', '-o', 'uuid', '--noheadings'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Current device storage tree:
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         nvme0n1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         |-- nvme0n1p3
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         |   `-- dm-0
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         |-- nvme0n1p1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         `-- nvme0n1p2
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         nvme0n1p1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         nvme0n1p2
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Shutdown Plan:
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/dm-0', 'dev_type': 'lvm'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/nvme0n1p1', 'dev_type': 'partition'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/nvme0n1p2', 'dev_type': 'partition'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         {'level': 3, 'device': '/sys/class/block/nvme0n1p3', 'dev_type': 'partition'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         {'level': 2, 'device': '/sys/class/block/nvme0n1', 'dev_type': 'disk'}
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         shutdown running on holder type: 'lvm' syspath: '/sys/class/block/dm-0'
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['dmsetup', 'splitname', 'ubuntu--vg-ubuntu--lv', '-c', '--noheadings', '--separator', '=', '-o', 'vg_name,lv_name'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Wiping lvm logical volume: /dev/ubuntu-vg/ubuntu-lv
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Running command ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv'] with allowed return codes [0] (capture=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         wipefs: /dev/ubuntu-vg/ubuntu-lv: cannot flush modified buffers: Input/output error
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: FAIL: removing previous storage devices
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         TIMED BLOCK_META: 31.197
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Traceback (most recent call last):
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             ret = args.func(args)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             return log_time("TIMED %s: " % msg, func, *args, **kwargs)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             return func(*args, **kwargs)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 118, in block_meta
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             meta_clear(devices, state.get('report_stack_prefix', ''))
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2213, in meta_clear
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             clear_holders.clear_holders(devices)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 638, in clear_holders
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             shutdown_function(dev_info['device'])
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 134, in shutdown_lvm
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             block.quick_zero(devname, partitions=False)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/__init__.py", line 1234, in quick_zero
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             util.subp(['wipefs', '--all', '--force', path])
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             return _subp(*args, **kwargs)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:             raise ProcessExecutionError(stdout=out, stderr=err,
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Exit code: 1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Reason: -
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Stdout: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Stderr: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Unexpected error while running command.
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Exit code: 1
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Reason: -
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Stdout: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         Stderr: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Stderr: ''
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['uname', '-a'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_log.3661[6241]: Running command ['sudo', 'lshw'] with allowed return codes [0] (capture=True)
Jun 27 11:52:18 ubuntu subiquity_event.3661[3661]:       removing previous storage devices
Jun 27 11:52:18 ubuntu subiquity_event.3661[3661]:      curtin command block-meta
Jun 27 11:52:18 ubuntu subiquity_event.3661[3661]:     running 'curtin block-meta simple'
Jun 27 11:52:18 ubuntu subiquity_event.3661[3661]:    configuring storage
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Running command ['ip', '--oneline', 'address', 'list'] with allowed return codes [0] (capture=combine)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Running command ['ip', '--oneline', '-6', 'address', 'list'] with allowed return codes [0] (capture=combine)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Running command ['ip', '--oneline', 'route', 'list'] with allowed return codes [0] (capture=combine)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Running command ['ip', '--oneline', '-6', 'route', 'list'] with allowed return codes [0] (capture=combine)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Running command ['tar', '-cvf', '/var/log/installer/curtin-errors.tar', 'curtin-logs-2024-06-27-10-52'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Wrote: /var/log/installer/curtin-errors.tar
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Skipping unmount: config disabled target unmounting
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: TIMED INSTALL_COMMAND: 35.675
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: finish: cmd-install: FAIL: curtin command install
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Traceback (most recent call last):
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:     ret = args.func(args)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:     return log_time("TIMED %s: " % msg, func, *args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:     return func(*args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/install.py", line 538, in cmd_install
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:     raise e
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/install.py", line 523, in cmd_install
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:     stage.run()
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:   File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/install.py", line 295, in run
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:     raise util.ProcessExecutionError(
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Command: ['curtin', 'block-meta', 'simple']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Exit code: 3
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Reason: -
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.151
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme0n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.023
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.021
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1p1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme0n1', 'size': 254930845696, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.015
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.016
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1p2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block-meta: extracted devices to clear: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Declared block devices: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         clearing devices=['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm assemble scan results:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: looking for devices for further assembly
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop14
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop13
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop10
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop11
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop12
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop9
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop8
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: Cannot assemble mbr metadata on /dev/sda1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: Cannot assemble mbr metadata on /dev/sda
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/dm-0
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop7
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop6
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop5
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop4
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop3
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop0
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: No arrays found in config file or automatically
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm detail scan after assemble:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.007
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['pvscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['vgscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.013
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Loading kernel module bcache via modprobe
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Generating device storage trees for path(s): ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p3' had holders: ['dm-0']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/dm-0' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/dm-0'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/dm-0 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['dmsetup', 'info', '/dev/dm-0', '-C', '-o', 'uuid', '--noheadings'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Current device storage tree:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         |-- nvme0n1p3
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         |   `-- dm-0
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         |-- nvme0n1p1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         `-- nvme0n1p2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         nvme0n1p1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         nvme0n1p2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Shutdown Plan:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/dm-0', 'dev_type': 'lvm'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/nvme0n1p1', 'dev_type': 'partition'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/nvme0n1p2', 'dev_type': 'partition'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 3, 'device': '/sys/class/block/nvme0n1p3', 'dev_type': 'partition'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 2, 'device': '/sys/class/block/nvme0n1', 'dev_type': 'disk'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         shutdown running on holder type: 'lvm' syspath: '/sys/class/block/dm-0'
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['dmsetup', 'splitname', 'ubuntu--vg-ubuntu--lv', '-c', '--noheadings', '--separator', '=', '-o', 'vg_name,lv_name'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Wiping lvm logical volume: /dev/ubuntu-vg/ubuntu-lv
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         wipefs: /dev/ubuntu-vg/ubuntu-lv: cannot flush modified buffers: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: FAIL: removing previous storage devices
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED BLOCK_META: 31.197
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Traceback (most recent call last):
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             ret = args.func(args)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             return log_time("TIMED %s: " % msg, func, *args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             return func(*args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 118, in block_meta
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             meta_clear(devices, state.get('report_stack_prefix', ''))
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2213, in meta_clear
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             clear_holders.clear_holders(devices)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 638, in clear_holders
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             shutdown_function(dev_info['device'])
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 134, in shutdown_lvm
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             block.quick_zero(devname, partitions=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/__init__.py", line 1234, in quick_zero
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             util.subp(['wipefs', '--all', '--force', path])
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             return _subp(*args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             raise ProcessExecutionError(stdout=out, stderr=err,
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Exit code: 1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Reason: -
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stdout: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stderr: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Unexpected error while running command.
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Exit code: 1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Reason: -
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stdout: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stderr: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Stderr: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Unexpected error while running command.
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Command: ['curtin', 'block-meta', 'simple']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Exit code: 3
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Reason: -
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.151
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme0n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.023
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.021
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1p1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme0n1', 'size': 254930845696, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         get_path_to_storage_volume for volume disk-nvme0n1({'ptable': 'gpt', 'serial': 'KXG50ZNV256G_TOSHIBA_Z7QB54Z5K5VS_1', 'wwn': 'eui.000000000000001000080d0300266161', 'nvme_controller': 'nvme-controller-nvme0', 'path': '/dev/nvme0n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme0n1', 'type': 'disk'})
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Processing serial eui.000000000000001000080d0300266161 via udev to eui.000000000000001000080d0300266161
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         lookup_disks found: ['nvme-eui.000000000000001000080d0300266161', 'nvme-eui.000000000000001000080d0300266161-part2', 'nvme-eui.000000000000001000080d0300266161-part1', 'nvme-eui.000000000000001000080d0300266161-part3']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme0n1'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device member? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block.lookup_disk() returning path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.015
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['partprobe', '/dev/nvme0n1'] with allowed return codes [0, 1] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p2: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1p3: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Warning: Error fsyncing/closing /dev/nvme0n1: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.016
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devsync happy - path /dev/nvme0n1 now exists
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         return volume path /dev/nvme0n1p2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         block-meta: extracted devices to clear: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Declared block devices: ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         clearing devices=['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm assemble scan results:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: looking for devices for further assembly
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop14
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop13
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop10
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop11
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop12
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop9
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop8
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: Cannot assemble mbr metadata on /dev/sda1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: Cannot assemble mbr metadata on /dev/sda
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/dm-0
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop7
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop6
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop5
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop4
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop3
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: no recogniseable superblock on /dev/loop0
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm: No arrays found in config file or automatically
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         mdadm detail scan after assemble:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.007
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['pvscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['vgscan'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED udevadm_settle(): 0.013
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Loading kernel module bcache via modprobe
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Generating device storage trees for path(s): ['/dev/nvme0n1', '/dev/nvme0n1p1', '/dev/nvme0n1p2']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/nvme0n1 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p3' had holders: ['dm-0']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/dm-0' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['udevadm', 'info', '--query=property', '--export', '/dev/dm-0'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         /dev/dm-0 is multipath device partition? False
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['dmsetup', 'info', '/dev/dm-0', '-C', '-o', 'uuid', '--noheadings'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p1' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         devname '/sys/class/block/nvme0n1p2' had holders: []
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Current device storage tree:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         nvme0n1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         |-- nvme0n1p3
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         |   `-- dm-0
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         |-- nvme0n1p1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         `-- nvme0n1p2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         nvme0n1p1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         nvme0n1p2
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Shutdown Plan:
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/dm-0', 'dev_type': 'lvm'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/nvme0n1p1', 'dev_type': 'partition'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 4, 'device': '/sys/class/block/nvme0n1p2', 'dev_type': 'partition'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 3, 'device': '/sys/class/block/nvme0n1p3', 'dev_type': 'partition'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         {'level': 2, 'device': '/sys/class/block/nvme0n1', 'dev_type': 'disk'}
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         shutdown running on holder type: 'lvm' syspath: '/sys/class/block/dm-0'
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['dmsetup', 'splitname', 'ubuntu--vg-ubuntu--lv', '-c', '--noheadings', '--separator', '=', '-o', 'vg_name,lv_name'] with allowed return codes [0] (capture=True)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Wiping lvm logical volume: /dev/ubuntu-vg/ubuntu-lv
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Running command ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv'] with allowed return codes [0] (capture=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         wipefs: /dev/ubuntu-vg/ubuntu-lv: cannot flush modified buffers: Input/output error
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: FAIL: removing previous storage devices
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         TIMED BLOCK_META: 31.197
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Traceback (most recent call last):
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             ret = args.func(args)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             return log_time("TIMED %s: " % msg, func, *args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             return func(*args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 118, in block_meta
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             meta_clear(devices, state.get('report_stack_prefix', ''))
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2213, in meta_clear
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             clear_holders.clear_holders(devices)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 638, in clear_holders
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             shutdown_function(dev_info['device'])
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/clear_holders.py", line 134, in shutdown_lvm
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             block.quick_zero(devname, partitions=False)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/block/__init__.py", line 1234, in quick_zero
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             util.subp(['wipefs', '--all', '--force', path])
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             return _subp(*args, **kwargs)
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:           File "/snap/ubuntu-desktop-bootstrap/171/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:             raise ProcessExecutionError(stdout=out, stderr=err,
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Exit code: 1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Reason: -
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stdout: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stderr: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Unexpected error while running command.
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Command: ['wipefs', '--all', '--force', '/dev/ubuntu-vg/ubuntu-lv']
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Exit code: 1
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Reason: -
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stdout: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         Stderr: ''
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]:         
Jun 27 11:52:20 ubuntu subiquity_log.3661[6241]: Stderr: ''
Jun 27 11:52:20 ubuntu subiquity_event.3661[3661]:  executing curtin install partitioning step
Jun 27 11:52:20 ubuntu subiquity_event.3661[3661]: installing system
Jun 27 11:52:20 ubuntu subiquity_event.3661[3661]: 
Jun 27 11:52:21 ubuntu subiquity_event.3661[3661]:   curtin command install

Revision history for this message

Sebastien Bacher (seb128) wrote on 2024-06-27:

Thank you for your bug report. Could you check the journalctl log for disk errors?

The log includes this error
> wipefs: /dev/ubuntu-vg/ubuntu-lv: cannot flush modified buffers: Input/output error

which suggests there might have been a disk or installation media problem

Changed in ubuntu-desktop-provision:
status:	New → Incomplete

Report a bug

This report contains Public information

Everyone can see this information.

You are

Subscribing...

Edit bug mail

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.