ubuntu-desktop-provision

24.04 fresh install on lenovo x250 fails

Bug #2069520 reported by wangjianjian0 on 2024-06-16

This bug report will be marked for expiration in 18 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

24.04 fresh install on lenovo x250 fails

Revision history for this message

wangjianjian0 (wangjianjian0) wrote on 2024-06-16:

Download full text (149.2 KiB)

Jun 16 13:54:07 ubuntu subiquity_event.5560[5560]: subiquity/load_cloud_config/extract_autoinstall: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/load_cloud_config/extract_autoinstall: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Early/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Early/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Reporting/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Reporting/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Error/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Error/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Userdata/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Userdata/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Package/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Package/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Debconf/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Debconf/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Kernel/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Kernel/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Zdev/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Zdev/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Ad/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Ad/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Late/apply_autoinstall_config: 
Jun 16 13:54:09 ubuntu subiquity_event.5560[5560]: subiquity/Late/apply_autoinstall_config: 
Jun 16 13:58:11 ubuntu subiquity_event.5560[5560]: subiquity/Ad/has_support_GET: 
Jun 16 13:58:36 ubuntu subiquity_event.5560[5560]: configuring apt
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: start: cmd-apt-config: curtin command apt-config
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Handling apt to target /tmp/tmpfxuv_g3g/mount with config {'debconf_selections': {'subiquity': ''}, 'disable_components': [], 'disable_suites': ['security'], 'preserve_sources_list': False, 'primary': [{'arches': ['default'], 'uri': 'http://cn.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 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--bind', '/dev', '/tmp/tmpfxuv_g3g/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--bind', '/proc', '/tmp/tmpfxuv_g3g/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--bind', '/run', '/tmp/tmpfxuv_g3g/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--bind', '/sys', '/tmp/tmpfxuv_g3g/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--bind', '/tmp/tmpfxuv_g3g/mount/usr/bin/true', '/tmp/tmpfxuv_g3g/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: got primary mirror: http://cn.archive.ubuntu.com/ubuntu/
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: got security mirror: http://security.ubuntu.com/ubuntu/
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Apt Mirror info: {'PRIMARY': 'http://cn.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu/', 'MIRROR': 'http://cn.archive.ubuntu.com/ubuntu/'}
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Applying debconf selections
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:38 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Checking if target_proc (/tmp/tmpfxuv_g3g/mount/proc) is a mount
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: It is, so unshare will use --mount-proc=/tmp/tmpfxuv_g3g/mount/proc
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpfxuv_g3g/mount/proc', '--', 'chroot', '/tmp/tmpfxuv_g3g/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64 to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64 to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_InRelease to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_InRelease
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64 to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64 to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Renaming apt list /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en to /tmp/tmpfxuv_g3g/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: TIMED subp(['udevadm', 'settle']): 0.005
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--make-private', '/tmp/tmpfxuv_g3g/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['umount', '/tmp/tmpfxuv_g3g/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--make-private', '/tmp/tmpfxuv_g3g/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['umount', '/tmp/tmpfxuv_g3g/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--make-private', '/tmp/tmpfxuv_g3g/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['umount', '/tmp/tmpfxuv_g3g/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--make-private', '/tmp/tmpfxuv_g3g/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['umount', '/tmp/tmpfxuv_g3g/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['mount', '--make-private', '/tmp/tmpfxuv_g3g/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: Running command ['umount', '/tmp/tmpfxuv_g3g/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:39 ubuntu subiquity_log.5560[6805]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: start: cmd-apt-config: curtin command apt-config
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Handling apt to target /tmp/tmp38k__ued/mount with config {'debconf_selections': {'subiquity': ''}, 'disable_components': [], 'preserve_sources_list': False, 'primary': [{'arches': ['default'], 'uri': 'http://cn.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 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--bind', '/dev', '/tmp/tmp38k__ued/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--bind', '/proc', '/tmp/tmp38k__ued/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--bind', '/run', '/tmp/tmp38k__ued/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--bind', '/sys', '/tmp/tmp38k__ued/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--bind', '/tmp/tmp38k__ued/mount/usr/bin/true', '/tmp/tmp38k__ued/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: got primary mirror: http://cn.archive.ubuntu.com/ubuntu/
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: got security mirror: http://security.ubuntu.com/ubuntu/
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Apt Mirror info: {'PRIMARY': 'http://cn.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu/', 'MIRROR': 'http://cn.archive.ubuntu.com/ubuntu/'}
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Applying debconf selections
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Checking if target_proc (/tmp/tmp38k__ued/mount/proc) is a mount
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: It is, so unshare will use --mount-proc=/tmp/tmp38k__ued/mount/proc
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp38k__ued/mount/proc', '--', 'chroot', '/tmp/tmp38k__ued/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble-updates_InRelease
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64 to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble-updates_main_cnf_Commands-amd64
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64 to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble-updates_restricted_cnf_Commands-amd64
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_InRelease to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_InRelease
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_binary-amd64_Packages
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64 to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_cnf_Commands-amd64
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_Components-amd64.yml.gz
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-48x48.tar.gz
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64%402.tar.gz
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_dep11_icons-64x64.tar.gz
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_main_i18n_Translation-en
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_restricted_binary-amd64_Packages
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64 to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_restricted_cnf_Commands-amd64
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Renaming apt list /tmp/tmp38k__ued/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en to /tmp/tmp38k__ued/mount/var/lib/apt/lists/cn.archive.ubuntu.com_ubuntu_dists_noble_restricted_i18n_Translation-en
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: TIMED subp(['udevadm', 'settle']): 0.004
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--make-private', '/tmp/tmp38k__ued/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['umount', '/tmp/tmp38k__ued/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--make-private', '/tmp/tmp38k__ued/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['umount', '/tmp/tmp38k__ued/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--make-private', '/tmp/tmp38k__ued/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['umount', '/tmp/tmp38k__ued/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--make-private', '/tmp/tmp38k__ued/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['umount', '/tmp/tmp38k__ued/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['mount', '--make-private', '/tmp/tmp38k__ued/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: Running command ['umount', '/tmp/tmp38k__ued/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:50 ubuntu subiquity_log.5560[7067]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: start: cmd-in-target: curtin command in-target
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--bind', '/dev', '/tmp/tmpp86t_4qv/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--bind', '/proc', '/tmp/tmpp86t_4qv/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--bind', '/run', '/tmp/tmpp86t_4qv/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--bind', '/sys', '/tmp/tmpp86t_4qv/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--bind', '/tmp/tmpp86t_4qv/mount/usr/bin/true', '/tmp/tmpp86t_4qv/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Checking if target_proc (/tmp/tmpp86t_4qv/mount/proc) is a mount
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: It is, so unshare will use --mount-proc=/tmp/tmpp86t_4qv/mount/proc
Jun 16 13:58:52 ubuntu subiquity_log.5560[7139]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpp86t_4qv/mount/proc', '--', 'chroot', '/tmp/tmpp86t_4qv/mount', 'apt-get', 'update'] with allowed return codes [0] (capture=False)
Jun 16 13:58:52 ubuntu subiquity_log.5560[7221]: Get:1 file:/cdrom noble InRelease
Jun 16 13:58:52 ubuntu subiquity_log.5560[7221]: Ign:1 file:/cdrom noble InRelease
Jun 16 13:58:52 ubuntu subiquity_log.5560[7221]: Get:2 file:/cdrom noble Release [1,072 B]
Jun 16 13:58:52 ubuntu subiquity_log.5560[7221]: Get:2 file:/cdrom noble Release [1,072 B]
Jun 16 13:58:52 ubuntu subiquity_log.5560[7221]: Get:3 file:/cdrom noble Release.gpg [833 B]
Jun 16 13:58:52 ubuntu subiquity_log.5560[7221]: Get:3 file:/cdrom noble Release.gpg [833 B]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:6 file:/cdrom noble/main amd64 Packages [53.0 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Ign:6 file:/cdrom noble/main amd64 Packages
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:7 file:/cdrom noble/restricted amd64 Packages [15.2 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Ign:7 file:/cdrom noble/restricted amd64 Packages
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:6 file:/cdrom noble/main amd64 Packages [53.0 kB]
Jun 16 13:58:53 ubuntu subiquity_event.5560[5560]:  curtin command in-target
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:4 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble InRelease [256 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:7 file:/cdrom noble/restricted amd64 Packages [15.2 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:5 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates InRelease [126 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:9 http://security.ubuntu.com/ubuntu noble-security InRelease [126 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:8 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports InRelease [126 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:10 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/main amd64 Packages [1,401 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:11 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/main Translation-en [513 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:12 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/restricted amd64 Packages [93.9 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:13 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/restricted Translation-en [18.7 kB]
Jun 16 13:58:53 ubuntu subiquity_log.5560[7221]: Get:14 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe amd64 Packages [15.0 MB]
Jun 16 13:58:54 ubuntu subiquity_log.5560[7221]: Get:15 http://security.ubuntu.com/ubuntu noble-security/main amd64 Packages [150 kB]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:16 http://security.ubuntu.com/ubuntu noble-security/main Translation-en [39.1 kB]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:17 http://security.ubuntu.com/ubuntu noble-security/main amd64 Components [6,876 B]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:18 http://security.ubuntu.com/ubuntu noble-security/main Icons (48x48) [9,524 B]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:19 http://security.ubuntu.com/ubuntu noble-security/main Icons (64x64) [11.2 kB]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:20 http://security.ubuntu.com/ubuntu noble-security/main Icons (64x64@2) [29 B]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:21 http://security.ubuntu.com/ubuntu noble-security/restricted amd64 Packages [70.1 kB]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:22 http://security.ubuntu.com/ubuntu noble-security/restricted Translation-en [14.3 kB]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:23 http://security.ubuntu.com/ubuntu noble-security/restricted amd64 Components [212 B]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:24 http://security.ubuntu.com/ubuntu noble-security/restricted Icons (48x48) [29 B]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:25 http://security.ubuntu.com/ubuntu noble-security/restricted Icons (64x64) [29 B]
Jun 16 13:58:56 ubuntu subiquity_log.5560[7221]: Get:26 http://security.ubuntu.com/ubuntu noble-security/restricted Icons (64x64@2) [29 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:27 http://security.ubuntu.com/ubuntu noble-security/universe amd64 Packages [42.9 kB]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:28 http://security.ubuntu.com/ubuntu noble-security/universe Translation-en [16.6 kB]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:29 http://security.ubuntu.com/ubuntu noble-security/universe amd64 Components [8,632 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:30 http://security.ubuntu.com/ubuntu noble-security/universe Icons (48x48) [3,763 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:31 http://security.ubuntu.com/ubuntu noble-security/universe Icons (64x64) [4,851 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:32 http://security.ubuntu.com/ubuntu noble-security/universe Icons (64x64@2) [29 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:33 http://security.ubuntu.com/ubuntu noble-security/universe amd64 c-n-f Metadata [112 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:34 http://security.ubuntu.com/ubuntu noble-security/multiverse amd64 Components [208 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:35 http://security.ubuntu.com/ubuntu noble-security/multiverse Icons (48x48) [29 B]
Jun 16 13:58:57 ubuntu subiquity_log.5560[7221]: Get:36 http://security.ubuntu.com/ubuntu noble-security/multiverse Icons (64x64) [29 B]
Jun 16 13:58:58 ubuntu subiquity_log.5560[7221]: Get:37 http://security.ubuntu.com/ubuntu noble-security/multiverse Icons (64x64@2) [29 B]
Jun 16 13:58:58 ubuntu subiquity_log.5560[7221]: Get:38 http://security.ubuntu.com/ubuntu noble-security/multiverse amd64 c-n-f Metadata [116 B]
Jun 16 13:59:00 ubuntu subiquity_log.5560[7221]: Get:39 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe Translation-en [5,982 kB]
Jun 16 13:59:02 ubuntu subiquity_log.5560[7221]: Get:40 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe amd64 Components [3,871 kB]
Jun 16 13:59:03 ubuntu subiquity_log.5560[7221]: Get:41 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe Icons (48x48) [3,717 kB]
Jun 16 13:59:04 ubuntu subiquity_log.5560[7221]: Get:42 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe Icons (64x64) [7,747 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:43 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe Icons (64x64@2) [75.0 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:44 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/universe amd64 c-n-f Metadata [301 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:45 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse amd64 Packages [269 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:46 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse Translation-en [118 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:47 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse amd64 Components [35.0 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:48 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse Icons (48x48) [56.1 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:49 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse Icons (64x64) [186 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:50 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse Icons (64x64@2) [904 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:51 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble/multiverse amd64 c-n-f Metadata [8,328 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:52 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/main amd64 Packages [169 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:53 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/main Translation-en [46.7 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:54 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/main amd64 Components [8,564 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:55 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/main Icons (48x48) [12.6 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:56 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/main Icons (64x64) [15.1 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:57 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/main Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:58 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/restricted amd64 Packages [70.1 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:59 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/restricted Translation-en [14.3 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:60 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/restricted amd64 Components [212 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:61 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/restricted Icons (48x48) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:62 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/restricted Icons (64x64) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:63 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/restricted Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:64 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe amd64 Packages [65.2 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:65 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe Translation-en [24.7 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:66 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe amd64 Components [45.0 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:67 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe Icons (48x48) [15.6 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:68 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe Icons (64x64) [21.5 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:69 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:70 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/universe amd64 c-n-f Metadata [112 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:71 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse amd64 Packages [2,968 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:72 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse Translation-en [968 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:73 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse amd64 Components [212 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:74 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse Icons (48x48) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:75 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse Icons (64x64) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:76 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:77 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-updates/multiverse amd64 c-n-f Metadata [116 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:78 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/main amd64 Components [208 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:79 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/main Icons (48x48) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:80 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/main Icons (64x64) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:81 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/main Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:82 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/main amd64 c-n-f Metadata [112 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:83 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/restricted amd64 Components [216 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:84 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/restricted Icons (48x48) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:85 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/restricted Icons (64x64) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:86 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/restricted Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:87 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/restricted amd64 c-n-f Metadata [116 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:88 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe amd64 Packages [6,840 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:89 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe Translation-en [9,652 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:90 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe amd64 Components [17.6 kB]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:91 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe Icons (48x48) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:92 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe Icons (64x64) [2,900 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:93 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:94 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/universe amd64 c-n-f Metadata [116 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:95 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/multiverse amd64 Components [212 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:96 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/multiverse Icons (48x48) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:97 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/multiverse Icons (64x64) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:98 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/multiverse Icons (64x64@2) [29 B]
Jun 16 13:59:06 ubuntu subiquity_log.5560[7221]: Get:99 http://mirrors.tuna.tsinghua.edu.cn/ubuntu noble-backports/multiverse amd64 c-n-f Metadata [116 B]
Jun 16 13:59:15 ubuntu subiquity_log.5560[7221]: Fetched 41.0 MB in 14s (2,905 kB/s)
Jun 16 13:59:16 ubuntu subiquity_log.5560[7221]: Reading package lists...
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: TIMED subp(['udevadm', 'settle']): 0.006
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--make-private', '/tmp/tmpp86t_4qv/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['umount', '/tmp/tmpp86t_4qv/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--make-private', '/tmp/tmpp86t_4qv/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['umount', '/tmp/tmpp86t_4qv/mount/sys'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--make-private', '/tmp/tmpp86t_4qv/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['umount', '/tmp/tmpp86t_4qv/mount/run'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--make-private', '/tmp/tmpp86t_4qv/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['umount', '/tmp/tmpp86t_4qv/mount/proc'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['mount', '--make-private', '/tmp/tmpp86t_4qv/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: Running command ['umount', '/tmp/tmpp86t_4qv/mount/dev'] with allowed return codes [0] (capture=False)
Jun 16 13:59:17 ubuntu subiquity_log.5560[7139]: finish: cmd-in-target: SUCCESS: curtin command in-target
Jun 16 13:59:17 ubuntu subiquity_event.5560[5560]:  curtin command in-target
Jun 16 13:59:17 ubuntu subiquity_event.5560[5560]: configuring apt
Jun 16 13:59:17 ubuntu subiquity_event.5560[5560]: installing system
Jun 16 13:59:17 ubuntu subiquity_event.5560[5560]:  executing curtin install initial step
Jun 16 13:59:17 ubuntu subiquity_log.5560[7560]: /usr/bin/ubuntu-drivers
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: start: cmd-install: curtin command install
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: LANG=en_US.UTF-8
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: 'reporter' not found in config file.
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: Exporting resume data to /tmp/tmpos2ipklg/resume-data.json so that further stages can be executed in a later invocation.
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: {'WORKING_DIR': '/tmp/tmp4e8cncy6/scratch', 'OUTPUT_FSTAB': '/tmp/tmp4e8cncy6/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmp4e8cncy6/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmp4e8cncy6/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmp4e8cncy6/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmp4e8cncy6/state/config'}
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: curtin: Installation finished.
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: Skipping unmount: config disabled target unmounting
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: TIMED INSTALL_COMMAND: 0.002
Jun 16 13:59:19 ubuntu subiquity_log.5560[7556]: finish: cmd-install: SUCCESS: curtin command install
Jun 16 13:59:19 ubuntu subiquity_event.5560[5560]:  executing curtin install initial step
Jun 16 13:59:19 ubuntu subiquity_event.5560[5560]:  executing curtin install partitioning step
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: start: cmd-install: curtin command install
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: unknown type for url 'cp:///tmp/tmpp86t_4qv/mount', assuming type 'tgz'
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: LANG=en_US.UTF-8
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: 'reporter' not found in config file.
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: {'WORKING_DIR': '/tmp/tmp4e8cncy6/scratch', 'OUTPUT_FSTAB': '/tmp/tmp4e8cncy6/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmp4e8cncy6/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmp4e8cncy6/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmp4e8cncy6/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmp4e8cncy6/state/config'}
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning: configuring storage
Jun 16 13:59:21 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin: running 'curtin block-meta simple'
Jun 16 13:59:22 ubuntu subiquity_event.5560[5560]:   curtin command install
Jun 16 13:59:22 ubuntu subiquity_event.5560[5560]:    configuring storage
Jun 16 13:59:22 ubuntu subiquity_event.5560[5560]:     running 'curtin block-meta simple'
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 90000326656, 'wipe': 'superblock', 'number': 1, 'preserve': False, 'offset': 2097152, 'id': 'partition-2', 'type': 'partition'})
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: Processing serial 0x5000c5008a2dce1b via udev to 0x5000c5008a2dce1b
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: lookup_disks found: ['wwn-0x5000c5008a2dce1b', 'wwn-0x5000c5008a2dce1b-part1', 'wwn-0x5000c5008a2dce1b-part2']
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device? False
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: block.lookup_disk() returning path /dev/sda
Jun 16 13:59:23 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_event.5560[5560]:      curtin command block-meta
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.076
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.065
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda1
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-3({'device': 'disk-sda', 'size': 8000634880, 'wipe': 'superblock', 'flag': 'swap', 'number': 3, 'preserve': False, 'offset': 90002423808, 'id': 'partition-3', 'type': 'partition'})
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Processing serial 0x5000c5008a2dce1b via udev to 0x5000c5008a2dce1b
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: lookup_disks found: ['wwn-0x5000c5008a2dce1b', 'wwn-0x5000c5008a2dce1b-part1', 'wwn-0x5000c5008a2dce1b-part2']
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device? False
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: block.lookup_disk() returning path /dev/sda
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.080
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-4({'device': 'disk-sda', 'size': 402103730176, 'wipe': 'superblock', 'number': 4, 'preserve': False, 'offset': 98003058688, 'id': 'partition-4', 'type': 'partition'})
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Processing serial 0x5000c5008a2dce1b via udev to 0x5000c5008a2dce1b
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: lookup_disks found: ['wwn-0x5000c5008a2dce1b', 'wwn-0x5000c5008a2dce1b-part1', 'wwn-0x5000c5008a2dce1b-part2']
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device? False
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: block.lookup_disk() returning path /dev/sda
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.071
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: block-meta: extracted devices to clear: ['/dev/sda1']
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Declared block devices: ['/dev/sda1']
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: clearing devices=['/dev/sda1']
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm assemble scan results:
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: looking for devices for further assembly
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop15
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop14
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop13
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop12
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop11
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop10
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop9
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop8
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/sdb4
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/sdb3
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/sdb2
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/sdb1
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: Cannot assemble mbr metadata on /dev/sdb
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/sda2
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/sda1
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: Cannot assemble mbr metadata on /dev/sda
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop7
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop6
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop5
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop4
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop3
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop2
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop1
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: no recogniseable superblock on /dev/loop0
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm: No arrays found in config file or automatically
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: mdadm detail scan after assemble:
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.005
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
Jun 16 13:59:24 ubuntu subiquity_event.5560[5560]:       removing previous storage devices
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.011
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Loading kernel module bcache via modprobe
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Generating device storage trees for path(s): ['/dev/sda1']
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: devname '/sys/class/block/sda1' had holders: []
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Current device storage tree:
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: sda1
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Shutdown Plan:
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: {'level': 0, 'device': '/sys/class/block/sda1', 'dev_type': 'partition'}
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: shutdown running on holder type: 'partition' syspath: '/sys/class/block/sda1'
Jun 16 13:59:24 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: info:
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: {
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  "sda": {
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODEL": "ST500LM021-1KJ152",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "NAME": "sda",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "SIZE": "500107862016",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "STATE": "running",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "TYPE": "disk",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "UUID": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda"
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  },
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  "sda1": {
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODEL": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "NAME": "sda1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "SIZE": "1048576",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "STATE": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "TYPE": "part",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "UUID": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda1"
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  },
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  "sda2": {
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "ext4",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda2",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:2",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODEL": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "NAME": "sda2",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "SIZE": "500104691712",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "STATE": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "TYPE": "part",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "UUID": "3fef05a0-c037-4f5a-bb6c-42ed9ec372ae",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda2"
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  }
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: }
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: (log=512, phys=4096)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID'] with allowed return codes [0] (capture=True)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Checking if /dev/sda1 is a swap device
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: wiping superblock on /dev/sda1
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: wiping /dev/sda1 attempt 1/4
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['wipefs', '--all', '--force', '/dev/sda1'] with allowed return codes [0] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: wiping 1M on /dev/sda1 at offsets [0, -1048576]
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: successfully wiped device /dev/sda1 on attempt 1/4
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: devname '/sys/class/block/sda1' had holders: []
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: blockmeta: detected storage config, using mode=custom
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-sda
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_event.5560[5560]:       removing previous storage devices
Jun 16 13:59:25 ubuntu subiquity_event.5560[5560]:       configuring disk: disk-sda
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.099
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Acquiring fcntl LOCK_EX on /dev/sda
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: labeling device: '/dev/sda' with 'gpt' partition table
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['wipefs', '--all', '--force', '/dev/sda'] with allowed return codes [0] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda: 8 bytes were erased at offset 0x00000200 (gpt): 45 46 49 20 50 41 52 54
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda: 8 bytes were erased at offset 0x7470c05e00 (gpt): 45 46 49 20 50 41 52 54
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda: 2 bytes were erased at offset 0x000001fe (PMBR): 55 aa
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: wiping 1M on /dev/sda at offsets [0, -1048576]
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: devname '/dev/sda' had holders: []
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Releasing fcntl LOCK_EX on /dev/sda
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.040
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda'] with allowed return codes [0] (capture=True)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: info:
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: {
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  "sda": {
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MODEL": "ST500LM021-1KJ152",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "NAME": "sda",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "SIZE": "500107862016",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "STATE": "running",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "TYPE": "disk",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "UUID": "",
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda"
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]:  }
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: }
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: (log=512, phys=4096)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: sfdisk input:
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: ---
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: label: gpt
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: 1:  start=4096 size=175781888
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: 2:  start=2048 size=2048 type=21686148-6449-6E6F-744E-656564454649
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: 3:  start=175785984 size=15626240 type=0657FD6D-A4AB-43C4-84E5-0933C84B4F4F
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: 4:  start=191412224 size=785358848
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: ---
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['losetup', '--version'] with allowed return codes [0] (capture=True)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Running command ['sfdisk', '--no-reread', '/dev/sda', '--no-tell-kernel'] with allowed return codes [0] (capture=False)
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Disk /dev/sda: 465.76 GiB, 500107862016 bytes, 976773168 sectors
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Disk model: ST500LM021-1KJ15
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Units: sectors of 1 * 512 = 512 bytes
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Sector size (logical/physical): 512 bytes / 4096 bytes
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: I/O size (minimum/optimal): 4096 bytes / 4096 bytes
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: >>> Script header accepted.
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: >>> Created a new GPT disklabel (GUID: 5E8D0752-E491-4E9F-90C7-9D57F47F4A2D).
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: /dev/sda1: Created a new partition 1 of type 'Linux filesystem' and of size 83.8 GiB.
Jun 16 13:59:25 ubuntu subiquity_log.5560[7575]: Partition #1 contains a ext4 signature.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda2: Created a new partition 2 of type 'BIOS boot' and of size 1 MiB.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda3: Created a new partition 3 of type 'Linux swap' and of size 7.5 GiB.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda4: Created a new partition 4 of type 'Linux filesystem' and of size 374.5 GiB.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda5: Done.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: New situation:
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Disklabel type: gpt
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Disk identifier: 5E8D0752-E491-4E9F-90C7-9D57F47F4A2D
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Device         Start       End   Sectors   Size Type
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda1       4096 175785983 175781888  83.8G Linux filesystem
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda2       2048      4095      2048     1M BIOS boot
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda3  175785984 191412223  15626240   7.5G Linux swap
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda4  191412224 976771071 785358848 374.5G Linux filesystem
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Partition table entries are not in disk order.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: The partition table has been altered.
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.191
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['wipefs', '--all', '--force', '/dev/sda4'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: wiping 1M on /dev/sda4 at offsets [0, -1048576]
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['wipefs', '--all', '--force', '/dev/sda2'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: wiping 1M on /dev/sda2 at offsets [0, -1048576]
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['wipefs', '--all', '--force', '/dev/sda3'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: wiping 1M on /dev/sda3 at offsets [0, -1048576]
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['wipefs', '--all', '--force', '/dev/sda1'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda1: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: wiping 1M on /dev/sda1 at offsets [0, -1048576]
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 90000326656, 'wipe': 'superblock', 'number': 1, 'preserve': False, 'offset': 2097152, 'id': 'partition-2', 'type': 'partition'})
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.118
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:26 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.265
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda1
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['blkid', '-o', 'export', '/dev/sda1'] with allowed return codes [0, 2] (capture=True)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: No partition-specific dname
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-1({'device': 'disk-sda', 'size': 1048576, 'flag': 'bios_grub', 'number': 2, 'preserve': False, 'offset': 1048576, 'id': 'partition-1', 'type': 'partition'})
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.171
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.167
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda2
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['blkid', '-o', 'export', '/dev/sda2'] with allowed return codes [0, 2] (capture=True)
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: No partition-specific dname
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-3({'device': 'disk-sda', 'size': 8000634880, 'wipe': 'superblock', 'flag': 'swap', 'number': 3, 'preserve': False, 'offset': 90002423808, 'id': 'partition-3', 'type': 'partition'})
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:27 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.138
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.188
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda3
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['blkid', '-o', 'export', '/dev/sda3'] with allowed return codes [0, 2] (capture=True)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: No partition-specific dname
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-4({'device': 'disk-sda', 'size': 402103730176, 'wipe': 'superblock', 'number': 4, 'preserve': False, 'offset': 98003058688, 'id': 'partition-4', 'type': 'partition'})
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.147
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:28 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.126
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda4
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['blkid', '-o', 'export', '/dev/sda4'] with allowed return codes [0, 2] (capture=True)
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: No partition-specific dname
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring disk: disk-sda
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring partition: partition-2
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 90000326656, 'wipe': 'superblock', 'number': 1, 'preserve': False, 'offset': 2097152, 'id': 'partition-2', 'type': 'partition'})
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_event.5560[5560]:       configuring disk: disk-sda
Jun 16 13:59:29 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-2
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.108
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.151
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda1
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring partition: partition-2
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring format: format-2
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 90000326656, 'wipe': 'superblock', 'number': 1, 'preserve': False, 'offset': 2097152, 'id': 'partition-2', 'type': 'partition'})
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:29 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-2
Jun 16 13:59:29 ubuntu subiquity_event.5560[5560]:      configuring format: format-2
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.196
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.107
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda1
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: mkfs /dev/sda1 info: {'fstype': 'xfs', 'volume': 'partition-2', 'preserve': False, 'id': 'format-2', 'type': 'format'}
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda1'] with allowed return codes [0] (capture=True)
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: info:
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: {
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:  "sda1": {
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda1",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:1",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "MODEL": "",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "NAME": "sda1",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "SIZE": "90000326656",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "STATE": "",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "TYPE": "part",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "UUID": "",
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda1"
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]:  }
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: }
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: (log=512, phys=4096)
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: Running command ['mkfs.xfs', '-f', '-m', 'uuid=28dbf991-0524-4968-8b0c-04e7b77738e3', '/dev/sda1'] with allowed return codes [0] (capture=True)
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: Formated device type: partition
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring format: format-2
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring mount: mount-1
Jun 16 13:59:30 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-2({'device': 'disk-sda', 'size': 90000326656, 'wipe': 'superblock', 'number': 1, 'preserve': False, 'offset': 2097152, 'id': 'partition-2', 'type': 'partition'})
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:31 ubuntu subiquity_event.5560[5560]:      configuring format: format-2
Jun 16 13:59:31 ubuntu subiquity_event.5560[5560]:      configuring mount: mount-1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.202
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.212
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: volume_path=/dev/sda1 found slaves: ['sda1']
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: kname_is_iscsi: no iscsi disk found for kname sda1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: kname_is_iscsi: no iscsi disk found for kname sda1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['mount', '-t', 'xfs', '-o', 'defaults', '/dev/sda1', '/target/'] with allowed return codes [0] (capture=True)
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda1'] with allowed return codes [0] (capture=True)
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda1'] with allowed return codes [0] (capture=True)
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: volspec: path=/dev/sda1 type=part
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: info[DEVLINKS] = ['/dev/disk/by-path/pci-0000:00:1f.2-ata-1-part1', '/dev/disk/by-diskseq/9-part1', '/dev/disk/by-id/ata-ST500LM021-1KJ152_W625E4GE-part1', '/dev/disk/by-path/pci-0000:00:1f.2-ata-1.0-part1', '/dev/disk/by-partuuid/772c0909-68d2-4ee7-8092-683558ad2e3a', '/dev/disk/by-uuid/28dbf991-0524-4968-8b0c-04e7b77738e3', '/dev/disk/by-id/wwn-0x5000c5008a2dce1b-part1']
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring mount: mount-1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring partition: partition-1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-1({'device': 'disk-sda', 'size': 1048576, 'flag': 'bios_grub', 'number': 2, 'preserve': False, 'offset': 1048576, 'id': 'partition-1', 'type': 'partition'})
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:31 ubuntu subiquity_event.5560[5560]:      configuring mount: mount-1
Jun 16 13:59:31 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-1
Jun 16 13:59:31 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.205
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.113
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda2
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring partition: partition-1
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring partition: partition-3
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-3({'device': 'disk-sda', 'size': 8000634880, 'wipe': 'superblock', 'flag': 'swap', 'number': 3, 'preserve': False, 'offset': 90002423808, 'id': 'partition-3', 'type': 'partition'})
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-1
Jun 16 13:59:32 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-3
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.064
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.076
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda3
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring partition: partition-3
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring format: format-3
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-3({'device': 'disk-sda', 'size': 8000634880, 'wipe': 'superblock', 'flag': 'swap', 'number': 3, 'preserve': False, 'offset': 90002423808, 'id': 'partition-3', 'type': 'partition'})
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:32 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-3
Jun 16 13:59:32 ubuntu subiquity_event.5560[5560]:      configuring format: format-3
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.087
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:32 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.104
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda3
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: mkfs /dev/sda3 info: {'fstype': 'swap', 'volume': 'partition-3', 'preserve': False, 'id': 'format-3', 'type': 'format'}
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda3'] with allowed return codes [0] (capture=True)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: info:
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: {
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:  "sda3": {
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda3",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:3",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "MODEL": "",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "NAME": "sda3",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "SIZE": "8000634880",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "STATE": "",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "TYPE": "part",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "UUID": "",
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda3"
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]:  }
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: }
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: (log=512, phys=4096)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['mkswap', '--force', '--uuid', '359611a4-d347-41dc-be96-af11fb017c6c', '/dev/sda3'] with allowed return codes [0] (capture=True)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Formated device type: partition
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring format: format-3
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring mount: mount-2
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-3({'device': 'disk-sda', 'size': 8000634880, 'wipe': 'superblock', 'flag': 'swap', 'number': 3, 'preserve': False, 'offset': 90002423808, 'id': 'partition-3', 'type': 'partition'})
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.088
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_event.5560[5560]:      configuring format: format-3
Jun 16 13:59:33 ubuntu subiquity_event.5560[5560]:      configuring mount: mount-2
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.114
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda3
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: volume_path=/dev/sda3 found slaves: ['sda3']
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: kname_is_iscsi: no iscsi disk found for kname sda3
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: kname_is_iscsi: no iscsi disk found for kname sda3
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda3'] with allowed return codes [0] (capture=True)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda3'] with allowed return codes [0] (capture=True)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: volspec: path=/dev/sda3 type=part
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: info[DEVLINKS] = ['/dev/disk/by-uuid/359611a4-d347-41dc-be96-af11fb017c6c', '/dev/disk/by-diskseq/9-part3', '/dev/disk/by-path/pci-0000:00:1f.2-ata-1-part3', '/dev/disk/by-partuuid/80369640-2df3-4e57-835e-adf6a26a44f2', '/dev/disk/by-id/ata-ST500LM021-1KJ152_W625E4GE-part3', '/dev/disk/by-id/wwn-0x5000c5008a2dce1b-part3', '/dev/disk/by-path/pci-0000:00:1f.2-ata-1.0-part3']
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring mount: mount-2
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring partition: partition-4
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-4({'device': 'disk-sda', 'size': 402103730176, 'wipe': 'superblock', 'number': 4, 'preserve': False, 'offset': 98003058688, 'id': 'partition-4', 'type': 'partition'})
Jun 16 13:59:33 ubuntu subiquity_event.5560[5560]:      configuring mount: mount-2
Jun 16 13:59:33 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-4
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.082
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:33 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.078
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda4
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring partition: partition-4
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring format: format-4
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-4({'device': 'disk-sda', 'size': 402103730176, 'wipe': 'superblock', 'number': 4, 'preserve': False, 'offset': 98003058688, 'id': 'partition-4', 'type': 'partition'})
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:34 ubuntu subiquity_event.5560[5560]:      configuring partition: partition-4
Jun 16 13:59:34 ubuntu subiquity_event.5560[5560]:      configuring format: format-4
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.101
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.167
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda4
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: mkfs /dev/sda4 info: {'fstype': 'xfs', 'volume': 'partition-4', 'preserve': False, 'id': 'format-4', 'type': 'format'}
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda4'] with allowed return codes [0] (capture=True)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: info:
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: {
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:  "sda4": {
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "ALIGNMENT": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "DISC-ALN": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "DISC-GRAN": "4096",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "DISC-MAX": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "DISC-ZERO": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "FSTYPE": "",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "GROUP": "disk",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "KNAME": "sda4",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "LABEL": "",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "LOG-SEC": "512",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "MAJ:MIN": "8:4",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "MIN-IO": "4096",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "MODE": "brw-rw----",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "MODEL": "",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "MOUNTPOINT": "",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "NAME": "sda4",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "OPT-IO": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "OWNER": "root",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "PHY-SEC": "4096",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "RM": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "RO": "0",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "ROTA": "1",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "RQ-SIZE": "64",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "SIZE": "402103730176",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "STATE": "",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "TYPE": "part",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "UUID": "",
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:   "device_path": "/dev/sda4"
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]:  }
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: }
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: get_blockdev_sector_size: (log=512, phys=4096)
Jun 16 13:59:34 ubuntu subiquity_log.5560[7575]: Running command ['mkfs.xfs', '-f', '-m', 'uuid=503e2669-ae08-4bb4-8635-644bacb208c5', '/dev/sda4'] with allowed return codes [0] (capture=True)
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: Formated device type: partition
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring format: format-4
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring mount: mount-3
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume partition-4({'device': 'disk-sda', 'size': 402103730176, 'wipe': 'superblock', 'number': 4, 'preserve': False, 'offset': 98003058688, 'id': 'partition-4', 'type': 'partition'})
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: get_path_to_storage_volume for volume disk-sda({'ptable': 'gpt', 'serial': 'ST500LM021-1KJ152_W625E4GE', 'wwn': '0x5000c5008a2dce1b', 'path': '/dev/sda', 'preserve': False, 'name': '', 'grub_device': True, 'id': 'disk-sda', 'type': 'disk'})
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: /dev/sda is multipath device member? False
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: found candidate disks [{'/dev/sda'}, {'/dev/sda'}, {'/dev/sda'}]
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:36 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.107
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: Running command ['partprobe', '/dev/sda'] with allowed return codes [0, 1] (capture=False)
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:      configuring format: format-4
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:      configuring mount: mount-3
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: TIMED udevadm_settle(): 0.094
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: devsync happy - path /dev/sda now exists
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: return volume path /dev/sda4
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: volume_path=/dev/sda4 found slaves: ['sda4']
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: kname_is_iscsi: no iscsi disk found for kname sda4
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: kname_is_iscsi: no iscsi disk found for kname sda4
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: Running command ['mount', '-t', 'xfs', '-o', 'defaults', '/dev/sda4', '/target/home'] with allowed return codes [0] (capture=True)
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/sda4'] with allowed return codes [0] (capture=True)
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: Running command ['lsblk', '--noheadings', '--bytes', '--pairs', '--output=ALIGNMENT,DISC-ALN,DISC-GRAN,DISC-MAX,DISC-ZERO,FSTYPE,GROUP,KNAME,LABEL,LOG-SEC,MAJ:MIN,MIN-IO,MODE,MODEL,MOUNTPOINT,NAME,OPT-IO,OWNER,PHY-SEC,RM,RO,ROTA,RQ-SIZE,SIZE,STATE,TYPE,UUID', '/dev/sda4'] with allowed return codes [0] (capture=True)
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: volspec: path=/dev/sda4 type=part
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: info[DEVLINKS] = ['/dev/disk/by-partuuid/4de3228b-648c-4f16-af62-beed63e4a485', '/dev/disk/by-uuid/503e2669-ae08-4bb4-8635-644bacb208c5', '/dev/disk/by-diskseq/9-part4', '/dev/disk/by-id/wwn-0x5000c5008a2dce1b-part4', '/dev/disk/by-path/pci-0000:00:1f.2-ata-1-part4', '/dev/disk/by-id/ata-ST500LM021-1KJ152_W625E4GE-part4', '/dev/disk/by-path/pci-0000:00:1f.2-ata-1.0-part4']
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring mount: mount-3
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: TIMED BLOCK_META: 13.636
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: curtin command block-meta
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning/builtin: SUCCESS: running 'curtin block-meta simple'
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: builtin took 15.579 seconds
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: stage_partitioning took 15.579 seconds
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: finish: cmd-install/stage-partitioning: SUCCESS: configuring storage
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: curtin: Installation finished.
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: Skipping unmount: config disabled target unmounting
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: TIMED INSTALL_COMMAND: 15.583
Jun 16 13:59:37 ubuntu subiquity_log.5560[7575]: finish: cmd-install: SUCCESS: curtin command install
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:      configuring mount: mount-3
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:     running 'curtin block-meta simple'
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:    configuring storage
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:   curtin command install
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:  executing curtin install partitioning step
Jun 16 13:59:37 ubuntu subiquity_event.5560[5560]:  executing curtin install extract step
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: start: cmd-install: curtin command install
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: unknown type for url 'cp:///tmp/tmpp86t_4qv/mount', assuming type 'tgz'
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: LANG=en_US.UTF-8
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: 'reporter' not found in config file.
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: curtin: Installation started. (24.0.0-3-gc66faffee)
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: {'WORKING_DIR': '/tmp/tmp4e8cncy6/scratch', 'OUTPUT_FSTAB': '/tmp/tmp4e8cncy6/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmp4e8cncy6/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmp4e8cncy6/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmp4e8cncy6/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmp4e8cncy6/state/config'}
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: start: cmd-install/stage-extract: writing install sources to disk
Jun 16 13:59:39 ubuntu subiquity_log.5560[8462]: start: cmd-install/stage-extract/builtin: running 'curtin extract'
Jun 16 13:59:40 ubuntu subiquity_event.5560[5560]:   curtin command install
Jun 16 13:59:40 ubuntu subiquity_event.5560[5560]:    writing install sources to disk
Jun 16 13:59:40 ubuntu subiquity_event.5560[5560]:     running 'curtin extract'
Jun 16 13:59:41 ubuntu subiquity_log.5560[8462]: start: cmd-install/stage-extract/builtin/cmd-extract: curtin command extract
Jun 16 13:59:41 ubuntu subiquity_log.5560[8462]: Installing sources: [{'type': 'tgz', 'uri': 'cp:///tmp/tmpp86t_4qv/mount'}] to target at /target
Jun 16 13:59:41 ubuntu subiquity_log.5560[8462]: start: cmd-install/stage-extract/builtin/cmd-extract: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 13:59:41 ubuntu subiquity_log.5560[8462]: Setting up Trivial Source for stack /tmp/tmpp86t_4qv/mount
Jun 16 13:59:41 ubuntu subiquity_log.5560[8462]: Running command ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.'] with allowed return codes [0] (capture=False)
Jun 16 13:59:41 ubuntu subiquity_event.5560[5560]:      curtin command extract
Jun 16 13:59:41 ubuntu subiquity_event.5560[5560]:       acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 13:59:46 ubuntu subiquity_log.5560[8462]: rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 13:59:53 ubuntu subiquity_log.5560[8462]: rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 13:59:53 ubuntu subiquity_log.5560[8462]: ERROR: usr/bin/gtk4-encode-symbolic-svg failed verification -- update discarded.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1338) [sender=3.2.7]
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: curtin command extract
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Traceback (most recent call last):
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:     ret = args.func(args)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 267, in extract
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:     extract_source(source, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 209, in extract_source
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:     copy_to_target(root_dir, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 225, in copy_to_target
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:     util.subp(
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:     return _subp(*args, **kwargs)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:     raise ProcessExecutionError(stdout=out, stderr=err,
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Exit code: 23
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Reason: -
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Stdout: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Stderr: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Unexpected error while running command.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Exit code: 23
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Reason: -
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Stdout: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Stderr: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: builtin command failed
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: finish: cmd-install/stage-extract/builtin: FAIL: running 'curtin extract'
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: builtin took 245.293 seconds
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: stage_extract took 245.294 seconds
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: finish: cmd-install/stage-extract: FAIL: writing install sources to disk
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: curtin: Installation failed with exception: Unexpected error while running command.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Command: ['curtin', 'extract']
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Exit code: 3
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Reason: -
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Stdout: start: cmd-install/stage-extract/builtin/cmd-extract: curtin command extract
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Installing sources: [{'type': 'tgz', 'uri': 'cp:///tmp/tmpp86t_4qv/mount'}] to target at /target
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         start: cmd-install/stage-extract/builtin/cmd-extract: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Setting up Trivial Source for stack /tmp/tmpp86t_4qv/mount
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Running command ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.'] with allowed return codes [0] (capture=False)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         ERROR: usr/bin/gtk4-encode-symbolic-svg failed verification -- update discarded.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1338) [sender=3.2.7]
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: curtin command extract
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Traceback (most recent call last):
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:             ret = args.func(args)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 267, in extract
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:             extract_source(source, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 209, in extract_source
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:             copy_to_target(root_dir, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 225, in copy_to_target
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:             util.subp(
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:             return _subp(*args, **kwargs)
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:             raise ProcessExecutionError(stdout=out, stderr=err,
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Exit code: 23
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Reason: -
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Stdout: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Stderr: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Unexpected error while running command.
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Exit code: 23
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Reason: -
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Stdout: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         Stderr: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]:         
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Stderr: ''
Jun 16 14:03:44 ubuntu subiquity_log.5560[8462]: Running command ['uname', '-a'] with allowed return codes [0] (capture=True)
Jun 16 14:03:45 ubuntu subiquity_log.5560[8462]: Running command ['sudo', 'lshw'] with allowed return codes [0] (capture=True)
Jun 16 14:03:45 ubuntu subiquity_event.5560[5560]:       acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:45 ubuntu subiquity_event.5560[5560]:     running 'curtin extract'
Jun 16 14:03:45 ubuntu subiquity_event.5560[5560]:    writing install sources to disk
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Running command ['ip', '--oneline', 'address', 'list'] with allowed return codes [0] (capture=combine)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Running command ['ip', '--oneline', '-6', 'address', 'list'] with allowed return codes [0] (capture=combine)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Running command ['ip', '--oneline', 'route', 'list'] with allowed return codes [0] (capture=combine)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Running command ['ip', '--oneline', '-6', 'route', 'list'] with allowed return codes [0] (capture=combine)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Running command ['tar', '-cvf', '/var/log/installer/curtin-errors.tar', 'curtin-logs-2024-06-16-06-03'] with allowed return codes [0] (capture=True)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Wrote: /var/log/installer/curtin-errors.tar
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Skipping unmount: config disabled target unmounting
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: TIMED INSTALL_COMMAND: 247.696
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: finish: cmd-install: FAIL: curtin command install
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Traceback (most recent call last):
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:     ret = args.func(args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:     return log_time("TIMED %s: " % msg, func, *args, **kwargs)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:     return func(*args, **kwargs)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/install.py", line 538, in cmd_install
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:     raise e
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/install.py", line 523, in cmd_install
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:     stage.run()
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:   File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/install.py", line 295, in run
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:     raise util.ProcessExecutionError(
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Command: ['curtin', 'extract']
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Exit code: 3
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Reason: -
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Stdout: start: cmd-install/stage-extract/builtin/cmd-extract: curtin command extract
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Installing sources: [{'type': 'tgz', 'uri': 'cp:///tmp/tmpp86t_4qv/mount'}] to target at /target
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         start: cmd-install/stage-extract/builtin/cmd-extract: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Setting up Trivial Source for stack /tmp/tmpp86t_4qv/mount
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Running command ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.'] with allowed return codes [0] (capture=False)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         ERROR: usr/bin/gtk4-encode-symbolic-svg failed verification -- update discarded.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1338) [sender=3.2.7]
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: curtin command extract
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Traceback (most recent call last):
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             ret = args.func(args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 267, in extract
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             extract_source(source, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 209, in extract_source
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             copy_to_target(root_dir, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 225, in copy_to_target
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             util.subp(
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             return _subp(*args, **kwargs)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             raise ProcessExecutionError(stdout=out, stderr=err,
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Exit code: 23
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Reason: -
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stdout: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stderr: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Unexpected error while running command.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Exit code: 23
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Reason: -
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stdout: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stderr: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Stderr: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Unexpected error while running command.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Command: ['curtin', 'extract']
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Exit code: 3
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Reason: -
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Stdout: start: cmd-install/stage-extract/builtin/cmd-extract: curtin command extract
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Installing sources: [{'type': 'tgz', 'uri': 'cp:///tmp/tmpp86t_4qv/mount'}] to target at /target
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         start: cmd-install/stage-extract/builtin/cmd-extract: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Setting up Trivial Source for stack /tmp/tmpp86t_4qv/mount
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Running command ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.'] with allowed return codes [0] (capture=False)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         ERROR: usr/bin/gtk4-encode-symbolic-svg failed verification -- update discarded.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         rsync error: some files/attrs were not transferred (see previous errors) (code 23) at main.c(1338) [sender=3.2.7]
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: acquiring and extracting image from cp:///tmp/tmpp86t_4qv/mount
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         finish: cmd-install/stage-extract/builtin/cmd-extract: FAIL: curtin command extract
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Traceback (most recent call last):
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             ret = args.func(args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 267, in extract
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             extract_source(source, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 209, in extract_source
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             copy_to_target(root_dir, target, extra_rsync_args=extra_rsync_args)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/commands/extract.py", line 225, in copy_to_target
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             util.subp(
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 323, in subp
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             return _subp(*args, **kwargs)
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:           File "/snap/ubuntu-desktop-bootstrap/205/lib/python3.10/site-packages/curtin/util.py", line 172, in _subp
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:             raise ProcessExecutionError(stdout=out, stderr=err,
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         curtin.util.ProcessExecutionError: Unexpected error while running command.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Exit code: 23
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Reason: -
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stdout: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stderr: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Unexpected error while running command.
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Command: ['rsync', '-aXHAS', '--one-file-system', '/tmp/tmpp86t_4qv/mount/', '.']
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Exit code: 23
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Reason: -
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stdout: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         Stderr: ''
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]:         
Jun 16 14:03:47 ubuntu subiquity_log.5560[8462]: Stderr: ''
Jun 16 14:03:47 ubuntu subiquity_event.5560[5560]:  executing curtin install extract step
Jun 16 14:03:47 ubuntu subiquity_event.5560[5560]: installing system
Jun 16 14:03:47 ubuntu subiquity_event.5560[5560]: 
Jun 16 14:03:47 ubuntu subiquity_event.5560[5560]:   curtin command install

Revision history for this message

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

Thank you for your bug report, the error seems to be

rsync: [sender] read errors mapping "/tmp/tmpp86t_4qv/mount/usr/bin/gtk4-encode-symbolic-svg": Input/output error (5)

could you check your disks and installation media for errors?

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.