API tools faq
paste
Advertisement
SirFisho

Error without installing 3rd party

SirFisho
May 6th, 2025
39
0
Never
Add comment
Not a member of Pastebin yet? Sign Up, it unlocks many cool features!
text 174.53 KB | None | 0 0
raw download clone embed print report
  1. May 06 13:51:20 ubuntu subiquity_event.4692[4692]: subiquity/load_cloud_config/extract_autoinstall:
  2. May 06 13:51:20 ubuntu subiquity_event.4692[4692]: subiquity/load_cloud_config/extract_autoinstall:
  3. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Early/apply_autoinstall_config:
  4. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Early/apply_autoinstall_config:
  5. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Reporting/apply_autoinstall_config:
  6. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Reporting/apply_autoinstall_config:
  7. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Error/apply_autoinstall_config:
  8. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Error/apply_autoinstall_config:
  9. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Userdata/apply_autoinstall_config:
  10. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Userdata/apply_autoinstall_config:
  11. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Package/apply_autoinstall_config:
  12. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Package/apply_autoinstall_config:
  13. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Debconf/apply_autoinstall_config:
  14. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Debconf/apply_autoinstall_config:
  15. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Kernel/apply_autoinstall_config:
  16. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Kernel/apply_autoinstall_config:
  17. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/KernelCrashDumps/apply_autoinstall_config:
  18. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/KernelCrashDumps/apply_autoinstall_config:
  19. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Zdev/apply_autoinstall_config:
  20. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Zdev/apply_autoinstall_config:
  21. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Ad/apply_autoinstall_config:
  22. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Ad/apply_autoinstall_config:
  23. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Late/apply_autoinstall_config:
  24. May 06 13:51:22 ubuntu subiquity_event.4692[4692]: subiquity/Late/apply_autoinstall_config:
  25. May 06 13:54:36 ubuntu subiquity_event.4692[4692]: subiquity/Ad/has_support_GET:
  26. May 06 13:55:22 ubuntu subiquity_event.4692[4692]: configuring apt
  27. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: start: cmd-apt-config: curtin command apt-config
  28. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Handling apt to target /tmp/tmps4cyitrw/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 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--bind', '/dev', '/tmp/tmps4cyitrw/mount/dev'] with allowed return codes [0] (capture=False)
  30. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--bind', '/proc', '/tmp/tmps4cyitrw/mount/proc'] with allowed return codes [0] (capture=False)
  31. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--bind', '/run', '/tmp/tmps4cyitrw/mount/run'] with allowed return codes [0] (capture=False)
  32. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--bind', '/sys', '/tmp/tmps4cyitrw/mount/sys'] with allowed return codes [0] (capture=False)
  33. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmps4cyitrw/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  34. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--bind', '/tmp/tmps4cyitrw/mount/usr/bin/true', '/tmp/tmps4cyitrw/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  35. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
  36. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  37. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  38. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
  39. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  40. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  41. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  42. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: got primary mirror: http://it.archive.ubuntu.com/ubuntu/
  43. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: got security mirror: http://security.ubuntu.com/ubuntu/
  44. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: 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 06 13:55:23 ubuntu subiquity_log.4692[8170]: Applying debconf selections
  46. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  47. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  48. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
  49. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  50. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  51. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
  52. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
  53. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  54. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  55. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  56. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  57. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  58. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
  59. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
  60. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Checking if target_proc (/tmp/tmps4cyitrw/mount/proc) is a mount
  61. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: It is, so unshare will use --mount-proc=/tmp/tmps4cyitrw/mount/proc
  62. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmps4cyitrw/mount/proc', '--', 'chroot', '/tmp/tmps4cyitrw/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  63. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_InRelease to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_InRelease
  64. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_cnf_Commands-amd64 to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_cnf_Commands-amd64
  65. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_Components-amd64.yml.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_Components-amd64.yml.gz
  66. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-48x48.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-48x48.tar.gz
  67. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64%402.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64%402.tar.gz
  68. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64.tar.gz
  69. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_cnf_Commands-amd64 to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_cnf_Commands-amd64
  70. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_Components-amd64.yml.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_Components-amd64.yml.gz
  71. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-48x48.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-48x48.tar.gz
  72. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64%402.tar.gz
  73. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64.tar.gz
  74. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_InRelease to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_InRelease
  75. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_binary-amd64_Packages to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_binary-amd64_Packages
  76. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_cnf_Commands-amd64 to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_cnf_Commands-amd64
  77. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_Components-amd64.yml.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_Components-amd64.yml.gz
  78. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-48x48.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-48x48.tar.gz
  79. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64%402.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64%402.tar.gz
  80. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64.tar.gz
  81. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_i18n_Translation-en to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_i18n_Translation-en
  82. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_binary-amd64_Packages to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_binary-amd64_Packages
  83. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_cnf_Commands-amd64 to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_cnf_Commands-amd64
  84. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_Components-amd64.yml.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_Components-amd64.yml.gz
  85. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-48x48.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-48x48.tar.gz
  86. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64%402.tar.gz
  87. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64.tar.gz to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64.tar.gz
  88. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Renaming apt list /tmp/tmps4cyitrw/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_i18n_Translation-en to /tmp/tmps4cyitrw/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_i18n_Translation-en
  89. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  90. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: TIMED subp(['udevadm', 'settle']): 0.003
  91. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--make-private', '/tmp/tmps4cyitrw/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  92. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['umount', '/tmp/tmps4cyitrw/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  93. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--make-private', '/tmp/tmps4cyitrw/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  94. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['umount', '/tmp/tmps4cyitrw/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  95. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--make-private', '/tmp/tmps4cyitrw/mount/sys'] with allowed return codes [0] (capture=False)
  96. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['umount', '/tmp/tmps4cyitrw/mount/sys'] with allowed return codes [0] (capture=False)
  97. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--make-private', '/tmp/tmps4cyitrw/mount/run'] with allowed return codes [0] (capture=False)
  98. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['umount', '/tmp/tmps4cyitrw/mount/run'] with allowed return codes [0] (capture=False)
  99. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--make-private', '/tmp/tmps4cyitrw/mount/proc'] with allowed return codes [0] (capture=False)
  100. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['umount', '/tmp/tmps4cyitrw/mount/proc'] with allowed return codes [0] (capture=False)
  101. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['mount', '--make-private', '/tmp/tmps4cyitrw/mount/dev'] with allowed return codes [0] (capture=False)
  102. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: Running command ['umount', '/tmp/tmps4cyitrw/mount/dev'] with allowed return codes [0] (capture=False)
  103. May 06 13:55:23 ubuntu subiquity_log.4692[8170]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
  104. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: start: cmd-apt-config: curtin command apt-config
  105. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Handling apt to target /tmp/tmpjw00lnql/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 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--bind', '/dev', '/tmp/tmpjw00lnql/mount/dev'] with allowed return codes [0] (capture=False)
  107. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--bind', '/proc', '/tmp/tmpjw00lnql/mount/proc'] with allowed return codes [0] (capture=False)
  108. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--bind', '/run', '/tmp/tmpjw00lnql/mount/run'] with allowed return codes [0] (capture=False)
  109. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--bind', '/sys', '/tmp/tmpjw00lnql/mount/sys'] with allowed return codes [0] (capture=False)
  110. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpjw00lnql/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  111. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--bind', '/tmp/tmpjw00lnql/mount/usr/bin/true', '/tmp/tmpjw00lnql/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  112. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
  113. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  114. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  115. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'lsb_release', '--all'] with allowed return codes [0] (capture=True)
  116. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  117. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  118. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  119. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: got primary mirror: http://it.archive.ubuntu.com/ubuntu/
  120. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: got security mirror: http://security.ubuntu.com/ubuntu/
  121. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: 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 06 13:55:25 ubuntu subiquity_log.4692[8379]: Applying debconf selections
  123. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  124. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  125. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'debconf-set-selections'] with allowed return codes [0] (capture=True)
  126. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  127. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  128. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'dpkg-query', '--list'] with allowed return codes [0] (capture=True)
  129. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: No custom template provided, fall back to modifymirrors in /etc/apt/sources.list.d/ubuntu.sources on the target system
  130. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  131. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  132. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  133. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  134. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  135. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'dpkg-query', '--show', '--showformat', '${Version}', 'cloud-init'] with allowed return codes [0] (capture=True)
  136. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Set preserve_sources_list to True in /etc/cloud/cloud.cfg.d/curtin-preserve-sources.cfg with: {'apt': {'preserve_sources_list': True}}
  137. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Checking if target_proc (/tmp/tmpjw00lnql/mount/proc) is a mount
  138. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: It is, so unshare will use --mount-proc=/tmp/tmpjw00lnql/mount/proc
  139. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpjw00lnql/mount/proc', '--', 'chroot', '/tmp/tmpjw00lnql/mount', 'dpkg', '--print-architecture'] with allowed return codes [0] (capture=True)
  140. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_InRelease to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_InRelease
  141. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_cnf_Commands-amd64 to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_cnf_Commands-amd64
  142. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_Components-amd64.yml.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_Components-amd64.yml.gz
  143. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-48x48.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-48x48.tar.gz
  144. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64%402.tar.gz
  145. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_main_dep11_icons-64x64.tar.gz
  146. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_cnf_Commands-amd64 to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_cnf_Commands-amd64
  147. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_Components-amd64.yml.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_Components-amd64.yml.gz
  148. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-48x48.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-48x48.tar.gz
  149. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64%402.tar.gz
  150. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky-updates_restricted_dep11_icons-64x64.tar.gz
  151. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_InRelease to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_InRelease
  152. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_binary-amd64_Packages to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_binary-amd64_Packages
  153. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_cnf_Commands-amd64 to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_cnf_Commands-amd64
  154. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_Components-amd64.yml.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_Components-amd64.yml.gz
  155. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-48x48.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-48x48.tar.gz
  156. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64%402.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64%402.tar.gz
  157. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_dep11_icons-64x64.tar.gz
  158. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_main_i18n_Translation-en to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_main_i18n_Translation-en
  159. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_binary-amd64_Packages to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_binary-amd64_Packages
  160. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_cnf_Commands-amd64 to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_cnf_Commands-amd64
  161. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_Components-amd64.yml.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_Components-amd64.yml.gz
  162. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-48x48.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-48x48.tar.gz
  163. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64%402.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64%402.tar.gz
  164. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64.tar.gz to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_dep11_icons-64x64.tar.gz
  165. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Renaming apt list /tmp/tmpjw00lnql/mount/var/lib/apt/lists/archive.ubuntu.com_ubuntu_dists_plucky_restricted_i18n_Translation-en to /tmp/tmpjw00lnql/mount/var/lib/apt/lists/it.archive.ubuntu.com_ubuntu_dists_plucky_restricted_i18n_Translation-en
  166. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  167. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: TIMED subp(['udevadm', 'settle']): 0.002
  168. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--make-private', '/tmp/tmpjw00lnql/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  169. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['umount', '/tmp/tmpjw00lnql/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  170. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--make-private', '/tmp/tmpjw00lnql/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  171. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['umount', '/tmp/tmpjw00lnql/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  172. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--make-private', '/tmp/tmpjw00lnql/mount/sys'] with allowed return codes [0] (capture=False)
  173. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['umount', '/tmp/tmpjw00lnql/mount/sys'] with allowed return codes [0] (capture=False)
  174. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--make-private', '/tmp/tmpjw00lnql/mount/run'] with allowed return codes [0] (capture=False)
  175. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['umount', '/tmp/tmpjw00lnql/mount/run'] with allowed return codes [0] (capture=False)
  176. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--make-private', '/tmp/tmpjw00lnql/mount/proc'] with allowed return codes [0] (capture=False)
  177. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['umount', '/tmp/tmpjw00lnql/mount/proc'] with allowed return codes [0] (capture=False)
  178. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['mount', '--make-private', '/tmp/tmpjw00lnql/mount/dev'] with allowed return codes [0] (capture=False)
  179. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: Running command ['umount', '/tmp/tmpjw00lnql/mount/dev'] with allowed return codes [0] (capture=False)
  180. May 06 13:55:25 ubuntu subiquity_log.4692[8379]: finish: cmd-apt-config: SUCCESS: curtin command apt-config
  181. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: start: cmd-in-target: curtin command in-target
  182. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--bind', '/dev', '/tmp/tmpr04pm3g6/mount/dev'] with allowed return codes [0] (capture=False)
  183. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--bind', '/proc', '/tmp/tmpr04pm3g6/mount/proc'] with allowed return codes [0] (capture=False)
  184. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--bind', '/run', '/tmp/tmpr04pm3g6/mount/run'] with allowed return codes [0] (capture=False)
  185. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--bind', '/sys', '/tmp/tmpr04pm3g6/mount/sys'] with allowed return codes [0] (capture=False)
  186. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--bind', '/sys/firmware/efi/efivars', '/tmp/tmpr04pm3g6/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  187. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--bind', '/tmp/tmpr04pm3g6/mount/usr/bin/true', '/tmp/tmpr04pm3g6/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  188. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['unshare', '--help'] with allowed return codes [0] (capture=True)
  189. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Checking if target_proc (/tmp/tmpr04pm3g6/mount/proc) is a mount
  190. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: It is, so unshare will use --mount-proc=/tmp/tmpr04pm3g6/mount/proc
  191. May 06 13:55:26 ubuntu subiquity_log.4692[8452]: Running command ['unshare', '--fork', '--pid', '--mount-proc=/tmp/tmpr04pm3g6/mount/proc', '--', 'chroot', '/tmp/tmpr04pm3g6/mount', 'apt-get', 'update'] with allowed return codes [0] (capture=False)
  192. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Ign:1 file:/cdrom plucky InRelease
  193. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:2 file:/cdrom plucky Release [1,075 B]
  194. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:2 file:/cdrom plucky Release [1,075 B]
  195. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:3 file:/cdrom plucky Release.gpg [833 B]
  196. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:3 file:/cdrom plucky Release.gpg [833 B]
  197. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:4 file:/cdrom plucky/main amd64 Packages [51.0 kB]
  198. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:5 file:/cdrom plucky/restricted amd64 Packages [9,717 B]
  199. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:6 http://it.archive.ubuntu.com/ubuntu plucky InRelease [265 kB]
  200. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:7 http://it.archive.ubuntu.com/ubuntu plucky-updates InRelease [126 kB]
  201. May 06 13:55:26 ubuntu subiquity_event.4692[4692]: curtin command in-target
  202. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:8 http://security.ubuntu.com/ubuntu plucky-security InRelease [126 kB]
  203. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:9 http://it.archive.ubuntu.com/ubuntu plucky-backports InRelease [126 kB]
  204. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:10 http://it.archive.ubuntu.com/ubuntu plucky/main amd64 Packages [1,446 kB]
  205. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:11 http://it.archive.ubuntu.com/ubuntu plucky/main Translation-en [519 kB]
  206. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:12 http://it.archive.ubuntu.com/ubuntu plucky/main amd64 Components [414 kB]
  207. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:13 http://it.archive.ubuntu.com/ubuntu plucky/main Icons (48x48) [85.8 kB]
  208. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:14 http://it.archive.ubuntu.com/ubuntu plucky/main Icons (64x64) [122 kB]
  209. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:15 http://it.archive.ubuntu.com/ubuntu plucky/main Icons (64x64@2) [21.8 kB]
  210. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:16 http://it.archive.ubuntu.com/ubuntu plucky/main amd64 c-n-f Metadata [31.6 kB]
  211. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:17 http://it.archive.ubuntu.com/ubuntu plucky/restricted amd64 Packages [52.3 kB]
  212. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:18 http://it.archive.ubuntu.com/ubuntu plucky/restricted Translation-en [13.1 kB]
  213. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:19 http://it.archive.ubuntu.com/ubuntu plucky/restricted amd64 Components [556 B]
  214. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:20 http://it.archive.ubuntu.com/ubuntu plucky/restricted Icons (48x48) [29 B]
  215. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:21 http://it.archive.ubuntu.com/ubuntu plucky/restricted Icons (64x64) [29 B]
  216. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:22 http://it.archive.ubuntu.com/ubuntu plucky/restricted Icons (64x64@2) [29 B]
  217. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:23 http://it.archive.ubuntu.com/ubuntu plucky/restricted amd64 c-n-f Metadata [380 B]
  218. May 06 13:55:26 ubuntu subiquity_log.4692[8476]: Get:24 http://it.archive.ubuntu.com/ubuntu plucky/universe amd64 Packages [16.3 MB]
  219. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:25 http://security.ubuntu.com/ubuntu plucky-security/main amd64 Packages [22.1 kB]
  220. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:26 http://security.ubuntu.com/ubuntu plucky-security/main Translation-en [8,084 B]
  221. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:27 http://security.ubuntu.com/ubuntu plucky-security/main amd64 Components [14.7 kB]
  222. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:28 http://security.ubuntu.com/ubuntu plucky-security/main Icons (48x48) [3,575 B]
  223. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:29 http://security.ubuntu.com/ubuntu plucky-security/main Icons (64x64) [5,307 B]
  224. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:30 http://security.ubuntu.com/ubuntu plucky-security/main Icons (64x64@2) [29 B]
  225. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:31 http://security.ubuntu.com/ubuntu plucky-security/main amd64 c-n-f Metadata [112 B]
  226. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:32 http://security.ubuntu.com/ubuntu plucky-security/restricted amd64 Packages [46.6 kB]
  227. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:33 http://security.ubuntu.com/ubuntu plucky-security/restricted Translation-en [11.8 kB]
  228. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:34 http://security.ubuntu.com/ubuntu plucky-security/restricted amd64 Components [212 B]
  229. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:35 http://security.ubuntu.com/ubuntu plucky-security/restricted Icons (48x48) [29 B]
  230. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:36 http://security.ubuntu.com/ubuntu plucky-security/restricted Icons (64x64) [29 B]
  231. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:37 http://it.archive.ubuntu.com/ubuntu plucky/universe Translation-en [6,281 kB]
  232. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:38 http://security.ubuntu.com/ubuntu plucky-security/restricted Icons (64x64@2) [29 B]
  233. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:39 http://security.ubuntu.com/ubuntu plucky-security/restricted amd64 c-n-f Metadata [116 B]
  234. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:40 http://security.ubuntu.com/ubuntu plucky-security/universe amd64 Packages [23.0 kB]
  235. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:41 http://security.ubuntu.com/ubuntu plucky-security/universe Translation-en [7,152 B]
  236. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:42 http://security.ubuntu.com/ubuntu plucky-security/universe amd64 Components [748 B]
  237. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:43 http://security.ubuntu.com/ubuntu plucky-security/universe Icons (48x48) [1,273 B]
  238. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:44 http://security.ubuntu.com/ubuntu plucky-security/universe Icons (64x64) [1,575 B]
  239. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:45 http://security.ubuntu.com/ubuntu plucky-security/universe Icons (64x64@2) [29 B]
  240. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:46 http://security.ubuntu.com/ubuntu plucky-security/universe amd64 c-n-f Metadata [116 B]
  241. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:47 http://security.ubuntu.com/ubuntu plucky-security/multiverse amd64 Packages [14.0 kB]
  242. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:48 http://security.ubuntu.com/ubuntu plucky-security/multiverse Translation-en [2,836 B]
  243. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:49 http://security.ubuntu.com/ubuntu plucky-security/multiverse amd64 Components [212 B]
  244. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:50 http://security.ubuntu.com/ubuntu plucky-security/multiverse Icons (48x48) [29 B]
  245. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:51 http://security.ubuntu.com/ubuntu plucky-security/multiverse Icons (64x64) [29 B]
  246. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:52 http://security.ubuntu.com/ubuntu plucky-security/multiverse Icons (64x64@2) [29 B]
  247. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:53 http://it.archive.ubuntu.com/ubuntu plucky/universe amd64 Components [4,360 kB]
  248. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:54 http://security.ubuntu.com/ubuntu plucky-security/multiverse amd64 c-n-f Metadata [116 B]
  249. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:55 http://it.archive.ubuntu.com/ubuntu plucky/universe Icons (48x48) [3,688 kB]
  250. May 06 13:55:27 ubuntu subiquity_log.4692[8476]: Get:56 http://it.archive.ubuntu.com/ubuntu plucky/universe Icons (64x64) [7,563 kB]
  251. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:57 http://it.archive.ubuntu.com/ubuntu plucky/universe Icons (64x64@2) [103 kB]
  252. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:58 http://it.archive.ubuntu.com/ubuntu plucky/universe amd64 c-n-f Metadata [104 B]
  253. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:59 http://it.archive.ubuntu.com/ubuntu plucky/multiverse amd64 Packages [260 kB]
  254. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:60 http://it.archive.ubuntu.com/ubuntu plucky/multiverse Translation-en [119 kB]
  255. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:61 http://it.archive.ubuntu.com/ubuntu plucky/multiverse amd64 Components [46.3 kB]
  256. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:62 http://it.archive.ubuntu.com/ubuntu plucky/multiverse Icons (48x48) [60.3 kB]
  257. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:63 http://it.archive.ubuntu.com/ubuntu plucky/multiverse Icons (64x64) [187 kB]
  258. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:64 http://it.archive.ubuntu.com/ubuntu plucky/multiverse Icons (64x64@2) [904 B]
  259. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:65 http://it.archive.ubuntu.com/ubuntu plucky/multiverse amd64 c-n-f Metadata [7,312 B]
  260. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:66 http://it.archive.ubuntu.com/ubuntu plucky-updates/main amd64 Packages [23.0 kB]
  261. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:67 http://it.archive.ubuntu.com/ubuntu plucky-updates/main Translation-en [8,492 B]
  262. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:68 http://it.archive.ubuntu.com/ubuntu plucky-updates/main amd64 Components [14.7 kB]
  263. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:69 http://it.archive.ubuntu.com/ubuntu plucky-updates/main Icons (48x48) [3,575 B]
  264. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:70 http://it.archive.ubuntu.com/ubuntu plucky-updates/main Icons (64x64) [5,307 B]
  265. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:71 http://it.archive.ubuntu.com/ubuntu plucky-updates/main Icons (64x64@2) [29 B]
  266. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:72 http://it.archive.ubuntu.com/ubuntu plucky-updates/main amd64 c-n-f Metadata [108 B]
  267. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:73 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted amd64 Packages [46.6 kB]
  268. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:74 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted Translation-en [11.8 kB]
  269. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:75 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted amd64 Components [212 B]
  270. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:76 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted Icons (48x48) [29 B]
  271. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:77 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted Icons (64x64) [29 B]
  272. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:78 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted Icons (64x64@2) [29 B]
  273. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:79 http://it.archive.ubuntu.com/ubuntu plucky-updates/restricted amd64 c-n-f Metadata [116 B]
  274. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:80 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe amd64 Packages [23.8 kB]
  275. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:81 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe Translation-en [7,372 B]
  276. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:82 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe amd64 Components [752 B]
  277. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:83 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe Icons (48x48) [1,273 B]
  278. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:84 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe Icons (64x64) [1,575 B]
  279. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:85 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe Icons (64x64@2) [29 B]
  280. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:86 http://it.archive.ubuntu.com/ubuntu plucky-updates/universe amd64 c-n-f Metadata [112 B]
  281. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:87 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse amd64 Packages [14.0 kB]
  282. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:88 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse Translation-en [2,836 B]
  283. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:89 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse amd64 Components [212 B]
  284. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:90 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse Icons (48x48) [29 B]
  285. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:91 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse Icons (64x64) [29 B]
  286. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:92 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse Icons (64x64@2) [29 B]
  287. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:93 http://it.archive.ubuntu.com/ubuntu plucky-updates/multiverse amd64 c-n-f Metadata [116 B]
  288. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:94 http://it.archive.ubuntu.com/ubuntu plucky-backports/main amd64 Components [212 B]
  289. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:95 http://it.archive.ubuntu.com/ubuntu plucky-backports/main Icons (48x48) [29 B]
  290. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:96 http://it.archive.ubuntu.com/ubuntu plucky-backports/main Icons (64x64) [29 B]
  291. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:97 http://it.archive.ubuntu.com/ubuntu plucky-backports/main Icons (64x64@2) [29 B]
  292. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:98 http://it.archive.ubuntu.com/ubuntu plucky-backports/main amd64 c-n-f Metadata [112 B]
  293. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:99 http://it.archive.ubuntu.com/ubuntu plucky-backports/restricted amd64 Components [216 B]
  294. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:100 http://it.archive.ubuntu.com/ubuntu plucky-backports/restricted Icons (48x48) [29 B]
  295. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:101 http://it.archive.ubuntu.com/ubuntu plucky-backports/restricted Icons (64x64) [29 B]
  296. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:102 http://it.archive.ubuntu.com/ubuntu plucky-backports/restricted Icons (64x64@2) [29 B]
  297. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:103 http://it.archive.ubuntu.com/ubuntu plucky-backports/restricted amd64 c-n-f Metadata [116 B]
  298. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:104 http://it.archive.ubuntu.com/ubuntu plucky-backports/universe amd64 Components [216 B]
  299. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:105 http://it.archive.ubuntu.com/ubuntu plucky-backports/universe Icons (48x48) [29 B]
  300. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:106 http://it.archive.ubuntu.com/ubuntu plucky-backports/universe Icons (64x64) [29 B]
  301. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:107 http://it.archive.ubuntu.com/ubuntu plucky-backports/universe Icons (64x64@2) [29 B]
  302. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:108 http://it.archive.ubuntu.com/ubuntu plucky-backports/universe amd64 c-n-f Metadata [116 B]
  303. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:109 http://it.archive.ubuntu.com/ubuntu plucky-backports/multiverse amd64 Components [216 B]
  304. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:110 http://it.archive.ubuntu.com/ubuntu plucky-backports/multiverse Icons (48x48) [29 B]
  305. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:111 http://it.archive.ubuntu.com/ubuntu plucky-backports/multiverse Icons (64x64) [29 B]
  306. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:112 http://it.archive.ubuntu.com/ubuntu plucky-backports/multiverse Icons (64x64@2) [29 B]
  307. May 06 13:55:28 ubuntu subiquity_log.4692[8476]: Get:113 http://it.archive.ubuntu.com/ubuntu plucky-backports/multiverse amd64 c-n-f Metadata [116 B]
  308. May 06 13:55:30 ubuntu subiquity_log.4692[8476]: Fetched 42.7 MB in 3s (16.8 MB/s)
  309. May 06 13:55:30 ubuntu subiquity_log.4692[8476]: Reading package lists...
  310. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  311. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: TIMED subp(['udevadm', 'settle']): 0.006
  312. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--make-private', '/tmp/tmpr04pm3g6/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  313. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['umount', '/tmp/tmpr04pm3g6/mount/usr/bin/ischroot'] with allowed return codes [0] (capture=False)
  314. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--make-private', '/tmp/tmpr04pm3g6/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  315. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['umount', '/tmp/tmpr04pm3g6/mount/sys/firmware/efi/efivars'] with allowed return codes [0] (capture=False)
  316. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--make-private', '/tmp/tmpr04pm3g6/mount/sys'] with allowed return codes [0] (capture=False)
  317. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['umount', '/tmp/tmpr04pm3g6/mount/sys'] with allowed return codes [0] (capture=False)
  318. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--make-private', '/tmp/tmpr04pm3g6/mount/run'] with allowed return codes [0] (capture=False)
  319. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['umount', '/tmp/tmpr04pm3g6/mount/run'] with allowed return codes [0] (capture=False)
  320. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--make-private', '/tmp/tmpr04pm3g6/mount/proc'] with allowed return codes [0] (capture=False)
  321. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['umount', '/tmp/tmpr04pm3g6/mount/proc'] with allowed return codes [0] (capture=False)
  322. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['mount', '--make-private', '/tmp/tmpr04pm3g6/mount/dev'] with allowed return codes [0] (capture=False)
  323. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: Running command ['umount', '/tmp/tmpr04pm3g6/mount/dev'] with allowed return codes [0] (capture=False)
  324. May 06 13:55:30 ubuntu subiquity_log.4692[8452]: finish: cmd-in-target: SUCCESS: curtin command in-target
  325. May 06 13:55:31 ubuntu subiquity_event.4692[4692]: curtin command in-target
  326. May 06 13:55:31 ubuntu subiquity_event.4692[4692]: configuring apt
  327. May 06 13:55:31 ubuntu subiquity_event.4692[4692]: installing system
  328. May 06 13:55:31 ubuntu subiquity_event.4692[4692]: executing curtin install initial step
  329. May 06 13:55:31 ubuntu subiquity_log.4692[8642]: /usr/bin/ubuntu-drivers
  330. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: start: cmd-install: curtin command install
  331. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: curtin: Installation started. (24.0.0-100-gaa2f5dd03)
  332. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: LANG=en_US.UTF-8
  333. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: 'reporter' not found in config file.
  334. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: curtin: Installation started. (24.0.0-100-gaa2f5dd03)
  335. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: Exporting resume data to /tmp/tmppxiku217/resume-data.json so that further stages can be executed in a later invocation.
  336. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: {'WORKING_DIR': '/tmp/tmpuql0gezb/scratch', 'OUTPUT_FSTAB': '/tmp/tmpuql0gezb/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmpuql0gezb/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmpuql0gezb/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmpuql0gezb/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmpuql0gezb/state/config'}
  337. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: curtin: Installation finished.
  338. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: Skipping unmount: config disabled target unmounting
  339. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: TIMED INSTALL_COMMAND: 0.000
  340. May 06 13:55:31 ubuntu subiquity_log.4692[8639]: finish: cmd-install: SUCCESS: curtin command install
  341. May 06 13:55:31 ubuntu subiquity_event.4692[4692]: executing curtin install initial step
  342. May 06 13:55:31 ubuntu subiquity_event.4692[4692]: executing curtin install partitioning step
  343. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: start: cmd-install: curtin command install
  344. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: unknown type for url 'cp:///tmp/tmpr04pm3g6/mount', assuming type 'tgz'
  345. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: curtin: Installation started. (24.0.0-100-gaa2f5dd03)
  346. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: LANG=en_US.UTF-8
  347. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: 'reporter' not found in config file.
  348. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: curtin: Installation started. (24.0.0-100-gaa2f5dd03)
  349. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: {'WORKING_DIR': '/tmp/tmpuql0gezb/scratch', 'OUTPUT_FSTAB': '/tmp/tmpuql0gezb/state/fstab', 'OUTPUT_INTERFACES': '/tmp/tmpuql0gezb/state/interfaces', 'OUTPUT_NETWORK_CONFIG': '/tmp/tmpuql0gezb/state/network_config', 'OUTPUT_NETWORK_STATE': '/tmp/tmpuql0gezb/state/network_state', 'TARGET_MOUNT_POINT': '/target', 'CONFIG': '/tmp/tmpuql0gezb/state/config'}
  350. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning: configuring storage
  351. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin: running 'curtin block-meta simple'
  352. May 06 13:55:32 ubuntu subiquity_event.4692[4692]: curtin command install
  353. May 06 13:55:32 ubuntu subiquity_event.4692[4692]: configuring storage
  354. May 06 13:55:32 ubuntu subiquity_event.4692[4692]: running 'curtin block-meta simple'
  355. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  356. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 490442063872, 'wipe': 'superblock', 'number': 3, 'preserve': False, 'offset': 5368709120, 'id': 'partition-0', 'type': 'partition'})
  357. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  358. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  359. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17', 'nvme-eui.000000000000000100a075244ad53e17-part3', 'nvme-eui.000000000000000100a075244ad53e17-part2', 'nvme-eui.000000000000000100a075244ad53e17-part1', 'nvme-eui.000000000000000100a075244ad53e17-part4']
  360. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  361. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device? False
  362. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  363. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device member? False
  364. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: block.lookup_disk() returning path /dev/nvme2n1
  365. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  366. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  367. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.032
  368. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  369. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1
  370. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  371. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  372. May 06 13:55:32 ubuntu subiquity_event.4692[4692]: curtin command block-meta
  373. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.023
  374. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  375. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1p3
  376. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: block-meta: extracted devices to clear: ['/dev/nvme2n1p3']
  377. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Declared block devices: ['/dev/nvme2n1p3']
  378. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: clearing devices=['/dev/nvme2n1p3']
  379. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  380. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  381. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm assemble scan results:
  382. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: looking for devices for further assembly
  383. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop17
  384. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop16
  385. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop14
  386. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop15
  387. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop13
  388. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop12
  389. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop10
  390. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop11
  391. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop9
  392. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop8
  393. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  394. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda
  395. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p4
  396. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p3
  397. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p2
  398. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p1
  399. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1
  400. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  401. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  402. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  403. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  404. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  405. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  406. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  407. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  408. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop7
  409. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop6
  410. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop5
  411. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop4
  412. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop3
  413. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop2
  414. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop1
  415. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop0
  416. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm: No arrays found in config file or automatically
  417. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  418. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: mdadm detail scan after assemble:
  419. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  420. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.002
  421. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  422. May 06 13:55:32 ubuntu subiquity_log.4692[8679]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  423. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  424. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  425. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.006
  426. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Loading kernel module bcache via modprobe
  427. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  428. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Generating device storage trees for path(s): ['/dev/nvme2n1p3']
  429. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  430. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Current device storage tree:
  431. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: nvme2n1p3
  432. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Shutdown Plan:
  433. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {'level': 0, 'device': '/sys/class/block/nvme2n1p3', 'dev_type': 'partition'}
  434. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: shutdown running on holder type: 'partition' syspath: '/sys/class/block/nvme2n1p3'
  435. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  436. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: info:
  437. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {
  438. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1": {
  439. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  440. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  441. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  442. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  443. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  444. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "",
  445. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  446. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1",
  447. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  448. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  449. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:9",
  450. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  451. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  452. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "CT500P310SSD8",
  453. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  454. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1",
  455. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  456. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  457. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  458. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  459. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  460. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  461. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  462. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "500107862016",
  463. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "live",
  464. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "disk",
  465. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "",
  466. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1"
  467. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  468. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p1": {
  469. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  470. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  471. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  472. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  473. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  474. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  475. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  476. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p1",
  477. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  478. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  479. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:10",
  480. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  481. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  482. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  483. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  484. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p1",
  485. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  486. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  487. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  488. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  489. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  490. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  491. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  492. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "1071644160",
  493. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  494. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  495. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DAD5",
  496. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p1"
  497. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  498. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p2": {
  499. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  500. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  501. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  502. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  503. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  504. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  505. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  506. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p2",
  507. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  508. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  509. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:11",
  510. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  511. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  512. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  513. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  514. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p2",
  515. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  516. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  517. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  518. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  519. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  520. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  521. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  522. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  523. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  524. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  525. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DA70",
  526. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p2"
  527. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  528. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p3": {
  529. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  530. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  531. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  532. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  533. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  534. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "ext4",
  535. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  536. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p3",
  537. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  538. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  539. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:12",
  540. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  541. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  542. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  543. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  544. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p3",
  545. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  546. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  547. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  548. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  549. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  550. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  551. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  552. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "490442087936",
  553. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  554. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  555. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "e7c0a7e4-d81a-40a4-8467-a2e969c9d6a1",
  556. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p3"
  557. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  558. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p4": {
  559. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  560. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  561. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  562. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  563. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  564. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "swap",
  565. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  566. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p4",
  567. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  568. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  569. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:13",
  570. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  571. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  572. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  573. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  574. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p4",
  575. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  576. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  577. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  578. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  579. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  580. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  581. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  582. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  583. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  584. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  585. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "f7c2eec1-4eb2-404e-8404-efb0cb4f8d65",
  586. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p4"
  587. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  588. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  589. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: (log=512, phys=512)
  590. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  591. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Checking if /dev/nvme2n1p3 is a swap device
  592. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  593. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping superblock on /dev/nvme2n1p3
  594. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping /dev/nvme2n1p3 attempt 1/4
  595. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1p3'] with allowed return codes [0] (capture=False)
  596. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: removing previous storage devices
  597. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1p3: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
  598. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping 1M on /dev/nvme2n1p3 at offsets [0, -1048576]
  599. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: successfully wiped device /dev/nvme2n1p3 on attempt 1/4
  600. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  601. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  602. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: blockmeta: detected storage config, using mode=custom
  603. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  604. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  605. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  606. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  607. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  608. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: removing previous storage devices
  609. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: configuring nvme_controller: nvme-controller-nvme2
  610. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  611. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED BLOCK_META: 0.398
  612. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: configuring nvme_controller: nvme-controller-nvme2
  613. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: configuring disk: disk-nvme2n1
  614. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: configuring disk: disk-nvme2n1
  615. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  616. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Traceback (most recent call last):
  617. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/main.py", line 202, in main
  618. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ret = args.func(args)
  619. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^
  620. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 97, in wrapper
  621. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  622. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  623. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 79, in log_time
  624. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return func(*args, **kwargs)
  625. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^
  626. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  627. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return meta_custom(args)
  628. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^
  629. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  630. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: handler(command, storage_config_dict, context)
  631. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  632. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk_handler_v1(info, storage_config, context)
  633. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  634. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  635. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  636. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  637. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: volume_path = v2_get_path_to_disk(vol)
  638. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^
  639. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  640. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: link2dev[dev['DEVNAME']] = dev
  641. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ~~~^^^^^^^^^^^
  642. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: KeyError: 'DEVNAME'
  643. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 'DEVNAME'
  644. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: builtin command failed
  645. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin: FAIL: running 'curtin block-meta simple'
  646. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: builtin took 0.834 seconds
  647. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: stage_partitioning took 0.834 seconds
  648. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning: FAIL: configuring storage
  649. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: curtin: Installation failed with exception: Unexpected error while running command.
  650. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Command: ['curtin', 'block-meta', 'simple']
  651. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Exit code: 3
  652. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Reason: -
  653. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  654. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 490442063872, 'wipe': 'superblock', 'number': 3, 'preserve': False, 'offset': 5368709120, 'id': 'partition-0', 'type': 'partition'})
  655. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  656. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  657. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17', 'nvme-eui.000000000000000100a075244ad53e17-part3', 'nvme-eui.000000000000000100a075244ad53e17-part2', 'nvme-eui.000000000000000100a075244ad53e17-part1', 'nvme-eui.000000000000000100a075244ad53e17-part4']
  658. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  659. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device? False
  660. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  661. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device member? False
  662. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: block.lookup_disk() returning path /dev/nvme2n1
  663. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  664. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  665. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.032
  666. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  667. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1
  668. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  669. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  670. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.023
  671. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  672. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1p3
  673. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: block-meta: extracted devices to clear: ['/dev/nvme2n1p3']
  674. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Declared block devices: ['/dev/nvme2n1p3']
  675. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: clearing devices=['/dev/nvme2n1p3']
  676. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  677. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  678. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm assemble scan results:
  679. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  680. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: looking for devices for further assembly
  681. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop17
  682. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop16
  683. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop14
  684. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop15
  685. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop13
  686. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop12
  687. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop10
  688. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop11
  689. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop9
  690. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop8
  691. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  692. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda
  693. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p4
  694. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p3
  695. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p2
  696. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p1
  697. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1
  698. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  699. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  700. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  701. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  702. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  703. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  704. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  705. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  706. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop7
  707. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop6
  708. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop5
  709. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop4
  710. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop3
  711. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop2
  712. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop1
  713. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop0
  714. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: No arrays found in config file or automatically
  715. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  716. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  717. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm detail scan after assemble:
  718. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  719. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  720. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  721. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.002
  722. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  723. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  724. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  725. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  726. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.006
  727. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Loading kernel module bcache via modprobe
  728. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  729. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Generating device storage trees for path(s): ['/dev/nvme2n1p3']
  730. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  731. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Current device storage tree:
  732. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: nvme2n1p3
  733. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Shutdown Plan:
  734. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {'level': 0, 'device': '/sys/class/block/nvme2n1p3', 'dev_type': 'partition'}
  735. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: shutdown running on holder type: 'partition' syspath: '/sys/class/block/nvme2n1p3'
  736. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  737. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: info:
  738. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {
  739. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1": {
  740. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  741. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  742. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  743. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  744. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  745. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "",
  746. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  747. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1",
  748. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  749. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  750. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:9",
  751. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  752. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  753. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "CT500P310SSD8",
  754. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  755. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1",
  756. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  757. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  758. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  759. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  760. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  761. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  762. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  763. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "500107862016",
  764. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "live",
  765. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "disk",
  766. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "",
  767. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1"
  768. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  769. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p1": {
  770. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  771. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  772. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  773. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  774. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  775. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  776. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  777. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p1",
  778. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  779. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  780. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:10",
  781. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  782. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  783. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  784. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  785. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p1",
  786. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  787. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  788. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  789. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  790. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  791. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  792. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  793. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "1071644160",
  794. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  795. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  796. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DAD5",
  797. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p1"
  798. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  799. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p2": {
  800. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  801. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  802. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  803. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  804. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  805. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  806. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  807. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p2",
  808. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  809. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  810. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:11",
  811. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  812. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  813. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  814. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  815. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p2",
  816. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  817. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  818. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  819. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  820. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  821. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  822. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  823. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  824. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  825. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  826. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DA70",
  827. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p2"
  828. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  829. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p3": {
  830. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  831. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  832. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  833. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  834. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  835. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "ext4",
  836. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  837. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p3",
  838. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  839. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  840. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:12",
  841. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  842. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  843. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  844. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  845. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p3",
  846. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  847. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  848. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  849. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  850. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  851. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  852. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  853. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "490442087936",
  854. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  855. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  856. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "e7c0a7e4-d81a-40a4-8467-a2e969c9d6a1",
  857. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p3"
  858. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  859. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p4": {
  860. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  861. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  862. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  863. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  864. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  865. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "swap",
  866. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  867. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p4",
  868. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  869. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  870. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:13",
  871. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  872. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  873. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  874. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  875. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p4",
  876. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  877. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  878. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  879. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  880. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  881. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  882. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  883. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  884. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  885. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  886. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "f7c2eec1-4eb2-404e-8404-efb0cb4f8d65",
  887. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p4"
  888. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  889. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  890. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: (log=512, phys=512)
  891. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  892. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Checking if /dev/nvme2n1p3 is a swap device
  893. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  894. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping superblock on /dev/nvme2n1p3
  895. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping /dev/nvme2n1p3 attempt 1/4
  896. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1p3'] with allowed return codes [0] (capture=False)
  897. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1p3: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
  898. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping 1M on /dev/nvme2n1p3 at offsets [0, -1048576]
  899. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: successfully wiped device /dev/nvme2n1p3 on attempt 1/4
  900. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  901. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  902. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: blockmeta: detected storage config, using mode=custom
  903. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  904. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  905. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  906. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  907. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  908. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  909. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED BLOCK_META: 0.398
  910. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  911. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Traceback (most recent call last):
  912. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/main.py", line 202, in main
  913. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ret = args.func(args)
  914. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^
  915. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 97, in wrapper
  916. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  917. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  918. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 79, in log_time
  919. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return func(*args, **kwargs)
  920. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^
  921. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  922. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return meta_custom(args)
  923. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^
  924. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  925. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: handler(command, storage_config_dict, context)
  926. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  927. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk_handler_v1(info, storage_config, context)
  928. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  929. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  930. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  931. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  932. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: volume_path = v2_get_path_to_disk(vol)
  933. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^
  934. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  935. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: link2dev[dev['DEVNAME']] = dev
  936. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ~~~^^^^^^^^^^^
  937. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: KeyError: 'DEVNAME'
  938. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 'DEVNAME'
  939. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  940. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Stderr: ''
  941. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['uname', '-a'] with allowed return codes [0] (capture=True)
  942. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['sudo', 'lshw'] with allowed return codes [0] (capture=True)
  943. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: running 'curtin block-meta simple'
  944. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: configuring storage
  945. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['ip', '--oneline', 'address', 'list'] with allowed return codes [0] (capture=combine)
  946. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['ip', '--oneline', '-6', 'address', 'list'] with allowed return codes [0] (capture=combine)
  947. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['ip', '--oneline', 'route', 'list'] with allowed return codes [0] (capture=combine)
  948. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['ip', '--oneline', '-6', 'route', 'list'] with allowed return codes [0] (capture=combine)
  949. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['tar', '-cvf', '/var/log/installer/curtin-errors.tar', 'curtin-logs-2025-05-06-11-55'] with allowed return codes [0] (capture=True)
  950. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Wrote: /var/log/installer/curtin-errors.tar
  951. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Skipping unmount: config disabled target unmounting
  952. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED INSTALL_COMMAND: 1.602
  953. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install: FAIL: curtin command install
  954. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Traceback (most recent call last):
  955. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/main.py", line 202, in main
  956. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ret = args.func(args)
  957. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^
  958. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 97, in wrapper
  959. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  960. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  961. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 79, in log_time
  962. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return func(*args, **kwargs)
  963. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^
  964. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/install.py", line 538, in cmd_install
  965. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: raise e
  966. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/install.py", line 523, in cmd_install
  967. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: stage.run()
  968. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/install.py", line 295, in run
  969. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: raise util.ProcessExecutionError(
  970. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: curtin.util.ProcessExecutionError: Unexpected error while running command.
  971. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Command: ['curtin', 'block-meta', 'simple']
  972. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Exit code: 3
  973. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Reason: -
  974. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  975. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 490442063872, 'wipe': 'superblock', 'number': 3, 'preserve': False, 'offset': 5368709120, 'id': 'partition-0', 'type': 'partition'})
  976. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  977. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  978. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17', 'nvme-eui.000000000000000100a075244ad53e17-part3', 'nvme-eui.000000000000000100a075244ad53e17-part2', 'nvme-eui.000000000000000100a075244ad53e17-part1', 'nvme-eui.000000000000000100a075244ad53e17-part4']
  979. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  980. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device? False
  981. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  982. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device member? False
  983. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: block.lookup_disk() returning path /dev/nvme2n1
  984. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  985. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  986. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.032
  987. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  988. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1
  989. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  990. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  991. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.023
  992. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  993. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1p3
  994. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: block-meta: extracted devices to clear: ['/dev/nvme2n1p3']
  995. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Declared block devices: ['/dev/nvme2n1p3']
  996. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: clearing devices=['/dev/nvme2n1p3']
  997. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  998. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  999. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm assemble scan results:
  1000. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1001. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: looking for devices for further assembly
  1002. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop17
  1003. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop16
  1004. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop14
  1005. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop15
  1006. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop13
  1007. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop12
  1008. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop10
  1009. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop11
  1010. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop9
  1011. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop8
  1012. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  1013. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda
  1014. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p4
  1015. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p3
  1016. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p2
  1017. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p1
  1018. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1
  1019. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  1020. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  1021. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  1022. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  1023. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  1024. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  1025. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  1026. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  1027. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop7
  1028. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop6
  1029. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop5
  1030. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop4
  1031. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop3
  1032. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop2
  1033. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop1
  1034. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop0
  1035. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: No arrays found in config file or automatically
  1036. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1037. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  1038. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm detail scan after assemble:
  1039. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1040. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1041. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1042. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.002
  1043. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  1044. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  1045. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  1046. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1047. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.006
  1048. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Loading kernel module bcache via modprobe
  1049. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  1050. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Generating device storage trees for path(s): ['/dev/nvme2n1p3']
  1051. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  1052. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Current device storage tree:
  1053. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: nvme2n1p3
  1054. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Shutdown Plan:
  1055. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {'level': 0, 'device': '/sys/class/block/nvme2n1p3', 'dev_type': 'partition'}
  1056. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: shutdown running on holder type: 'partition' syspath: '/sys/class/block/nvme2n1p3'
  1057. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  1058. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: info:
  1059. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {
  1060. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1": {
  1061. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1062. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1063. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1064. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1065. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1066. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "",
  1067. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1068. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1",
  1069. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1070. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1071. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:9",
  1072. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1073. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1074. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "CT500P310SSD8",
  1075. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1076. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1",
  1077. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1078. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1079. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1080. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1081. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1082. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1083. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1084. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "500107862016",
  1085. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "live",
  1086. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "disk",
  1087. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "",
  1088. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1"
  1089. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1090. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p1": {
  1091. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1092. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1093. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1094. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1095. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1096. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  1097. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1098. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p1",
  1099. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1100. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1101. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:10",
  1102. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1103. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1104. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1105. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1106. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p1",
  1107. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1108. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1109. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1110. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1111. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1112. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1113. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1114. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "1071644160",
  1115. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1116. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1117. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DAD5",
  1118. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p1"
  1119. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1120. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p2": {
  1121. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1122. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1123. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1124. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1125. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1126. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  1127. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1128. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p2",
  1129. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1130. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1131. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:11",
  1132. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1133. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1134. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1135. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1136. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p2",
  1137. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1138. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1139. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1140. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1141. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1142. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1143. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1144. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  1145. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1146. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1147. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DA70",
  1148. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p2"
  1149. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1150. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p3": {
  1151. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1152. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1153. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1154. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1155. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1156. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "ext4",
  1157. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1158. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p3",
  1159. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1160. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1161. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:12",
  1162. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1163. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1164. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1165. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1166. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p3",
  1167. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1168. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1169. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1170. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1171. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1172. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1173. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1174. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "490442087936",
  1175. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1176. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1177. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "e7c0a7e4-d81a-40a4-8467-a2e969c9d6a1",
  1178. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p3"
  1179. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1180. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p4": {
  1181. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1182. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1183. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1184. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1185. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1186. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "swap",
  1187. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1188. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p4",
  1189. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1190. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1191. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:13",
  1192. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1193. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1194. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1195. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1196. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p4",
  1197. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1198. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1199. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1200. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1201. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1202. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1203. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1204. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  1205. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1206. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1207. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "f7c2eec1-4eb2-404e-8404-efb0cb4f8d65",
  1208. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p4"
  1209. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  1210. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  1211. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: (log=512, phys=512)
  1212. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  1213. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Checking if /dev/nvme2n1p3 is a swap device
  1214. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  1215. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping superblock on /dev/nvme2n1p3
  1216. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping /dev/nvme2n1p3 attempt 1/4
  1217. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1p3'] with allowed return codes [0] (capture=False)
  1218. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1p3: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
  1219. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping 1M on /dev/nvme2n1p3 at offsets [0, -1048576]
  1220. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: successfully wiped device /dev/nvme2n1p3 on attempt 1/4
  1221. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  1222. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  1223. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: blockmeta: detected storage config, using mode=custom
  1224. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  1225. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  1226. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  1227. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  1228. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  1229. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  1230. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED BLOCK_META: 0.398
  1231. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  1232. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Traceback (most recent call last):
  1233. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/main.py", line 202, in main
  1234. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ret = args.func(args)
  1235. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^
  1236. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 97, in wrapper
  1237. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  1238. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  1239. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 79, in log_time
  1240. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return func(*args, **kwargs)
  1241. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^
  1242. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  1243. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return meta_custom(args)
  1244. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^
  1245. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  1246. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: handler(command, storage_config_dict, context)
  1247. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  1248. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk_handler_v1(info, storage_config, context)
  1249. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  1250. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  1251. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  1252. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  1253. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: volume_path = v2_get_path_to_disk(vol)
  1254. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^
  1255. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  1256. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: link2dev[dev['DEVNAME']] = dev
  1257. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ~~~^^^^^^^^^^^
  1258. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: KeyError: 'DEVNAME'
  1259. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 'DEVNAME'
  1260. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1261. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Stderr: ''
  1262. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Unexpected error while running command.
  1263. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Command: ['curtin', 'block-meta', 'simple']
  1264. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Exit code: 3
  1265. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Reason: -
  1266. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Stdout: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: curtin command block-meta
  1267. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_path_to_storage_volume for volume partition-0({'device': 'disk-nvme2n1', 'size': 490442063872, 'wipe': 'superblock', 'number': 3, 'preserve': False, 'offset': 5368709120, 'id': 'partition-0', 'type': 'partition'})
  1268. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  1269. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Processing serial eui.000000000000000100a075244ad53e17 via udev to eui.000000000000000100a075244ad53e17
  1270. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: lookup_disks found: ['nvme-eui.000000000000000100a075244ad53e17', 'nvme-eui.000000000000000100a075244ad53e17-part3', 'nvme-eui.000000000000000100a075244ad53e17-part2', 'nvme-eui.000000000000000100a075244ad53e17-part1', 'nvme-eui.000000000000000100a075244ad53e17-part4']
  1271. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  1272. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device? False
  1273. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'info', '--query=property', '--export', '/dev/nvme2n1'] with allowed return codes [0] (capture=True)
  1274. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1 is multipath device member? False
  1275. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: block.lookup_disk() returning path /dev/nvme2n1
  1276. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  1277. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1278. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.032
  1279. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  1280. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1
  1281. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['partprobe', '/dev/nvme2n1'] with allowed return codes [0, 1] (capture=False)
  1282. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1283. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.023
  1284. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devsync happy - path /dev/nvme2n1 now exists
  1285. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return volume path /dev/nvme2n1p3
  1286. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: block-meta: extracted devices to clear: ['/dev/nvme2n1p3']
  1287. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Declared block devices: ['/dev/nvme2n1p3']
  1288. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: clearing devices=['/dev/nvme2n1p3']
  1289. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: removing previous storage devices
  1290. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--assemble', '--scan', '-v'] with allowed return codes [0, 1, 2] (capture=True)
  1291. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm assemble scan results:
  1292. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1293. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: looking for devices for further assembly
  1294. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop17
  1295. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop16
  1296. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop14
  1297. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop15
  1298. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop13
  1299. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop12
  1300. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop10
  1301. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop11
  1302. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop9
  1303. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop8
  1304. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda1
  1305. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/sda
  1306. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p4
  1307. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme2n1p3
  1308. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p2
  1309. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1p1
  1310. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme2n1
  1311. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p4
  1312. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p3
  1313. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme0n1p2
  1314. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1p1
  1315. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme0n1
  1316. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1p2
  1317. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/nvme1n1p1
  1318. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: Cannot assemble mbr metadata on /dev/nvme1n1
  1319. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop7
  1320. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop6
  1321. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop5
  1322. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop4
  1323. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop3
  1324. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop2
  1325. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop1
  1326. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: no recogniseable superblock on /dev/loop0
  1327. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm: No arrays found in config file or automatically
  1328. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1329. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['mdadm', '--detail', '--scan', '-v'] with allowed return codes [0, 1] (capture=True)
  1330. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: mdadm detail scan after assemble:
  1331. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1332. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1333. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1334. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.002
  1335. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['pvscan'] with allowed return codes [0] (capture=True)
  1336. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgscan'] with allowed return codes [0] (capture=True)
  1337. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['vgchange', '--activate=y'] with allowed return codes [0] (capture=True)
  1338. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['udevadm', 'settle'] with allowed return codes [0] (capture=False)
  1339. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED udevadm_settle(): 0.006
  1340. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Loading kernel module bcache via modprobe
  1341. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['modprobe', '--use-blacklist', 'bcache'] with allowed return codes [0] (capture=False)
  1342. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Generating device storage trees for path(s): ['/dev/nvme2n1p3']
  1343. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  1344. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Current device storage tree:
  1345. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: nvme2n1p3
  1346. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Shutdown Plan:
  1347. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {'level': 0, 'device': '/sys/class/block/nvme2n1p3', 'dev_type': 'partition'}
  1348. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: shutdown running on holder type: 'partition' syspath: '/sys/class/block/nvme2n1p3'
  1349. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  1350. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: info:
  1351. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: {
  1352. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1": {
  1353. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1354. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1355. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1356. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1357. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1358. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "",
  1359. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1360. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1",
  1361. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1362. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1363. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:9",
  1364. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1365. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1366. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "CT500P310SSD8",
  1367. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1368. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1",
  1369. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1370. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1371. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1372. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1373. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1374. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1375. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1376. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "500107862016",
  1377. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "live",
  1378. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "disk",
  1379. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "",
  1380. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1"
  1381. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1382. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p1": {
  1383. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1384. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1385. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1386. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1387. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1388. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  1389. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1390. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p1",
  1391. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1392. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1393. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:10",
  1394. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1395. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1396. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1397. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1398. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p1",
  1399. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1400. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1401. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1402. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1403. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1404. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1405. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1406. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "1071644160",
  1407. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1408. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1409. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DAD5",
  1410. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p1"
  1411. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1412. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p2": {
  1413. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1414. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1415. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1416. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1417. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1418. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "vfat",
  1419. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1420. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p2",
  1421. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1422. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1423. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:11",
  1424. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1425. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1426. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1427. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1428. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p2",
  1429. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1430. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1431. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1432. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1433. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1434. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1435. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1436. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  1437. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1438. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1439. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "D209-DA70",
  1440. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p2"
  1441. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1442. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p3": {
  1443. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1444. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1445. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1446. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1447. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1448. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "ext4",
  1449. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1450. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p3",
  1451. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1452. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1453. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:12",
  1454. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1455. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1456. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1457. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1458. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p3",
  1459. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1460. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1461. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1462. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1463. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1464. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1465. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1466. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "490442087936",
  1467. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1468. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1469. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "e7c0a7e4-d81a-40a4-8467-a2e969c9d6a1",
  1470. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p3"
  1471. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: },
  1472. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "nvme2n1p4": {
  1473. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ALIGNMENT": "0",
  1474. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ALN": "0",
  1475. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-GRAN": "512",
  1476. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-MAX": "2199023255040",
  1477. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "DISC-ZERO": "0",
  1478. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "FSTYPE": "swap",
  1479. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "GROUP": "disk",
  1480. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "KNAME": "nvme2n1p4",
  1481. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LABEL": "",
  1482. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "LOG-SEC": "512",
  1483. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MAJ:MIN": "259:13",
  1484. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MIN-IO": "4096",
  1485. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODE": "brw-rw----",
  1486. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MODEL": "",
  1487. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "MOUNTPOINT": "",
  1488. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "NAME": "nvme2n1p4",
  1489. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OPT-IO": "4096",
  1490. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "OWNER": "root",
  1491. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "PHY-SEC": "512",
  1492. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RM": "0",
  1493. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RO": "0",
  1494. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "ROTA": "0",
  1495. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "RQ-SIZE": "1023",
  1496. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "SIZE": "4294966784",
  1497. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "STATE": "",
  1498. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "TYPE": "part",
  1499. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "UUID": "f7c2eec1-4eb2-404e-8404-efb0cb4f8d65",
  1500. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: "device_path": "/dev/nvme2n1p4"
  1501. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  1502. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: }
  1503. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: get_blockdev_sector_size: (log=512, phys=512)
  1504. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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)
  1505. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Checking if /dev/nvme2n1p3 is a swap device
  1506. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Found swap magic: b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00'
  1507. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping superblock on /dev/nvme2n1p3
  1508. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping /dev/nvme2n1p3 attempt 1/4
  1509. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Running command ['wipefs', '--all', '--force', '/dev/nvme2n1p3'] with allowed return codes [0] (capture=False)
  1510. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: /dev/nvme2n1p3: 2 bytes were erased at offset 0x00000438 (ext4): 53 ef
  1511. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: wiping 1M on /dev/nvme2n1p3 at offsets [0, -1048576]
  1512. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: successfully wiped device /dev/nvme2n1p3 on attempt 1/4
  1513. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: devname '/sys/class/block/nvme2n1p3' had holders: []
  1514. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta/clear-holders: SUCCESS: removing previous storage devices
  1515. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: blockmeta: detected storage config, using mode=custom
  1516. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring nvme_controller: nvme-controller-nvme2
  1517. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: SUCCESS: configuring nvme_controller: nvme-controller-nvme2
  1518. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: start: cmd-install/stage-partitioning/builtin/cmd-block-meta: configuring disk: disk-nvme2n1
  1519. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 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', 'preserve': True, 'name': '', 'grub_device': False, 'id': 'disk-nvme2n1', 'type': 'disk'})
  1520. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: An error occured handling 'disk-nvme2n1': KeyError - 'DEVNAME'
  1521. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: configuring disk: disk-nvme2n1
  1522. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: TIMED BLOCK_META: 0.398
  1523. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: finish: cmd-install/stage-partitioning/builtin/cmd-block-meta: FAIL: curtin command block-meta
  1524. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Traceback (most recent call last):
  1525. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/main.py", line 202, in main
  1526. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ret = args.func(args)
  1527. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^
  1528. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 97, in wrapper
  1529. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return log_time("TIMED %s: " % msg, func, *args, **kwargs)
  1530. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  1531. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/log.py", line 79, in log_time
  1532. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return func(*args, **kwargs)
  1533. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^
  1534. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 128, in block_meta
  1535. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: return meta_custom(args)
  1536. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^
  1537. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 2284, in meta_custom
  1538. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: handler(command, storage_config_dict, context)
  1539. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta_v2.py", line 446, in disk_handler_v2
  1540. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk_handler_v1(info, storage_config, context)
  1541. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 771, in disk_handler
  1542. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: disk = get_path_to_storage_volume(info.get('id'), storage_config)
  1543. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
  1544. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 596, in get_path_to_storage_volume
  1545. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: volume_path = v2_get_path_to_disk(vol)
  1546. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ^^^^^^^^^^^^^^^^^^^^^^^^
  1547. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: File "/snap/ubuntu-desktop-bootstrap/366/lib/python3.12/site-packages/curtin/commands/block_meta.py", line 501, in v2_get_path_to_disk
  1548. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: link2dev[dev['DEVNAME']] = dev
  1549. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: ~~~^^^^^^^^^^^
  1550. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: KeyError: 'DEVNAME'
  1551. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: 'DEVNAME'
  1552. May 06 13:55:33 ubuntu subiquity_log.4692[8679]:
  1553. May 06 13:55:33 ubuntu subiquity_log.4692[8679]: Stderr: ''
  1554. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: executing curtin install partitioning step
  1555. May 06 13:55:33 ubuntu subiquity_event.4692[4692]: installing system
  1556. May 06 13:55:33 ubuntu subiquity_event.4692[4692]:
  1557. May 06 13:55:34 ubuntu subiquity_event.4692[4692]: 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!