API tools faq
paste
Advertisement
SirFisho

Ubuntu installation error

SirFisho
May 2nd, 2025 (edited)
122
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
text 148.27 KB | None | 0 0
raw download clone embed print report
  1. May 02 16:22:46 ubuntu subiquity_event.4805[4805]: subiquity/load_cloud_config/extract_autoinstall:
  2. May 02 16:22:46 ubuntu subiquity_event.4805[4805]: subiquity/load_cloud_config/extract_autoinstall:
  3. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Early/apply_autoinstall_config:
  4. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Early/apply_autoinstall_config:
  5. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Reporting/apply_autoinstall_config:
  6. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Reporting/apply_autoinstall_config:
  7. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Error/apply_autoinstall_config:
  8. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Error/apply_autoinstall_config:
  9. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Userdata/apply_autoinstall_config:
  10. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Userdata/apply_autoinstall_config:
  11. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Package/apply_autoinstall_config:
  12. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Package/apply_autoinstall_config:
  13. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Debconf/apply_autoinstall_config:
  14. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Debconf/apply_autoinstall_config:
  15. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Kernel/apply_autoinstall_config:
  16. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Kernel/apply_autoinstall_config:
  17. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/KernelCrashDumps/apply_autoinstall_config:
  18. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/KernelCrashDumps/apply_autoinstall_config:
  19. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Zdev/apply_autoinstall_config:
  20. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Zdev/apply_autoinstall_config:
  21. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Ad/apply_autoinstall_config:
  22. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Ad/apply_autoinstall_config:
  23. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Late/apply_autoinstall_config:
  24. May 02 16:22:47 ubuntu subiquity_event.4805[4805]: subiquity/Late/apply_autoinstall_config:
  25. May 02 16:24:12 ubuntu subiquity_event.4805[4805]: subiquity/Ad/has_support_GET:
  26. May 02 16:24:56 ubuntu subiquity_event.4805[4805]: configuring apt
  27. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: start: cmd-apt-config: curtin command apt-config
  28. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Handling apt to target /tmp/tmp15beusc8/mount with config {'debconf_selections': {'subiquity': ''}, 'disable_components': [], 'disable_suites': ['security'], 'preserve_sources_list': False, 'primary': [{'arches': ['default'], 'uri': 'http://it.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'}]}
  29. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--bind', '/dev', '/tmp/tmp15beusc8/mount/dev'] with allowed return codes [0] (capture=False)
  30. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--bind', '/proc', '/tmp/tmp15beusc8/mount/proc'] with allowed return codes [0] (capture=False)
  31. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--bind', '/run', '/tmp/tmp15beusc8/mount/run'] with allowed return codes [0] (capture=False)
  32. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--bind', '/sys', '/tmp/tmp15beusc8/mount/sys'] with allowed return codes [0] (capture=False)
  33. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmp15beusc8/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  34. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--bind', '/tmp/tmp15beusc8/mount/usr/bin/true', '/tmp/tmp15beusc8/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  35. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
  36. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  37. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  38. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
  39. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  40. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  41. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  42. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: got primary mirror: http://it.archive.ubuntu.com/ubuntu/
  43. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: got security mirror: http://security.ubuntu.com/ubuntu/
  44. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Apt Mirror info: {'PRIMARY': 'http://it.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu/', 'MIRROR': 'http://it.archive.ubuntu.com/ubuntu/'}
  45. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Applying debconf selections
  46. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  47. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  48. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
  49. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  50. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  51. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
  52. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
  53. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  54. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  55. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  56. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  57. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  58. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
  59. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
  60. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Checking if target_proc (/tmp/tmp15beusc8/mount/proc) is a mount
  61. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: It is, so unshare will use --mount-proc=/tmp/tmp15beusc8/mount/proc
  62. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmp15beusc8/mount/proc', '--', 'chroot', '/tmp/tmp15beusc8/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  63. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_InRelease to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_InRelease
  64. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_cnf_Commands-amd64 to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_cnf_Commands-amd64
  65. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_Components-amd64.yml.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_Components-amd64.yml.gz
  66. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-48x48.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-48x48.tar.gz
  67. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64%402.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64%402.tar.gz
  68. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64.tar.gz
  69. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_cnf_Commands-amd64 to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_cnf_Commands-amd64
  70. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_Components-amd64.yml.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_Components-amd64.yml.gz
  71. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-48x48.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-48x48.tar.gz
  72. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64%402.tar.gz
  73. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64.tar.gz
  74. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_InRelease to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_InRelease
  75. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_binary-amd64_Packages to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_binary-amd64_Packages
  76. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_cnf_Commands-amd64 to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_cnf_Commands-amd64
  77. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_Components-amd64.yml.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_Components-amd64.yml.gz
  78. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-48x48.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-48x48.tar.gz
  79. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64%402.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64%402.tar.gz
  80. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64.tar.gz
  81. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_i18n_Translation-en to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_i18n_Translation-en
  82. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_binary-amd64_Packages to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_binary-amd64_Packages
  83. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_cnf_Commands-amd64 to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_cnf_Commands-amd64
  84. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_Components-amd64.yml.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_Components-amd64.yml.gz
  85. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-48x48.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-48x48.tar.gz
  86. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64%402.tar.gz
  87. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64.tar.gz to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64.tar.gz
  88. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Renaming apt list /tmp/tmp15beusc8/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_i18n_Translation-en to /tmp/tmp15beusc8/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_i18n_Translation-en
  89. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  90. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: TIMED subp(['udevadm', 'settle']): 0.001
  91. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--make-private', '/tmp/tmp15beusc8/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  92. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['umount', '/tmp/tmp15beusc8/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  93. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--make-private', '/tmp/tmp15beusc8/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  94. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['umount', '/tmp/tmp15beusc8/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  95. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--make-private', '/tmp/tmp15beusc8/mount/sys'] with allowed return codes [0] (capture=False)
  96. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['umount', '/tmp/tmp15beusc8/mount/sys'] with allowed return codes [0] (capture=False)
  97. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--make-private', '/tmp/tmp15beusc8/mount/run'] with allowed return codes [0] (capture=False)
  98. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['umount', '/tmp/tmp15beusc8/mount/run'] with allowed return codes [0] (capture=False)
  99. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--make-private', '/tmp/tmp15beusc8/mount/proc'] with allowed return codes [0] (capture=False)
  100. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['umount', '/tmp/tmp15beusc8/mount/proc'] with allowed return codes [0] (capture=False)
  101. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['mount', '--make-private', '/tmp/tmp15beusc8/mount/dev'] with allowed return codes [0] (capture=False)
  102. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: Running command ['umount', '/tmp/tmp15beusc8/mount/dev'] with allowed return codes [0] (capture=False)
  103. May 02 16:24:56 ubuntu subiquity_log.4805[6157]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
  104. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: start: cmd-apt-config: curtin command apt-config
  105. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Handling apt to target /tmp/tmpclewitfk/mount with config {'debconf_selections': {'subiquity': ''}, 'disable_components': [], 'preserve_sources_list': False, 'primary': [{'arches': ['default'], 'uri': 'http://it.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'}]}
  106. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--bind', '/dev', '/tmp/tmpclewitfk/mount/dev'] with allowed return codes [0] (capture=False)
  107. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--bind', '/proc', '/tmp/tmpclewitfk/mount/proc'] with allowed return codes [0] (capture=False)
  108. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--bind', '/run', '/tmp/tmpclewitfk/mount/run'] with allowed return codes [0] (capture=False)
  109. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--bind', '/sys', '/tmp/tmpclewitfk/mount/sys'] with allowed return codes [0] (capture=False)
  110. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpclewitfk/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  111. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--bind', '/tmp/tmpclewitfk/mount/usr/bin/true', '/tmp/tmpclewitfk/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  112. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
  113. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  114. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  115. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
  116. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  117. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  118. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  119. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: got primary mirror: http://it.archive.ubuntu.com/ubuntu/
  120. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: got security mirror: http://security.ubuntu.com/ubuntu/
  121. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Apt Mirror info: {'PRIMARY': 'http://it.archive.ubuntu.com/ubuntu/', 'SECURITY': 'http://security.ubuntu.com/ubuntu/', 'MIRROR': 'http://it.archive.ubuntu.com/ubuntu/'}
  122. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Applying debconf selections
  123. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  124. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  125. May 02 16:24:58 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
  126. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  127. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  128. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
  129. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
  130. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  131. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  132. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  133. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  134. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  135. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
  136. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
  137. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Checking if target_proc (/tmp/tmpclewitfk/mount/proc) is a mount
  138. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: It is, so unshare will use --mount-proc=/tmp/tmpclewitfk/mount/proc
  139. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpclewitfk/mount/proc', '--', 'chroot', '/tmp/tmpclewitfk/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  140. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_InRelease to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_InRelease
  141. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_cnf_Commands-amd64 to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_cnf_Commands-amd64
  142. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_Components-amd64.yml.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_Components-amd64.yml.gz
  143. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-48x48.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-48x48.tar.gz
  144. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64%402.tar.gz
  145. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_main_dep11_icons-64x64.tar.gz
  146. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_cnf_Commands-amd64 to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_cnf_Commands-amd64
  147. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_Components-amd64.yml.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_Components-amd64.yml.gz
  148. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-48x48.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-48x48.tar.gz
  149. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64%402.tar.gz
  150. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular-updates_restricted_dep11_icons-64x64.tar.gz
  151. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_InRelease to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_InRelease
  152. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_binary-amd64_Packages to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_binary-amd64_Packages
  153. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_cnf_Commands-amd64 to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_cnf_Commands-amd64
  154. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_Components-amd64.yml.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_Components-amd64.yml.gz
  155. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-48x48.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-48x48.tar.gz
  156. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64%402.tar.gz
  157. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_dep11_icons-64x64.tar.gz
  158. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_main_i18n_Translation-en to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_main_i18n_Translation-en
  159. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_binary-amd64_Packages to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_binary-amd64_Packages
  160. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_cnf_Commands-amd64 to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_cnf_Commands-amd64
  161. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_Components-amd64.yml.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_Components-amd64.yml.gz
  162. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-48x48.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-48x48.tar.gz
  163. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64%402.tar.gz
  164. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64.tar.gz to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_dep11_icons-64x64.tar.gz
  165. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Renaming apt list /tmp/tmpclewitfk/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_oracular_restricted_i18n_Translation-en to /tmp/tmpclewitfk/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_oracular_restricted_i18n_Translation-en
  166. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  167. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: TIMED subp(['udevadm', 'settle']): 0.001
  168. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--make-private', '/tmp/tmpclewitfk/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  169. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['umount', '/tmp/tmpclewitfk/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  170. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--make-private', '/tmp/tmpclewitfk/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  171. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['umount', '/tmp/tmpclewitfk/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  172. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--make-private', '/tmp/tmpclewitfk/mount/sys'] with allowed return codes [0] (capture=False)
  173. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['umount', '/tmp/tmpclewitfk/mount/sys'] with allowed return codes [0] (capture=False)
  174. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--make-private', '/tmp/tmpclewitfk/mount/run'] with allowed return codes [0] (capture=False)
  175. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['umount', '/tmp/tmpclewitfk/mount/run'] with allowed return codes [0] (capture=False)
  176. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--make-private', '/tmp/tmpclewitfk/mount/proc'] with allowed return codes [0] (capture=False)
  177. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['umount', '/tmp/tmpclewitfk/mount/proc'] with allowed return codes [0] (capture=False)
  178. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['mount', '--make-private', '/tmp/tmpclewitfk/mount/dev'] with allowed return codes [0] (capture=False)
  179. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: Running command ['umount', '/tmp/tmpclewitfk/mount/dev'] with allowed return codes [0] (capture=False)
  180. May 02 16:24:59 ubuntu subiquity_log.4805[6457]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
  181. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: start: cmd-in-target: curtin command in-target
  182. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--bind', '/dev', '/tmp/tmpo2w5mmkm/mount/dev'] with allowed return codes [0] (capture=False)
  183. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--bind', '/proc', '/tmp/tmpo2w5mmkm/mount/proc'] with allowed return codes [0] (capture=False)
  184. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--bind', '/run', '/tmp/tmpo2w5mmkm/mount/run'] with allowed return codes [0] (capture=False)
  185. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--bind', '/sys', '/tmp/tmpo2w5mmkm/mount/sys'] with allowed return codes [0] (capture=False)
  186. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpo2w5mmkm/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  187. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--bind', '/tmp/tmpo2w5mmkm/mount/usr/bin/true', '/tmp/tmpo2w5mmkm/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  188. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
  189. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Checking if target_proc (/tmp/tmpo2w5mmkm/mount/proc) is a mount
  190. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: It is, so unshare will use --mount-proc=/tmp/tmpo2w5mmkm/mount/proc
  191. May 02 16:24:59 ubuntu subiquity_log.4805[6533]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpo2w5mmkm/mount/proc', '--', 'chroot', '/tmp/tmpo2w5mmkm/mount', 'apt-get', 'update'] with allowed return codes [0] (capture=False)
  192. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:1 file:/cdrom oracular InRelease
  193. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Ign:1 file:/cdrom oracular InRelease
  194. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:2 file:/cdrom oracular Release [1081 B]
  195. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:2 file:/cdrom oracular Release [1081 B]
  196. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:3 file:/cdrom oracular Release.gpg [833 B]
  197. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:3 file:/cdrom oracular Release.gpg [833 B]
  198. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:4 http://it.archive.ubuntu.com/ubuntu oracular InRelease [265 kB]
  199. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:5 file:/cdrom oracular/main amd64 Packages [48.0 kB]
  200. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Ign:5 file:/cdrom oracular/main amd64 Packages
  201. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:6 file:/cdrom oracular/restricted amd64 Packages [9497 B]
  202. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Ign:6 file:/cdrom oracular/restricted amd64 Packages
  203. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:5 file:/cdrom oracular/main amd64 Packages [48.0 kB]
  204. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:6 file:/cdrom oracular/restricted amd64 Packages [9497 B]
  205. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:7 http://security.ubuntu.com/ubuntu oracular-security InRelease [126 kB]
  206. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:8 http://it.archive.ubuntu.com/ubuntu oracular-updates InRelease [126 kB]
  207. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:9 http://it.archive.ubuntu.com/ubuntu oracular-backports InRelease [126 kB]
  208. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:10 http://it.archive.ubuntu.com/ubuntu oracular/main amd64 Packages [1425 kB]
  209. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:11 http://it.archive.ubuntu.com/ubuntu oracular/main amd64 c-n-f Metadata [31.2 kB]
  210. May 02 16:24:59 ubuntu subiquity_event.4805[4805]: curtin command in-target
  211. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:12 http://it.archive.ubuntu.com/ubuntu oracular/universe amd64 Packages [15.7 MB]
  212. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:13 http://security.ubuntu.com/ubuntu oracular-security/main amd64 Packages [287 kB]
  213. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:14 http://security.ubuntu.com/ubuntu oracular-security/main Translation-en [74.3 kB]
  214. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:15 http://security.ubuntu.com/ubuntu oracular-security/main amd64 Components [21.6 kB]
  215. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:16 http://security.ubuntu.com/ubuntu oracular-security/main Icons (48x48) [13.4 kB]
  216. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:17 http://security.ubuntu.com/ubuntu oracular-security/main Icons (64x64) [20.0 kB]
  217. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:18 http://security.ubuntu.com/ubuntu oracular-security/main amd64 c-n-f Metadata [4424 B]
  218. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:19 http://security.ubuntu.com/ubuntu oracular-security/restricted amd64 Packages [188 kB]
  219. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:20 http://security.ubuntu.com/ubuntu oracular-security/restricted Translation-en [42.8 kB]
  220. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:21 http://security.ubuntu.com/ubuntu oracular-security/restricted amd64 Components [212 B]
  221. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:22 http://security.ubuntu.com/ubuntu oracular-security/restricted amd64 c-n-f Metadata [380 B]
  222. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:23 http://security.ubuntu.com/ubuntu oracular-security/universe amd64 Packages [183 kB]
  223. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:24 http://security.ubuntu.com/ubuntu oracular-security/universe Translation-en [59.6 kB]
  224. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:25 http://security.ubuntu.com/ubuntu oracular-security/universe amd64 Components [7176 B]
  225. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:26 http://security.ubuntu.com/ubuntu oracular-security/universe Icons (48x48) [8114 B]
  226. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:27 http://security.ubuntu.com/ubuntu oracular-security/universe Icons (64x64) [13.3 kB]
  227. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:28 http://security.ubuntu.com/ubuntu oracular-security/universe Icons (64x64@2) [29 B]
  228. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:29 http://security.ubuntu.com/ubuntu oracular-security/universe amd64 c-n-f Metadata [5616 B]
  229. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:30 http://security.ubuntu.com/ubuntu oracular-security/multiverse amd64 Packages [9704 B]
  230. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:31 http://security.ubuntu.com/ubuntu oracular-security/multiverse Translation-en [2572 B]
  231. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:32 http://security.ubuntu.com/ubuntu oracular-security/multiverse amd64 Components [212 B]
  232. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:33 http://security.ubuntu.com/ubuntu oracular-security/multiverse Icons (48x48) [29 B]
  233. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:34 http://security.ubuntu.com/ubuntu oracular-security/multiverse Icons (64x64) [29 B]
  234. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:35 http://security.ubuntu.com/ubuntu oracular-security/multiverse Icons (64x64@2) [29 B]
  235. May 02 16:24:59 ubuntu subiquity_log.4805[6557]: Get:36 http://security.ubuntu.com/ubuntu oracular-security/multiverse amd64 c-n-f Metadata [372 B]
  236. May 02 16:25:00 ubuntu subiquity_log.4805[6557]: Get:37 http://it.archive.ubuntu.com/ubuntu oracular/universe Translation-en [6132 kB]
  237. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:38 http://it.archive.ubuntu.com/ubuntu oracular/universe amd64 Components [4130 kB]
  238. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:39 http://it.archive.ubuntu.com/ubuntu oracular/universe Icons (48x48) [3757 kB]
  239. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:40 http://it.archive.ubuntu.com/ubuntu oracular/universe Icons (64x64) [7582 kB]
  240. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:41 http://it.archive.ubuntu.com/ubuntu oracular/universe Icons (64x64@2) [69.5 kB]
  241. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:42 http://it.archive.ubuntu.com/ubuntu oracular/universe amd64 c-n-f Metadata [307 kB]
  242. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:43 http://it.archive.ubuntu.com/ubuntu oracular/multiverse amd64 Packages [251 kB]
  243. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:44 http://it.archive.ubuntu.com/ubuntu oracular/multiverse Translation-en [117 kB]
  244. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:45 http://it.archive.ubuntu.com/ubuntu oracular/multiverse amd64 Components [41.3 kB]
  245. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:46 http://it.archive.ubuntu.com/ubuntu oracular/multiverse Icons (48x48) [57.4 kB]
  246. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:47 http://it.archive.ubuntu.com/ubuntu oracular/multiverse Icons (64x64) [201 kB]
  247. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:48 http://it.archive.ubuntu.com/ubuntu oracular/multiverse Icons (64x64@2) [904 B]
  248. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:49 http://it.archive.ubuntu.com/ubuntu oracular/multiverse amd64 c-n-f Metadata [7276 B]
  249. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:50 http://it.archive.ubuntu.com/ubuntu oracular-updates/main amd64 Packages [404 kB]
  250. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:51 http://it.archive.ubuntu.com/ubuntu oracular-updates/main Translation-en [109 kB]
  251. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:52 http://it.archive.ubuntu.com/ubuntu oracular-updates/main amd64 Components [59.0 kB]
  252. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:53 http://it.archive.ubuntu.com/ubuntu oracular-updates/main Icons (48x48) [25.8 kB]
  253. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:54 http://it.archive.ubuntu.com/ubuntu oracular-updates/main Icons (64x64) [39.7 kB]
  254. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:55 http://it.archive.ubuntu.com/ubuntu oracular-updates/main amd64 c-n-f Metadata [7908 B]
  255. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:56 http://it.archive.ubuntu.com/ubuntu oracular-updates/restricted amd64 Packages [228 kB]
  256. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:57 http://it.archive.ubuntu.com/ubuntu oracular-updates/restricted Translation-en [50.6 kB]
  257. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:58 http://it.archive.ubuntu.com/ubuntu oracular-updates/restricted amd64 Components [216 B]
  258. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:59 http://it.archive.ubuntu.com/ubuntu oracular-updates/restricted amd64 c-n-f Metadata [400 B]
  259. May 02 16:25:01 ubuntu subiquity_log.4805[6557]: Get:60 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe amd64 Packages [247 kB]
  260. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:61 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe Translation-en [82.2 kB]
  261. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:62 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe amd64 Components [60.9 kB]
  262. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:63 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe Icons (48x48) [52.9 kB]
  263. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:64 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe Icons (64x64) [74.2 kB]
  264. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:65 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe Icons (64x64@2) [29 B]
  265. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:66 http://it.archive.ubuntu.com/ubuntu oracular-updates/universe amd64 c-n-f Metadata [7460 B]
  266. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:67 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse amd64 Packages [10.7 kB]
  267. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:68 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse Translation-en [2596 B]
  268. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:69 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse amd64 Components [212 B]
  269. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:70 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse Icons (48x48) [29 B]
  270. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:71 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse Icons (64x64) [29 B]
  271. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:72 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse Icons (64x64@2) [29 B]
  272. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:73 http://it.archive.ubuntu.com/ubuntu oracular-updates/multiverse amd64 c-n-f Metadata [384 B]
  273. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:74 http://it.archive.ubuntu.com/ubuntu oracular-backports/main amd64 Components [212 B]
  274. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:75 http://it.archive.ubuntu.com/ubuntu oracular-backports/main Icons (48x48) [29 B]
  275. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:76 http://it.archive.ubuntu.com/ubuntu oracular-backports/main Icons (64x64) [29 B]
  276. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:77 http://it.archive.ubuntu.com/ubuntu oracular-backports/main Icons (64x64@2) [29 B]
  277. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:78 http://it.archive.ubuntu.com/ubuntu oracular-backports/main amd64 c-n-f Metadata [112 B]
  278. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:79 http://it.archive.ubuntu.com/ubuntu oracular-backports/restricted amd64 Components [216 B]
  279. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:80 http://it.archive.ubuntu.com/ubuntu oracular-backports/restricted Icons (48x48) [29 B]
  280. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:81 http://it.archive.ubuntu.com/ubuntu oracular-backports/restricted Icons (64x64) [29 B]
  281. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:82 http://it.archive.ubuntu.com/ubuntu oracular-backports/restricted Icons (64x64@2) [29 B]
  282. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:83 http://it.archive.ubuntu.com/ubuntu oracular-backports/restricted amd64 c-n-f Metadata [120 B]
  283. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:84 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe amd64 Packages [4912 B]
  284. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:85 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe Translation-en [1296 B]
  285. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:86 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe amd64 Components [9700 B]
  286. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:87 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe Icons (48x48) [1865 B]
  287. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:88 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe Icons (64x64) [1829 B]
  288. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:89 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe Icons (64x64@2) [29 B]
  289. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:90 http://it.archive.ubuntu.com/ubuntu oracular-backports/universe amd64 c-n-f Metadata [176 B]
  290. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:91 http://it.archive.ubuntu.com/ubuntu oracular-backports/multiverse amd64 Components [216 B]
  291. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:92 http://it.archive.ubuntu.com/ubuntu oracular-backports/multiverse Icons (48x48) [29 B]
  292. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:93 http://it.archive.ubuntu.com/ubuntu oracular-backports/multiverse Icons (64x64) [29 B]
  293. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:94 http://it.archive.ubuntu.com/ubuntu oracular-backports/multiverse Icons (64x64@2) [29 B]
  294. May 02 16:25:02 ubuntu subiquity_log.4805[6557]: Get:95 http://it.archive.ubuntu.com/ubuntu oracular-backports/multiverse amd64 c-n-f Metadata [120 B]
  295. May 02 16:25:04 ubuntu subiquity_log.4805[6557]: Fetched 42.8 MB in 3s (16.1 MB/s)
  296. May 02 16:25:05 ubuntu subiquity_log.4805[6557]: Reading package lists...
  297. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  298. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: TIMED subp(['udevadm', 'settle']): 0.005
  299. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--make-private', '/tmp/tmpo2w5mmkm/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  300. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['umount', '/tmp/tmpo2w5mmkm/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  301. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--make-private', '/tmp/tmpo2w5mmkm/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  302. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['umount', '/tmp/tmpo2w5mmkm/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  303. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--make-private', '/tmp/tmpo2w5mmkm/mount/sys'] with allowed return codes [0] (capture=False)
  304. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['umount', '/tmp/tmpo2w5mmkm/mount/sys'] with allowed return codes [0] (capture=False)
  305. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--make-private', '/tmp/tmpo2w5mmkm/mount/run'] with allowed return codes [0] (capture=False)
  306. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['umount', '/tmp/tmpo2w5mmkm/mount/run'] with allowed return codes [0] (capture=False)
  307. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--make-private', '/tmp/tmpo2w5mmkm/mount/proc'] with allowed return codes [0] (capture=False)
  308. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['umount', '/tmp/tmpo2w5mmkm/mount/proc'] with allowed return codes [0] (capture=False)
  309. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['mount', '--make-private', '/tmp/tmpo2w5mmkm/mount/dev'] with allowed return codes [0] (capture=False)
  310. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: Running command ['umount', '/tmp/tmpo2w5mmkm/mount/dev'] with allowed return codes [0] (capture=False)
  311. May 02 16:25:05 ubuntu subiquity_log.4805[6533]: finish: cmd-in-target: SUCCESS: curtin command in-target
  312. May 02 16:25:05 ubuntu subiquity_event.4805[4805]: curtin command in-target
  313. May 02 16:25:05 ubuntu subiquity_event.4805[4805]: configuring apt
  314. May 02 16:25:05 ubuntu subiquity_event.4805[4805]: installing system
  315. May 02 16:25:05 ubuntu subiquity_event.4805[4805]: executing curtin install initial step
  316. May 02 16:25:05 ubuntu subiquity_log.4805[6904]: /usr/bin/ubuntu-drivers
  317. May 02 16:25:05 ubuntu subiquity_log.4805[6905]: /usr/bin/ubuntu-drivers
  318. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: start: cmd-install: curtin command install
  319. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: curtin: Installation started. (24.0.0-53-g0ded564bd)
  320. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: LANG=C.UTF-8
  321. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: 'reporter' not found in config file.
  322. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: curtin: Installation started. (24.0.0-53-g0ded564bd)
  323. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: Exporting resume data to /tmp/tmpmnmgu5c6/resume-data.json so that further stages can be executed in a later invocation.
  324. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: {'WORKING_DIR': '/tmp/tmpcj_7zoym/scratch', 'OUTPUT_FSTAB': '/tmp/tmpcj_7zoym/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmpcj_7zoym/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmpcj_7zoym/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmpcj_7zoym/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmpcj_7zoym/state/config'}
  325. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: curtin: Installation finished.
  326. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: Skipping unmount: config disabled target unmounting
  327. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: TIMED INSTALL_COMMAND: 0.000
  328. May 02 16:25:05 ubuntu subiquity_log.4805[6897]: finish: cmd-install: SUCCESS: curtin command install
  329. May 02 16:25:05 ubuntu subiquity_event.4805[4805]: executing curtin install initial step
  330. May 02 16:25:05 ubuntu subiquity_event.4805[4805]: executing curtin install partitioning step
  331. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: start: cmd-install: curtin command install
  332. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: unknown type for url 'cp:///tmp/tmpo2w5mmkm/mount', assuming type 'tgz'
  333. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: curtin: Installation started. (24.0.0-53-g0ded564bd)
  334. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: LANG=C.UTF-8
  335. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: 'reporter' not found in config file.
  336. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: curtin: Installation started. (24.0.0-53-g0ded564bd)
  337. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: {'WORKING_DIR': '/tmp/tmpcj_7zoym/scratch', 'OUTPUT_FSTAB': '/tmp/tmpcj_7zoym/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmpcj_7zoym/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmpcj_7zoym/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmpcj_7zoym/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmpcj_7zoym/state/config'}
  338. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning: configuring storage
  339. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin: running 'curtin block-meta simple'
  340. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  341. May 02 16:25:06 ubuntu subiquity_event.4805[4805]: curtin command install
  342. May 02 16:25:06 ubuntu subiquity_event.4805[4805]: configuring storage
  343. May 02 16:25:06 ubuntu subiquity_event.4805[4805]: running 'curtin block-meta simple'
  344. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  345. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  346. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  347. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  348. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  349. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  350. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  351. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  352. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  353. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  354. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.032
  355. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  356. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  357. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
  358. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  359. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  360. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  361. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  362. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  363. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  364. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  365. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  366. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  367. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  368. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  369. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  370. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  371. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme2n1', 'size': 498978521088, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
  372. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  373. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  374. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  375. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  376. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  377. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  378. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  379. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  380. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  381. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  382. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  383. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  384. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  385. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: block-meta: extracted devices to clear: ['/dev/nvme2n1']
  386. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Declared block devices: ['/dev/nvme2n1']
  387. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: clearing devices=['/dev/nvme2n1']
  388. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  389. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  390. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm assemble scan results:
  391. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: looking for devices for further assembly
  392. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop16
  393. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop15
  394. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop14
  395. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop13
  396. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop12
  397. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop11
  398. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop10
  399. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop9
  400. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop8
  401. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  402. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda
  403. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme2n1
  404. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  405. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  406. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  407. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  408. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  409. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  410. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  411. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  412. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop7
  413. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop6
  414. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop5
  415. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop4
  416. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop3
  417. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop2
  418. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop1
  419. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop0
  420. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm: No arrays found in config file or automatically
  421. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  422. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: mdadm detail scan after assemble:
  423. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  424. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.002
  425. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  426. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  427. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  428. May 02 16:25:06 ubuntu subiquity_event.4805[4805]: curtin command block-meta
  429. May 02 16:25:06 ubuntu subiquity_event.4805[4805]: removing previous storage devices
  430. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  431. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.006
  432. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Loading kernel module bcache via modprobe
  433. May 02 16:25:06 ubuntu subiquity_log.4805[6962]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  434. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Generating device storage trees for path(s): ['/dev/nvme2n1']
  435. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  436. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  437. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  438. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  439. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Current device storage tree:
  440. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: nvme2n1
  441. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Shutdown Plan:
  442. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {'level': 0, 'device': '/sys/class/block/nvme2n1', 'dev_type': 'disk'}
  443. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: shutdown running on holder type: 'disk' syspath: '/sys/class/block/nvme2n1'
  444. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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/nvme2n1'] with allowed return codes [0] (capture=True)
  445. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: info:
  446. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {
  447. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "nvme2n1": {
  448. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ALIGNMENT": "0",
  449. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ALN": "0",
  450. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-GRAN": "512",
  451. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-MAX": "2199023255040",
  452. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ZERO": "0",
  453. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "FSTYPE": "",
  454. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "GROUP": "disk",
  455. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "KNAME": "nvme2n1",
  456. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LABEL": "",
  457. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LOG-SEC": "512",
  458. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MAJ:MIN": "259:9",
  459. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MIN-IO": "4096",
  460. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODE": "brw-rw----",
  461. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODEL": "CT500P310SSD8",
  462. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MOUNTPOINT": "",
  463. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "NAME": "nvme2n1",
  464. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OPT-IO": "4096",
  465. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OWNER": "root",
  466. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "PHY-SEC": "512",
  467. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RM": "0",
  468. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RO": "0",
  469. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ROTA": "0",
  470. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RQ-SIZE": "1023",
  471. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "SIZE": "500107862016",
  472. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "STATE": "live",
  473. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "TYPE": "disk",
  474. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "UUID": "",
  475. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "device_path": "/dev/nvme2n1"
  476. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  477. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  478. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: (log=512, phys=512)
  479. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['fdasd', '--table', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  480. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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)
  481. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Checking if /dev/nvme2n1 is a swap device
  482. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  483. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping superblock on /dev/nvme2n1
  484. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping /dev/nvme2n1 attempt 1/4
  485. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  486. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping 1M on /dev/nvme2n1 at offsets [0, -1048576]
  487. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: successfully wiped device /dev/nvme2n1 on attempt 1/4
  488. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  489. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  490. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  491. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  492. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  493. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: blockmeta: detected storage config, using mode=custom
  494. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  495. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  496. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  497. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  498. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  499. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  500. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED BLOCK_META: 0.389
  501. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  502. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Traceback (most recent call last):
  503. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  504. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: ret = args.func(args)
  505. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  506. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  507. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  508. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return func(*args, **kwargs)
  509. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  510. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return meta_custom(args)
  511. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  512. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: handler(command, storage_config_dict, context)
  513. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  514. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk_handler_v1(info, storage_config, context)
  515. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  516. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  517. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  518. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: volume_path = v2_get_path_to_disk(vol)
  519. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  520. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: link2dev[dev['DEVNAME']] = dev
  521. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: KeyError: 'DEVNAME'
  522. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 'DEVNAME'
  523. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: builtin command failed
  524. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin: FAIL: running 'curtin block-meta simple'
  525. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: builtin took 0.731 seconds
  526. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: stage_partitioning took 0.731 seconds
  527. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning: FAIL: configuring storage
  528. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: curtin: Installation failed with exception: Unexpected error while running command.
  529. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Command: ['curtin', 'block-meta', 'simple']
  530. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Exit code: 3
  531. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Reason: -
  532. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  533. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  534. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  535. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  536. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  537. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  538. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  539. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  540. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  541. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  542. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  543. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.032
  544. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  545. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  546. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
  547. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  548. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  549. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  550. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  551. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  552. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  553. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  554. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  555. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  556. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  557. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  558. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  559. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  560. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme2n1', 'size': 498978521088, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
  561. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  562. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  563. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  564. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  565. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  566. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  567. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  568. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  569. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  570. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  571. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  572. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  573. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  574. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block-meta: extracted devices to clear: ['/dev/nvme2n1']
  575. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Declared block devices: ['/dev/nvme2n1']
  576. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: clearing devices=['/dev/nvme2n1']
  577. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  578. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  579. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm assemble scan results:
  580. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  581. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: looking for devices for further assembly
  582. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop16
  583. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop15
  584. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop14
  585. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop13
  586. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop12
  587. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop11
  588. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop10
  589. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop9
  590. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop8
  591. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  592. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda
  593. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme2n1
  594. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  595. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  596. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  597. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  598. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  599. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  600. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  601. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  602. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop7
  603. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop6
  604. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop5
  605. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop4
  606. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop3
  607. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop2
  608. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop1
  609. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop0
  610. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: No arrays found in config file or automatically
  611. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  612. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  613. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm detail scan after assemble:
  614. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  615. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  616. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  617. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.002
  618. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  619. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  620. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  621. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  622. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.006
  623. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Loading kernel module bcache via modprobe
  624. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  625. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Generating device storage trees for path(s): ['/dev/nvme2n1']
  626. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  627. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  628. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  629. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  630. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Current device storage tree:
  631. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: nvme2n1
  632. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Shutdown Plan:
  633. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {'level': 0, 'device': '/sys/class/block/nvme2n1', 'dev_type': 'disk'}
  634. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: shutdown running on holder type: 'disk' syspath: '/sys/class/block/nvme2n1'
  635. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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/nvme2n1'] with allowed return codes [0] (capture=True)
  636. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: info:
  637. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {
  638. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "nvme2n1": {
  639. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ALIGNMENT": "0",
  640. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ALN": "0",
  641. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-GRAN": "512",
  642. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-MAX": "2199023255040",
  643. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ZERO": "0",
  644. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "FSTYPE": "",
  645. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "GROUP": "disk",
  646. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "KNAME": "nvme2n1",
  647. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LABEL": "",
  648. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LOG-SEC": "512",
  649. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MAJ:MIN": "259:9",
  650. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MIN-IO": "4096",
  651. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODE": "brw-rw----",
  652. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODEL": "CT500P310SSD8",
  653. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MOUNTPOINT": "",
  654. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "NAME": "nvme2n1",
  655. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OPT-IO": "4096",
  656. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OWNER": "root",
  657. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "PHY-SEC": "512",
  658. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RM": "0",
  659. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RO": "0",
  660. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ROTA": "0",
  661. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RQ-SIZE": "1023",
  662. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "SIZE": "500107862016",
  663. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "STATE": "live",
  664. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "TYPE": "disk",
  665. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "UUID": "",
  666. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "device_path": "/dev/nvme2n1"
  667. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  668. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  669. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: (log=512, phys=512)
  670. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['fdasd', '--table', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  671. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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)
  672. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Checking if /dev/nvme2n1 is a swap device
  673. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  674. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping superblock on /dev/nvme2n1
  675. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping /dev/nvme2n1 attempt 1/4
  676. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  677. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping 1M on /dev/nvme2n1 at offsets [0, -1048576]
  678. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: successfully wiped device /dev/nvme2n1 on attempt 1/4
  679. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  680. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  681. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  682. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  683. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  684. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: blockmeta: detected storage config, using mode=custom
  685. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  686. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  687. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  688. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  689. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  690. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  691. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED BLOCK_META: 0.389
  692. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  693. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Traceback (most recent call last):
  694. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  695. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: ret = args.func(args)
  696. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  697. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  698. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  699. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return func(*args, **kwargs)
  700. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  701. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return meta_custom(args)
  702. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  703. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: handler(command, storage_config_dict, context)
  704. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  705. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk_handler_v1(info, storage_config, context)
  706. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  707. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  708. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  709. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: volume_path = v2_get_path_to_disk(vol)
  710. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  711. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: link2dev[dev['DEVNAME']] = dev
  712. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: KeyError: 'DEVNAME'
  713. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 'DEVNAME'
  714. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  715. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Stderr: ''
  716. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['uname', '-a'] with allowed return codes [0] (capture=True)
  717. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['sudo', 'lshw'] with allowed return codes [0] (capture=True)
  718. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: removing previous storage devices
  719. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: configuring nvme_controller: nvme-controller-nvme2
  720. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: configuring nvme_controller: nvme-controller-nvme2
  721. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: configuring disk: disk-nvme2n1
  722. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: configuring disk: disk-nvme2n1
  723. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: running 'curtin block-meta simple'
  724. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: configuring storage
  725. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['ip', '--oneline', 'address', 'list'] with allowed return codes [0] (capture=combine)
  726. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['ip', '--oneline', '-6', 'address', 'list'] with allowed return codes [0] (capture=combine)
  727. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['ip', '--oneline', 'route', 'list'] with allowed return codes [0] (capture=combine)
  728. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['ip', '--oneline', '-6', 'route', 'list'] with allowed return codes [0] (capture=combine)
  729. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['tar', '-cvf', '/var/log/installer/curtin-errors.tar', 'curtin-logs-2025-05-02-14-25'] with allowed return codes [0] (capture=True)
  730. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Wrote: /var/log/installer/curtin-errors.tar
  731. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Skipping unmount: config disabled target unmounting
  732. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED INSTALL_COMMAND: 1.506
  733. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install: FAIL: curtin command install
  734. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Traceback (most recent call last):
  735. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  736. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: ret = args.func(args)
  737. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  738. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  739. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  740. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return func(*args, **kwargs)
  741. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/install.py", line 538, in cmd_install
  742. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: raise e
  743. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/install.py", line 523, in cmd_install
  744. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: stage.run()
  745. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/install.py", line 295, in run
  746. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: raise util.ProcessExecutionError(
  747. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: curtin.util.ProcessExecutionError: Unexpected error while running command.
  748. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Command: ['curtin', 'block-meta', 'simple']
  749. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Exit code: 3
  750. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Reason: -
  751. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  752. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  753. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  754. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  755. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  756. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  757. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  758. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  759. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  760. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  761. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  762. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.032
  763. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  764. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  765. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
  766. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  767. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  768. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  769. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  770. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  771. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  772. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  773. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  774. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  775. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  776. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  777. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  778. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  779. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme2n1', 'size': 498978521088, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
  780. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  781. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  782. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  783. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  784. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  785. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  786. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  787. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  788. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  789. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  790. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  791. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  792. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  793. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block-meta: extracted devices to clear: ['/dev/nvme2n1']
  794. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Declared block devices: ['/dev/nvme2n1']
  795. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: clearing devices=['/dev/nvme2n1']
  796. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  797. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  798. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm assemble scan results:
  799. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  800. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: looking for devices for further assembly
  801. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop16
  802. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop15
  803. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop14
  804. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop13
  805. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop12
  806. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop11
  807. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop10
  808. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop9
  809. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop8
  810. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  811. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda
  812. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme2n1
  813. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  814. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  815. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  816. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  817. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  818. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  819. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  820. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  821. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop7
  822. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop6
  823. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop5
  824. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop4
  825. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop3
  826. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop2
  827. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop1
  828. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop0
  829. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: No arrays found in config file or automatically
  830. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  831. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  832. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm detail scan after assemble:
  833. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  834. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  835. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  836. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.002
  837. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  838. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  839. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  840. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  841. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.006
  842. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Loading kernel module bcache via modprobe
  843. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  844. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Generating device storage trees for path(s): ['/dev/nvme2n1']
  845. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  846. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  847. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  848. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  849. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Current device storage tree:
  850. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: nvme2n1
  851. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Shutdown Plan:
  852. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {'level': 0, 'device': '/sys/class/block/nvme2n1', 'dev_type': 'disk'}
  853. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: shutdown running on holder type: 'disk' syspath: '/sys/class/block/nvme2n1'
  854. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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/nvme2n1'] with allowed return codes [0] (capture=True)
  855. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: info:
  856. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {
  857. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "nvme2n1": {
  858. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ALIGNMENT": "0",
  859. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ALN": "0",
  860. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-GRAN": "512",
  861. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-MAX": "2199023255040",
  862. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ZERO": "0",
  863. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "FSTYPE": "",
  864. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "GROUP": "disk",
  865. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "KNAME": "nvme2n1",
  866. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LABEL": "",
  867. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LOG-SEC": "512",
  868. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MAJ:MIN": "259:9",
  869. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MIN-IO": "4096",
  870. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODE": "brw-rw----",
  871. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODEL": "CT500P310SSD8",
  872. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MOUNTPOINT": "",
  873. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "NAME": "nvme2n1",
  874. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OPT-IO": "4096",
  875. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OWNER": "root",
  876. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "PHY-SEC": "512",
  877. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RM": "0",
  878. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RO": "0",
  879. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ROTA": "0",
  880. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RQ-SIZE": "1023",
  881. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "SIZE": "500107862016",
  882. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "STATE": "live",
  883. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "TYPE": "disk",
  884. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "UUID": "",
  885. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "device_path": "/dev/nvme2n1"
  886. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  887. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  888. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: (log=512, phys=512)
  889. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['fdasd', '--table', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  890. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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)
  891. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Checking if /dev/nvme2n1 is a swap device
  892. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  893. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping superblock on /dev/nvme2n1
  894. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping /dev/nvme2n1 attempt 1/4
  895. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  896. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping 1M on /dev/nvme2n1 at offsets [0, -1048576]
  897. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: successfully wiped device /dev/nvme2n1 on attempt 1/4
  898. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  899. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  900. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  901. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  902. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  903. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: blockmeta: detected storage config, using mode=custom
  904. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  905. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  906. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  907. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  908. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  909. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  910. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED BLOCK_META: 0.389
  911. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  912. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Traceback (most recent call last):
  913. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  914. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: ret = args.func(args)
  915. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  916. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  917. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  918. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return func(*args, **kwargs)
  919. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  920. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return meta_custom(args)
  921. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  922. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: handler(command, storage_config_dict, context)
  923. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  924. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk_handler_v1(info, storage_config, context)
  925. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  926. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  927. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  928. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: volume_path = v2_get_path_to_disk(vol)
  929. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  930. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: link2dev[dev['DEVNAME']] = dev
  931. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: KeyError: 'DEVNAME'
  932. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 'DEVNAME'
  933. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  934. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Stderr: ''
  935. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Unexpected error while running command.
  936. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Command: ['curtin', 'block-meta', 'simple']
  937. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Exit code: 3
  938. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Reason: -
  939. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  940. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  941. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  942. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  943. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  944. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  945. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  946. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  947. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  948. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  949. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  950. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.032
  951. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  952. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  953. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 1127219200, 'wipe': 'superblock', 'flag': 'boot', 'number': 1, 'preserve': False, 'grub_device': True, 'offset': 1048576, 'id': 'partition-0', 'type': 'partition'})
  954. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  955. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  956. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  957. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  958. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  959. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  960. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  961. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  962. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  963. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  964. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  965. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  966. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  967. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume partition-1({'device': 'disk-nvme2n1', 'size': 498978521088, 'wipe': 'superblock', 'number': 2, 'preserve': False, 'offset': 1128267776, 'id': 'partition-1', 'type': 'partition'})
  968. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  969. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  970. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17']
  971. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  972. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device? False
  973. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  974. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device member? False
  975. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block.lookup_disk() returning path /dev/nvme2n1
  976. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  977. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  978. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.010
  979. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devsync happy - path /dev/nvme2n1 now exists
  980. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return volume path /dev/nvme2n1
  981. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: block-meta: extracted devices to clear: ['/dev/nvme2n1']
  982. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Declared block devices: ['/dev/nvme2n1']
  983. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: clearing devices=['/dev/nvme2n1']
  984. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  985. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  986. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm assemble scan results:
  987. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  988. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: looking for devices for further assembly
  989. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop16
  990. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop15
  991. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop14
  992. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop13
  993. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop12
  994. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop11
  995. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop10
  996. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop9
  997. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop8
  998. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  999. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/sda
  1000. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme2n1
  1001. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  1002. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  1003. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  1004. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  1005. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  1006. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  1007. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  1008. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  1009. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop7
  1010. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop6
  1011. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop5
  1012. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop4
  1013. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop3
  1014. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop2
  1015. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop1
  1016. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: no recogniseable superblock on /dev/loop0
  1017. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm: No arrays found in config file or automatically
  1018. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  1019. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  1020. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: mdadm detail scan after assemble:
  1021. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  1022. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  1023. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1024. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.002
  1025. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  1026. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  1027. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  1028. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1029. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED udevadm_settle(): 0.006
  1030. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Loading kernel module bcache via modprobe
  1031. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  1032. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Generating device storage trees for path(s): ['/dev/nvme2n1']
  1033. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  1034. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  1035. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  1036. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  1037. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Current device storage tree:
  1038. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: nvme2n1
  1039. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Shutdown Plan:
  1040. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {'level': 0, 'device': '/sys/class/block/nvme2n1', 'dev_type': 'disk'}
  1041. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: shutdown running on holder type: 'disk' syspath: '/sys/class/block/nvme2n1'
  1042. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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/nvme2n1'] with allowed return codes [0] (capture=True)
  1043. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: info:
  1044. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: {
  1045. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "nvme2n1": {
  1046. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ALIGNMENT": "0",
  1047. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ALN": "0",
  1048. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-GRAN": "512",
  1049. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-MAX": "2199023255040",
  1050. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "DISC-ZERO": "0",
  1051. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "FSTYPE": "",
  1052. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "GROUP": "disk",
  1053. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "KNAME": "nvme2n1",
  1054. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LABEL": "",
  1055. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "LOG-SEC": "512",
  1056. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MAJ:MIN": "259:9",
  1057. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MIN-IO": "4096",
  1058. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODE": "brw-rw----",
  1059. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MODEL": "CT500P310SSD8",
  1060. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "MOUNTPOINT": "",
  1061. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "NAME": "nvme2n1",
  1062. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OPT-IO": "4096",
  1063. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "OWNER": "root",
  1064. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "PHY-SEC": "512",
  1065. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RM": "0",
  1066. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RO": "0",
  1067. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "ROTA": "0",
  1068. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "RQ-SIZE": "1023",
  1069. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "SIZE": "500107862016",
  1070. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "STATE": "live",
  1071. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "TYPE": "disk",
  1072. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "UUID": "",
  1073. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: "device_path": "/dev/nvme2n1"
  1074. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  1075. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: }
  1076. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_blockdev_sector_size: (log=512, phys=512)
  1077. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['fdasd', '--table', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  1078. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 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)
  1079. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Checking if /dev/nvme2n1 is a swap device
  1080. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  1081. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping superblock on /dev/nvme2n1
  1082. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping /dev/nvme2n1 attempt 1/4
  1083. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1'] with allowed return codes [0] (capture=False)
  1084. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: wiping 1M on /dev/nvme2n1 at offsets [0, -1048576]
  1085. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: successfully wiped device /dev/nvme2n1 on attempt 1/4
  1086. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: devname '/sys/class/block/nvme2n1' had holders: []
  1087. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  1088. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  1089. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: /dev/nvme2n1 is multipath device partition? False
  1090. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  1091. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: blockmeta: detected storage config, using mode=custom
  1092. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  1093. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  1094. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  1095. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: get_path_to_storage_volume for volume disk-nvme2n1({'ptable': 'gpt', 'serial': 'CT500P310SSD8_24254AD53E17_1', 'wwn': 'eui.000000000000000100a075244ad53e17', 'nvme_controller': 'nvme-controller-nvme2', 'path': '/dev/nvme2n1', 'wipe': 'superblock-recursive', 'preserve': False, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  1096. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  1097. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  1098. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: TIMED BLOCK_META: 0.389
  1099. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  1100. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Traceback (most recent call last):
  1101. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/main.py", line 202, in main
  1102. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: ret = args.func(args)
  1103. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 97, in wrapper
  1104. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  1105. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/log.py", line 79, in log_time
  1106. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return func(*args, **kwargs)
  1107. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  1108. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: return meta_custom(args)
  1109. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  1110. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: handler(command, storage_config_dict, context)
  1111. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  1112. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk_handler_v1(info, storage_config, context)
  1113. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  1114. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  1115. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  1116. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: volume_path = v2_get_path_to_disk(vol)
  1117. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: File "/snap/ubuntu-desktop-bootstrap/290/lib/python3.10/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  1118. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: link2dev[dev['DEVNAME']] = dev
  1119. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: KeyError: 'DEVNAME'
  1120. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: 'DEVNAME'
  1121. May 02 16:25:07 ubuntu subiquity_log.4805[6962]:
  1122. May 02 16:25:07 ubuntu subiquity_log.4805[6962]: Stderr: ''
  1123. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: executing curtin install partitioning step
  1124. May 02 16:25:07 ubuntu subiquity_event.4805[4805]: installing system
  1125. May 02 16:25:07 ubuntu subiquity_event.4805[4805]:
  1126. May 02 16:25:08 ubuntu subiquity_event.4805[4805]: curtin command install
Advertisement
Add Comment
Please, Sign In to add comment
Advertisement
Public Pastes
Advertisement
We use cookies for various purposes including analytics. By continuing to use Pastebin, you agree to our use of cookies as described in the Cookies Policy.  OK, I Understand
Not a member of Pastebin yet?
Sign Up, it unlocks many cool features!