2020-11-23 15:08:21,170 INFO subiquity:135 Starting Subiquity revision 1966 2020-11-23 15:08:21,170 INFO subiquity:136 Arguments passed: ['/snap/subiquity/1966/usr/bin/subiquity'] 2020-11-23 15:08:22,379 INFO root:39 start: subiquity/core_validation: 2020-11-23 15:08:22,380 INFO root:39 finish: subiquity/core_validation: SUCCESS: 2020-11-23 15:08:22,574 INFO root:39 finish: subiquity/Reporting: SUCCESS: completed 2020-11-23 15:08:22,578 INFO root:39 finish: subiquity/Error: SUCCESS: completed 2020-11-23 15:08:22,579 INFO root:39 finish: subiquity/Early: SUCCESS: completed 2020-11-23 15:08:22,580 INFO root:39 finish: subiquity/Userdata: SUCCESS: completed 2020-11-23 15:08:22,582 INFO root:39 finish: subiquity/Package: SUCCESS: completed 2020-11-23 15:08:22,582 INFO root:39 finish: subiquity/Debconf: SUCCESS: completed 2020-11-23 15:08:22,599 INFO root:39 finish: subiquity/Welcome: SUCCESS: completed 2020-11-23 15:08:22,600 INFO root:39 finish: subiquity/Refresh: SUCCESS: completed 2020-11-23 15:08:22,601 INFO root:39 finish: subiquity/Keyboard: SUCCESS: completed 2020-11-23 15:08:22,828 INFO probert.lvm:120 b' 1 logical volume(s) in volume group "ubuntu-vg" now active\n' 2020-11-23 15:08:23,076 INFO curtin:1324 Validating extracted storage config components 2020-11-23 15:08:32,562 INFO root:39 start: subiquity/Network/apply_autoinstall_config/apply_config: silent=False 2020-11-23 15:08:43,339 INFO root:39 finish: subiquity/Network/apply_autoinstall_config/apply_config: SUCCESS: silent=False 2020-11-23 15:08:43,343 INFO root:39 finish: subiquity/Network: SUCCESS: completed 2020-11-23 15:08:43,345 INFO root:39 finish: subiquity/Proxy: SUCCESS: completed 2020-11-23 15:08:43,348 INFO root:39 finish: subiquity/Mirror: SUCCESS: completed 2020-11-23 15:08:43,350 INFO root:39 finish: subiquity/Refresh: SUCCESS: completed 2020-11-23 15:08:43,358 INFO root:39 finish: subiquity/Filesystem: SUCCESS: completed 2020-11-23 15:08:43,360 INFO root:39 finish: subiquity/Identity: SUCCESS: completed 2020-11-23 15:08:43,362 INFO root:39 finish: subiquity/SSH: SUCCESS: completed 2020-11-23 15:08:43,379 INFO root:39 finish: subiquity/SnapList: SUCCESS: completed 2020-11-23 15:08:46,371 INFO root:39 start: subiquity/InstallProgress/install/curtin_install: installing system 2020-11-23 15:10:07,224 ERROR root:39 finish: subiquity/InstallProgress/install/curtin_install: FAIL: Command '['systemd-cat', '--level-prefix=false', '--identifier=curtin_log.5282', '/snap/subiquity/1966/usr/bin/python3', '-m', 'curtin', '--showtrace', '-c', '/var/log/installer/subiquity-curtin-install.conf', 'install']' returned non-zero exit status 3. 2020-11-23 15:10:07,224 ERROR subiquitycore.controller.installprogress:145 curtin_error Traceback (most recent call last): File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquity/controllers/installprogress.py", line 304, in install await self.curtin_install(context=context) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/context.py", line 142, in decorated_async return await meth(self, **kw) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquity/controllers/installprogress.py", line 281, in curtin_install self.logged_command(curtin_cmd), check=True) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/utils.py", line 85, in arun_command raise subprocess.CalledProcessError(proc.returncode, cmd) subprocess.CalledProcessError: Command '['systemd-cat', '--level-prefix=false', '--identifier=curtin_log.5282', '/snap/subiquity/1966/usr/bin/python3', '-m', 'curtin', '--showtrace', '-c', '/var/log/installer/subiquity-curtin-install.conf', 'install']' returned non-zero exit status 3. 2020-11-23 15:10:07,228 INFO subiquity.core:487 saving crash report 'install failed crashed with CalledProcessError' to /var/crash/1606144207.227556705.install_fail.crash 2020-11-23 15:10:07,231 ERROR root:39 finish: subiquity/InstallProgress/install: FAIL: Command '['systemd-cat', '--level-prefix=false', '--identifier=curtin_log.5282', '/snap/subiquity/1966/usr/bin/python3', '-m', 'curtin', '--showtrace', '-c', '/var/log/installer/subiquity-curtin-install.conf', 'install']' returned non-zero exit status 3. 2020-11-23 15:10:07,242 ERROR root:39 finish: subiquity/InstallProgress/apply_autoinstall_config: FAIL: Command '['systemd-cat', '--level-prefix=false', '--identifier=curtin_log.5282', '/snap/subiquity/1966/usr/bin/python3', '-m', 'curtin', '--showtrace', '-c', '/var/log/installer/subiquity-curtin-install.conf', 'install']' returned non-zero exit status 3. 2020-11-23 15:10:07,292 ERROR subiquitycore.core:678 Exception in controller.run(): Traceback (most recent call last): File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/core.py", line 676, in run self.urwid_loop.run() File "/snap/subiquity/1966/usr/lib/python3/dist-packages/urwid/main_loop.py", line 286, in run self._run() File "/snap/subiquity/1966/usr/lib/python3/dist-packages/urwid/main_loop.py", line 384, in _run self.event_loop.run() File "/snap/subiquity/1966/usr/lib/python3/dist-packages/urwid/main_loop.py", line 1484, in run reraise(*exc_info) File "/snap/subiquity/1966/usr/lib/python3/dist-packages/urwid/compat.py", line 57, in reraise raise value.with_traceback(tb) File "/snap/subiquity/1966/usr/lib/python3.6/asyncio/events.py", line 145, in _run self._callback(*self._args) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/async_helpers.py", line 26, in _done fut.result() File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquity/controllers/installprogress.py", line 328, in move_on await self.install_task File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/context.py", line 142, in decorated_async return await meth(self, **kw) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquity/controllers/installprogress.py", line 304, in install await self.curtin_install(context=context) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/context.py", line 142, in decorated_async return await meth(self, **kw) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquity/controllers/installprogress.py", line 281, in curtin_install self.logged_command(curtin_cmd), check=True) File "/snap/subiquity/1966/lib/python3.6/site-packages/subiquitycore/utils.py", line 85, in arun_command raise subprocess.CalledProcessError(proc.returncode, cmd) subprocess.CalledProcessError: Command '['systemd-cat', '--level-prefix=false', '--identifier=curtin_log.5282', '/snap/subiquity/1966/usr/bin/python3', '-m', 'curtin', '--showtrace', '-c', '/var/log/installer/subiquity-curtin-install.conf', 'install']' returned non-zero exit status 3. 2020-11-23 15:10:07,297 INFO subiquity.core:487 saving crash report 'Installer UI crashed with CalledProcessError' to /var/crash/1606144207.294909954.ui.crash