2023-06-23 07:39:08,567 INFO subiquity:163 Starting Subiquity server revision 1099 of snap /snap/ubuntu-desktop-installer/1099
2023-06-23 07:39:08,567 INFO subiquity:164 Arguments passed: ['/snap/ubuntu-desktop-installer/1099/bin/subiquity/subiquity/cmd/server.py', '--use-os-prober', '--storage-version=2', '--postinst-hooks-dir=/snap/ubuntu-desktop-installer/1099/etc/subiquity/postinst.d']
2023-06-23 07:39:09,040 INFO aiohttp.access:206  [23/Jun/2023:07:39:09 +0000] "GET /meta/status HTTP/1.1" 200 420 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,025 INFO root:37 start: subiquity/apply_autoinstall_config: 
2023-06-23 07:39:10,037 INFO root:37 finish: subiquity/apply_autoinstall_config: SUCCESS: 
2023-06-23 07:39:10,193 ERROR root:37 finish: subiquity/Refresh/check_for_update: FAIL: cancelled
2023-06-23 07:39:10,195 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:10,196 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-06-23 07:39:10,196 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /meta/status HTTP/1.1" 200 412 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,211 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:10,212 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-06-23 07:39:10,212 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /meta/status HTTP/1.1" 200 412 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,212 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:10,212 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-06-23 07:39:10,212 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /meta/status HTTP/1.1" 200 412 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,212 INFO root:37 start: subiquity/Meta/client_variant_POST: 
2023-06-23 07:39:10,212 INFO root:37 finish: subiquity/Meta/client_variant_POST: SUCCESS: 200 null
2023-06-23 07:39:10,212 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "POST /meta/client_variant?variant=%22desktop%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,228 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:10,229 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /locale HTTP/1.1" 200 195 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,229 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:10,229 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "WAITING", "confirming_tty": "", "error": null, "cloud_init_ok": tr...
2023-06-23 07:39:10,229 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /meta/status HTTP/1.1" 200 412 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,239 ERROR probert.raid:40 Failed mdadm_assemble, mdadm command not found: [Errno 2] No such file or directory: 'mdadm'
2023-06-23 07:39:10,251 INFO root:37 start: subiquity/Meta/mark_configured_POST: 
2023-06-23 07:39:10,251 INFO root:37 finish: subiquity/Meta/mark_configured_POST: SUCCESS: 200 null
2023-06-23 07:39:10,251 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "POST /meta/mark_configured?endpoint_names=%5B%22mirror%22%2C%22proxy%22%2C%22ssh%22%2C%22snaplist%22%2C%22ubuntu_pro%22%5D HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:10,274 INFO root:37 start: subiquity/Meta/interactive_sections_GET: 
2023-06-23 07:39:10,274 INFO root:37 finish: subiquity/Meta/interactive_sections_GET: SUCCESS: 200 null
2023-06-23 07:39:10,275 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /meta/interactive_sections HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:12,060 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'maps', 'raw', 'format', '%w,%d,%N']
2023-06-23 07:39:12,064 ERROR probert.multipath:38 Failed to run cmd: ['multipathd', 'show', 'paths', 'raw', 'format', '%d,%z,%m,%N,%n,%R,%r,%a']
2023-06-23 07:39:12,927 INFO curtin:1342 Validating extracted storage config components
2023-06-23 07:39:17,679 INFO aiohttp.access:206  [23/Jun/2023:07:39:17 +0000] "POST /locale HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:22,301 INFO aiohttp.access:206  [23/Jun/2023:07:39:22 +0000] "GET /storage/has_rst HTTP/1.1" 200 191 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:22,309 INFO aiohttp.access:206  [23/Jun/2023:07:39:22 +0000] "GET /keyboard HTTP/1.1" 200 41538 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:22,313 INFO aiohttp.access:206  [23/Jun/2023:07:39:22 +0000] "GET /keyboard HTTP/1.1" 200 41538 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:22,422 INFO aiohttp.access:206  [23/Jun/2023:07:39:22 +0000] "POST /keyboard/input_source?user=%22ubuntu%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:27,639 INFO aiohttp.access:206  [23/Jun/2023:07:39:27 +0000] "POST /keyboard/input_source?user=%22ubuntu%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:29,309 INFO aiohttp.access:206  [23/Jun/2023:07:39:28 +0000] "POST /keyboard HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:30,741 INFO root:37 start: subiquity/Meta/mark_configured_POST: 
2023-06-23 07:39:30,742 INFO root:37 finish: subiquity/Meta/mark_configured_POST: SUCCESS: 200 null
2023-06-23 07:39:30,743 INFO aiohttp.access:206  [23/Jun/2023:07:39:30 +0000] "POST /meta/mark_configured?endpoint_names=%5B%22network%22%5D HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:30,750 INFO aiohttp.access:206  [23/Jun/2023:07:39:30 +0000] "GET /source HTTP/1.1" 200 606 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:30,756 INFO aiohttp.access:206  [23/Jun/2023:07:39:30 +0000] "GET /drivers HTTP/1.1" 200 268 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:30,761 INFO aiohttp.access:206  [23/Jun/2023:07:39:30 +0000] "GET /codecs HTTP/1.1" 200 205 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,694 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "POST /source?source_id=%22ubuntu-desktop%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,699 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "POST /drivers HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,702 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "POST /codecs HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,708 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "GET /storage/v2?wait=true HTTP/1.1" 200 1707 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,735 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "GET /storage/v2?wait=true HTTP/1.1" 200 1707 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,738 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "GET /storage/v2/guided?wait=true HTTP/1.1" 200 554 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:31,757 INFO aiohttp.access:206  [23/Jun/2023:07:39:31 +0000] "GET /storage/has_bitlocker HTTP/1.1" 200 188 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:32,592 INFO aiohttp.access:206  [23/Jun/2023:07:39:32 +0000] "GET /storage/v2?wait=true HTTP/1.1" 200 1707 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:32,597 INFO aiohttp.access:206  [23/Jun/2023:07:39:32 +0000] "GET /storage/v2/guided?wait=true HTTP/1.1" 200 554 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:34,391 INFO aiohttp.access:206  [23/Jun/2023:07:39:34 +0000] "POST /storage/v2/guided HTTP/1.1" 200 945 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:34,397 INFO aiohttp.access:206  [23/Jun/2023:07:39:34 +0000] "POST /storage/v2 HTTP/1.1" 200 1251 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:34,398 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "NEEDS_CONFIRMATION", "confirming_tty": "", "error": null, "cloud_i...
2023-06-23 07:39:34,398 INFO aiohttp.access:206  [23/Jun/2023:07:39:10 +0000] "GET /meta/status?cur=%22WAITING%22 HTTP/1.1" 200 423 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:34,401 INFO aiohttp.access:206  [23/Jun/2023:07:39:34 +0000] "GET /storage/v2?wait=true HTTP/1.1" 200 1251 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:34,402 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:34,482 INFO curtin:1342 Validating extracted storage config components
2023-06-23 07:39:34,491 INFO aiohttp.access:206  [23/Jun/2023:07:39:34 +0000] "GET /storage/v2/orig_config HTTP/1.1" 200 1707 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:35,769 INFO aiohttp.access:206  [23/Jun/2023:07:39:35 +0000] "GET /timezone HTTP/1.1" 200 241 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:35,979 INFO root:37 start: subiquity/Meta/confirm_POST: 
2023-06-23 07:39:35,979 INFO root:37 finish: subiquity/Meta/confirm_POST: SUCCESS: 200 null
2023-06-23 07:39:35,980 INFO aiohttp.access:206  [23/Jun/2023:07:39:35 +0000] "POST /meta/confirm?tty=%22%2Fdev%2Ftty1%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:35,980 INFO root:37 start: subiquity/Install/install/configure_apt: configuring apt
2023-06-23 07:39:35,981 INFO root:37 finish: subiquity/Meta/status_GET: SUCCESS: 200 {"state": "RUNNING", "confirming_tty": "/dev/tty1", "error": null, "cloud_ini...
2023-06-23 07:39:35,981 INFO aiohttp.access:206  [23/Jun/2023:07:39:34 +0000] "GET /meta/status?cur=%22NEEDS_CONFIRMATION%22 HTTP/1.1" 200 421 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:36,046 INFO root:37 start: subiquity/Meta/status_GET: 
2023-06-23 07:39:37,203 INFO aiohttp.access:206  [23/Jun/2023:07:39:37 +0000] "POST /timezone?tz=%22Atlantic%2FReykjavik%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:37,203 INFO aiohttp.access:206  [23/Jun/2023:07:39:37 +0000] "GET /identity HTTP/1.1" 200 259 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:37,215 INFO aiohttp.access:206  [23/Jun/2023:07:39:37 +0000] "GET /active_directory/has_support HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:40,074 INFO aiohttp.access:206  [23/Jun/2023:07:39:40 +0000] "GET /identity/validate_username?username=%22u%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:40,665 INFO aiohttp.access:206  [23/Jun/2023:07:39:40 +0000] "GET /identity/validate_username?username=%22um%22 HTTP/1.1" 200 190 "-" "Dart/3.0 (dart:io)"
2023-06-23 07:39:41,483 ERROR root:37 finish: subiquity/Install/install/configure_apt: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.3061', '--property', 'PrivateMounts=yes', '--setenv', 'PATH=/snap/ubuntu-desktop-installer/1099/bin/subiquity/bin:/snap/ubuntu-desktop-installer/1099/bin/subiquity/usr/bin:/snap/ubuntu-desktop-installer/1099/bin:/snap/ubuntu-desktop-installer/1099/sbin:/snap/ubuntu-desktop-installer/1099/usr/sbin:/snap/ubuntu-desktop-installer/1099/usr/bin:/snap/ubuntu-desktop-installer/1099/sbin:/snap/ubuntu-desktop-installer/1099/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/1099/lib/python3.10/site-packages:/snap/ubuntu-desktop-installer/1099/usr/lib/python3/dist-packages:/snap/ubuntu-desktop-installer/1099/usr/lib/python3/site-packages:', '--setenv', 'PYTHON=/snap/ubuntu-desktop-installer/1099/usr/bin/python3.10', '--setenv', 'SNAP=/snap/ubuntu-desktop-installer/1099', '--', '/snap/ubuntu-desktop-installer/1099/usr/bin/python3.10', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.3061.3"}}', 'in-target', '-t', '/tmp/tmp9aazssxb/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.
2023-06-23 07:39:41,490 INFO subiquity.common.errorreport:426 saving crash report 'install failed crashed with CalledProcessError' to /var/crash/1687505981.483444929.install_fail.crash
2023-06-23 07:39:41,490 ERROR root:37 finish: subiquity/Install/install: FAIL: Command '['systemd-run', '--wait', '--same-dir', '--property', 'SyslogIdentifier=subiquity_log.3061', '--property', 'PrivateMounts=yes', '--setenv', 'PATH=/snap/ubuntu-desktop-installer/1099/bin/subiquity/bin:/snap/ubuntu-desktop-installer/1099/bin/subiquity/usr/bin:/snap/ubuntu-desktop-installer/1099/bin:/snap/ubuntu-desktop-installer/1099/sbin:/snap/ubuntu-desktop-installer/1099/usr/sbin:/snap/ubuntu-desktop-installer/1099/usr/bin:/snap/ubuntu-desktop-installer/1099/sbin:/snap/ubuntu-desktop-installer/1099/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/1099/lib/python3.10/site-packages:/snap/ubuntu-desktop-installer/1099/usr/lib/python3/dist-packages:/snap/ubuntu-desktop-installer/1099/usr/lib/python3/site-packages:', '--setenv', 'PYTHON=/snap/ubuntu-desktop-installer/1099/usr/bin/python3.10', '--setenv', 'SNAP=/snap/ubuntu-desktop-installer/1099', '--', '/snap/ubuntu-desktop-installer/1099/usr/bin/python3.10', '-m', 'curtin', '--showtrace', '-vvv', '--set', 'json:reporting={"subiquity": {"type": "journald", "identifier": "curtin_event.3061.3"}}', 'in-target', '-t', '/tmp/tmp9aazssxb/mount', '--', 'apt-get', 'update']' returned non-zero exit status 100.
2023-06-23 07:39:41,490 INFO root:37 start: subiquity/ErrorReporter/1687505981.483444929.install_fail/add_info: