2023-10-11 03:36:18,847 INFO subiquity:199 Starting Subiquity server revision 1257 of snap /snap/ubuntu-desktop-installer/1257
2023-10-11 03:36:18,848 INFO subiquity:200 Arguments passed: ['/snap/ubuntu-desktop-installer/1257/bin/subiquity/subiquity/cmd/server.py', '--use-os-prober', '--storage-version=2', '--postinst-hooks-dir=/snap/ubuntu-desktop-installer/1257/etc/subiquity/postinst.d']
2023-10-11 03:36:42,139 INFO root:30 start: subiquity/apply_autoinstall_config: 
2023-10-11 03:36:42,162 INFO root:30 finish: subiquity/apply_autoinstall_config: SUCCESS: 
2023-10-11 03:36:42,349 ERROR root:30 finish: subiquity/Refresh/check_for_update: FAIL: cancelled
2023-10-11 03:36:42,372 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:36:42,372 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-10-11 03:36:42,377 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:36:42,378 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-10-11 03:36:42,378 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:36:42,378 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-10-11 03:36:42,378 INFO root:30 start: subiquity/Meta/client_variant_POST: 
2023-10-11 03:36:42,378 INFO root:30 finish: subiquity/Meta/client_variant_POST: SUCCESS: 200 null
2023-10-11 03:36:42,379 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:36:42,380 INFO root:30 start: subiquity/Meta/interactive_sections_GET: 
2023-10-11 03:36:42,380 INFO root:30 finish: subiquity/Meta/interactive_sections_GET: SUCCESS: 200 null
2023-10-11 03:36:42,380 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:36:42,382 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-10-11 03:36:42,383 INFO root:30 start: subiquity/Meta/mark_configured_POST: 
2023-10-11 03:36:42,384 INFO root:30 finish: subiquity/Meta/mark_configured_POST: SUCCESS: 200 null
2023-10-11 03:36:42,655 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'maps', 'raw', 'format', '%w,%d,%N']
2023-10-11 03:36:42,657 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'paths', 'raw', 'format', '%d,%z,%m,%N,%n,%R,%r,%a']
2023-10-11 03:36:44,927 INFO curtin:1351 Validating extracted storage config components
2023-10-11 03:38:03,453 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'maps', 'raw', 'format', '%w,%d,%N']
2023-10-11 03:38:03,455 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'paths', 'raw', 'format', '%d,%z,%m,%N,%n,%R,%r,%a']
2023-10-11 03:38:04,197 INFO curtin:1351 Validating extracted storage config components
2023-10-11 03:38:05,817 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'maps', 'raw', 'format', '%w,%d,%N']
2023-10-11 03:38:05,818 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'paths', 'raw', 'format', '%d,%z,%m,%N,%n,%R,%r,%a']
2023-10-11 03:38:06,204 INFO curtin:1351 Validating extracted storage config components
2023-10-11 03:38:12,748 INFO curtin:1351 Validating extracted storage config components
2023-10-11 03:38:14,945 INFO root:30 start: subiquity/Meta/mark_configured_POST: 
2023-10-11 03:38:14,946 INFO root:30 finish: subiquity/Meta/mark_configured_POST: SUCCESS: 200 null
2023-10-11 03:38:14,948 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "NEEDS_CONFIRMATION", "confirming_tty": "", "error": null, "cloud_i...
2023-10-11 03:38:14,949 INFO root:30 start: subiquity/Meta/confirm_POST: 
2023-10-11 03:38:14,949 INFO root:30 finish: subiquity/Meta/confirm_POST: SUCCESS: 200 null
2023-10-11 03:38:14,950 INFO root:30 start: subiquity/Install/install/configure_apt: configuring apt
2023-10-11 03:38:14,987 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:38:14,987 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "RUNNING", "confirming_tty": "/dev/tty1", "error": null, "cloud_ini...
2023-10-11 03:38:14,991 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:38:39,030 INFO root:30 start: subiquity/Meta/mark_configured_POST: 
2023-10-11 03:38:39,031 INFO root:30 finish: subiquity/Meta/mark_configured_POST: SUCCESS: 200 null
2023-10-11 03:38:41,107 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:38:41,107 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "RUNNING", "confirming_tty": "/dev/tty1", "error": null, "cloud_ini...
2023-10-11 03:38:41,378 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:38:41,378 INFO root:30 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "RUNNING", "confirming_tty": "/dev/tty1", "error": null, "cloud_ini...
2023-10-11 03:38:41,411 INFO root:30 start: subiquity/Meta/status_GET: 
2023-10-11 03:38:46,230 ERROR root:30 finish: subiquity/Install/install/configure_apt: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.2060', '--property', 'PrivateMounts=yes', '--setenv', 'PATH=/snap/ubuntu-desktop-installer/1257/bin/subiquity/bin:/snap/ubuntu-desktop-installer/1257/bin/subiquity/usr/bin:/snap/ubuntu-desktop-installer/1257/bin:/snap/ubuntu-desktop-installer/1257/sbin:/snap/ubuntu-desktop-installer/1257/usr/sbin:/snap/ubuntu-desktop-installer/1257/usr/bin:/snap/ubuntu-desktop-installer/1257/sbin:/snap/ubuntu-desktop-installer/1257/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin', '--setenv', 'PYTHONPATH=/snap/ubuntu-desktop-installer/1257/lib/python3.10/site-packages:/snap/ubuntu-desktop-installer/1257/usr/lib/python3/dist-packages:/snap/ubuntu-desktop-installer/1257/usr/lib/python3/site-packages:', '--setenv', 'PYTHON=/snap/ubuntu-desktop-installer/1257/usr/bin/python3.10', '--setenv', 'SNAP=/snap/ubuntu-desktop-installer/1257', '--', '/snap/ubuntu-desktop-installer/1257/usr/bin/python3.10', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2060.3"}}', 'in-target', '-t', '/tmp/tmp71369fw6/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.
2023-10-11 03:38:46,267 INFO subiquity.common.errorreport:415 saving crash report 'install failed crashed with CalledProcessError' to /var/crash/1696995526.230397224.install_fail.crash
2023-10-11 03:38:46,268 ERROR root:30 finish: subiquity/Install/install: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.2060', '--property', 'PrivateMounts=yes', '--setenv', 'PATH=/snap/ubuntu-desktop-installer/1257/bin/subiquity/bin:/snap/ubuntu-desktop-installer/1257/bin/subiquity/usr/bin:/snap/ubuntu-desktop-installer/1257/bin:/snap/ubuntu-desktop-installer/1257/sbin:/snap/ubuntu-desktop-installer/1257/usr/sbin:/snap/ubuntu-desktop-installer/1257/usr/bin:/snap/ubuntu-desktop-installer/1257/sbin:/snap/ubuntu-desktop-installer/1257/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin', '--setenv', 'PYTHONPATH=/snap/ubuntu-desktop-installer/1257/lib/python3.10/site-packages:/snap/ubuntu-desktop-installer/1257/usr/lib/python3/dist-packages:/snap/ubuntu-desktop-installer/1257/usr/lib/python3/site-packages:', '--setenv', 'PYTHON=/snap/ubuntu-desktop-installer/1257/usr/bin/python3.10', '--setenv', 'SNAP=/snap/ubuntu-desktop-installer/1257', '--', '/snap/ubuntu-desktop-installer/1257/usr/bin/python3.10', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.2060.3"}}', 'in-target', '-t', '/tmp/tmp71369fw6/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.
2023-10-11 03:38:46,268 INFO root:30 start: subiquity/ErrorReporter/1696995526.230397224.install_fail/add_info: