2023-02-23 15:19:22,887 INFO subiquity:161 Starting Subiquity server revision 4380 2023-02-23 15:19:22,887 INFO subiquity:162 Arguments passed: ['/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/cmd/server.py'] 2023-02-23 15:19:23,705 INFO aiohttp.access:233 [23/Feb/2023:15:19:23 +0000] "GET /meta/status?cur=null HTTP/1.1" 200 420 "-" "Python/3.8 aiohttp/3.6.2" 2023-02-23 15:19:24,019 INFO root:37 start: subiquity/core_validation: 2023-02-23 15:19:24,020 INFO root:37 finish: subiquity/core_validation: SUCCESS: 2023-02-23 15:19:24,283 INFO root:37 start: subiquity/apply_autoinstall_config: 2023-02-23 15:19:24,286 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr... 2023-02-23 15:19:25,292 INFO aiohttp.access:233 [23/Feb/2023:15:19:23 +0000] "GET /meta/status?cur=%22CLOUD_INIT_WAIT%22 HTTP/1.1" 200 413 "-" "Python/3.8 aiohttp/3.6.2" 2023-02-23 15:19:25,302 ERROR root:37 finish: subiquity/Refresh/check_for_update: FAIL: cancelled 2023-02-23 15:19:25,304 ERROR root:37 finish: subiquity/Refresh/check_for_update: FAIL: cancelled 2023-02-23 15:19:25,305 ERROR root:37 finish: subiquity/Refresh/check_for_update: FAIL: cancelled 2023-02-23 15:19:25,306 INFO root:37 start: subiquity/Meta/status_GET: 2023-02-23 15:19:25,676 ERROR probert.filesystems:46 Command '['/usr/sbin/resize2fs', '-P', '/dev/sda2']' returned non-zero exit status 1. Traceback (most recent call last): File "/snap/subiquity/4380/lib/python3.8/site-packages/probert/filesystem.py", line 41, in run return subprocess.check_output(cmdarr, universal_newlines=True, File "/snap/subiquity/4380/usr/lib/python3.8/subprocess.py", line 415, in check_output return run(*popenargs, stdout=PIPE, timeout=timeout, check=True, File "/snap/subiquity/4380/usr/lib/python3.8/subprocess.py", line 516, in run raise CalledProcessError(retcode, process.args, subprocess.CalledProcessError: Command '['/usr/sbin/resize2fs', '-P', '/dev/sda2']' returned non-zero exit status 1. 2023-02-23 15:19:26,085 INFO curtin:1329 Validating extracted storage config components 2023-02-23 15:19:34,302 INFO root:37 start: subiquity/Network/apply_autoinstall_config/apply_config: silent=False 2023-02-23 15:19:44,952 INFO root:37 finish: subiquity/Network/apply_autoinstall_config/apply_config: SUCCESS: silent=False 2023-02-23 15:19:44,969 INFO subiquity.server.controllers.filesystem:622 autoinstall: running guided direct install in mode reformat_disk using GuidedStorageTargetReformat(disk_id='disk-sda') 2023-02-23 15:19:44,994 INFO root:37 finish: subiquity/apply_autoinstall_config: SUCCESS: 2023-02-23 15:19:44,997 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "NEEDS_CONFIRMATION", "confirming_tty": "", "error": null, "cloud_i... 2023-02-23 15:19:44,998 INFO aiohttp.access:233 [23/Feb/2023:15:19:25 +0000] "GET /meta/status?cur=%22WAITING%22 HTTP/1.1" 200 424 "-" "Python/3.8 aiohttp/3.6.2" 2023-02-23 15:19:44,999 INFO root:37 start: subiquity/Install/install/configure_apt: configuring apt 2023-02-23 15:19:45,015 INFO root:37 start: subiquity/Meta/status_GET: 2023-02-23 15:19:45,016 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "RUNNING", "confirming_tty": "", "error": null, "cloud_init_ok": tr... 2023-02-23 15:19:45,017 INFO aiohttp.access:233 [23/Feb/2023:15:19:45 +0000] "GET /meta/status?cur=%22NEEDS_CONFIRMATION%22 HTTP/1.1" 200 413 "-" "Python/3.8 aiohttp/3.6.2" 2023-02-23 15:19:45,018 INFO root:37 start: subiquity/Meta/status_GET: 2023-02-23 15:19:59,988 INFO root:37 finish: subiquity/Install/install/configure_apt: SUCCESS: configuring apt 2023-02-23 15:19:59,990 INFO root:37 start: subiquity/Install/install/curtin_install: installing system 2023-02-23 15:20:35,636 ERROR root:37 finish: subiquity/Install/install/curtin_install/run_curtin_install_step/cmd-install/stage-curthooks/002-setupcon-save-only/cmd-in-target: FAIL: curtin command in-target 2023-02-23 15:20:35,636 ERROR root:37 finish: subiquity/Install/install/curtin_install/run_curtin_install_step/cmd-install/stage-curthooks/002-setupcon-save-only: FAIL: running 'curtin in-target -- setupcon --save-only' 2023-02-23 15:20:35,637 ERROR root:37 finish: subiquity/Install/install/curtin_install/run_curtin_install_step/cmd-install/stage-curthooks: FAIL: configuring installed system 2023-02-23 15:20:36,316 ERROR root:37 finish: subiquity/Install/install/curtin_install/run_curtin_install_step: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.2720', '--setenv', 'PATH=/snap/subiquity/4380/bin:/snap/subiquity/4380/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/snap/subiquity/4380/bin:/snap/subiquity/4380/sbin', '--setenv', 'PYTHONPATH=:/snap/subiquity/4380/lib/python3.8/site-packages', '--setenv', 'PYTHON=/snap/subiquity/4380/usr/bin/python3.8', '--setenv', 'SNAP=/snap/subiquity/4380', '--', '/snap/subiquity/4380/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2720.7"}}', '-c', '/var/log/installer/curtin-install/subiquity-curthooks.conf', 'install', 'cp:///tmp/tmp1ordx03c/mount', '--set', 'json:stages=["curthooks"]']' returned non-zero exit status 3. 2023-02-23 15:20:36,316 ERROR root:37 finish: subiquity/Install/install/curtin_install: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.2720', '--setenv', 'PATH=/snap/subiquity/4380/bin:/snap/subiquity/4380/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/snap/subiquity/4380/bin:/snap/subiquity/4380/sbin', '--setenv', 'PYTHONPATH=:/snap/subiquity/4380/lib/python3.8/site-packages', '--setenv', 'PYTHON=/snap/subiquity/4380/usr/bin/python3.8', '--setenv', 'SNAP=/snap/subiquity/4380', '--', '/snap/subiquity/4380/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2720.7"}}', '-c', '/var/log/installer/curtin-install/subiquity-curthooks.conf', 'install', 'cp:///tmp/tmp1ordx03c/mount', '--set', 'json:stages=["curthooks"]']' returned non-zero exit status 3. 2023-02-23 15:20:36,320 INFO subiquity.common.errorreport:406 saving crash report 'install failed crashed with CalledProcessError' to /var/crash/1677165636.317376614.install_fail.crash 2023-02-23 15:20:36,321 ERROR root:37 finish: subiquity/Install/install: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.2720', '--setenv', 'PATH=/snap/subiquity/4380/bin:/snap/subiquity/4380/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/snap/subiquity/4380/bin:/snap/subiquity/4380/sbin', '--setenv', 'PYTHONPATH=:/snap/subiquity/4380/lib/python3.8/site-packages', '--setenv', 'PYTHON=/snap/subiquity/4380/usr/bin/python3.8', '--setenv', 'SNAP=/snap/subiquity/4380', '--', '/snap/subiquity/4380/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2720.7"}}', '-c', '/var/log/installer/curtin-install/subiquity-curthooks.conf', 'install', 'cp:///tmp/tmp1ordx03c/mount', '--set', 'json:stages=["curthooks"]']' returned non-zero exit status 3. 2023-02-23 15:20:36,321 INFO root:37 start: subiquity/ErrorReporter/1677165636.317376614.install_fail/add_info: 2023-02-23 15:20:36,321 ERROR subiquity.server.server:424 top level error Traceback (most recent call last): File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/controllers/cmdlist.py", line 139, in _run await Install.install_task File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 281, in install await self.curtin_install( File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 249, in curtin_install await self.run_curtin_install_step( File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquitycore/context.py", line 148, in decorated_async return await meth(self, **kw) File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/controllers/install.py", line 187, in run_curtin_install_step return await run_curtin_command( File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/curtin.py", line 203, in run_curtin_command return await cmd.wait() File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/curtin.py", line 116, in wait result = await self.runner.wait(self.proc) File "/snap/subiquity/4380/lib/python3.8/site-packages/subiquity/server/runner.py", line 84, in wait raise subprocess.CalledProcessError(proc.returncode, proc.args) subprocess.CalledProcessError: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.2720', '--setenv', 'PATH=/snap/subiquity/4380/bin:/snap/subiquity/4380/usr/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/snap/subiquity/4380/bin:/snap/subiquity/4380/sbin', '--setenv', 'PYTHONPATH=:/snap/subiquity/4380/lib/python3.8/site-packages', '--setenv', 'PYTHON=/snap/subiquity/4380/usr/bin/python3.8', '--setenv', 'SNAP=/snap/subiquity/4380', '--', '/snap/subiquity/4380/usr/bin/python3.8', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2720.7"}}', '-c', '/var/log/installer/curtin-install/subiquity-curthooks.conf', 'install', 'cp:///tmp/tmp1ordx03c/mount', '--set', 'json:stages=["curthooks"]']' returned non-zero exit status 3.