2023-10-11 03:36:35.317311 WARNING subiquity_server: Unable to find the subiquity_client package. Falling back to the current working dir: /home/ubuntu
2023-10-11 03:36:35.318034 INFO subiquity_server: Waiting server up to 90 seconds
2023-10-11 03:36:35.324527 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:36.332957 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:37.335686 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:38.341359 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:39.344351 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:40.347551 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:41.353154 INFO subiquity_server: ApplicationState.CLOUD_INIT_WAIT
2023-10-11 03:36:42.373381 INFO subiquity_server: ApplicationState.WAITING
2023-10-11 03:36:42.373516 INFO subiquity_client: Opening socket to Endpoint(/run/subiquity/socket )
2023-10-11 03:36:42.373715 DEBUG subiquity_client: POST http://localhost/meta/client_variant?variant=%22desktop%22
2023-10-11 03:36:42.378803 INFO subiquity_status: null => ApplicationStatus(state: ApplicationState.WAITING, confirmingTty: , error: null, cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:36:42.379249 INFO subiquity_status: null => ApplicationStatus(state: ApplicationState.WAITING, confirmingTty: , error: null, cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:36:42.379382 DEBUG subiquity_client: GET http://localhost/meta/interactive_sections
2023-10-11 03:36:42.379675 DEBUG subiquity_client: ==> setVariant(Variant.DESKTOP) null
2023-10-11 03:36:42.380622 DEBUG subiquity_client: ==> getInteractiveSections() null
2023-10-11 03:36:42.381243 INFO locale: Loaded 75 languages
2023-10-11 03:36:42.381289 DEBUG subiquity_client: GET http://localhost/locale
2023-10-11 03:36:42.383116 INFO subiquity_status: null => ApplicationStatus(state: ApplicationState.WAITING, confirmingTty: , error: null, cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:36:42.383230 DEBUG subiquity_client: POST http://localhost/meta/mark_configured?endpoint_names=%5B%22mirror%22%2C%22proxy%22%2C%22ssh%22%2C%22snaplist%22%2C%22ubuntu_pro%22%5D
2023-10-11 03:36:42.383565 DEBUG subiquity_client: ==> locale() "C.UTF-8"
2023-10-11 03:36:42.383685 INFO locale: Selected en_US as UI language
2023-10-11 03:36:42.412638 DEBUG subiquity_client: ==> markConfigured([mirror, proxy, ssh, snaplist, ubuntu_pro]) null
2023-10-11 03:36:42.418327 DEBUG desktop: Disabling automounting
2023-10-11 03:36:42.739441 DEBUG desktop: Disabling screen blanking
2023-10-11 03:36:42.793791 DEBUG desktop: Disabling screensaver
2023-10-11 03:36:42.875453 DEBUG subiquity_client: GET http://localhost/refresh?wait=true
2023-10-11 03:36:44.535309 DEBUG subiquity_client: ==> checkRefresh() {"availability": "UNAVAILABLE", "current_snap_version": "0+git.bca6e31c", "new_snap_version": ""}
2023-10-11 03:36:44.535550 DEBUG refresh: RefreshState.status(status: RefreshStatus(availability: RefreshCheckState.UNAVAILABLE, currentSnapVersion: 0+git.bca6e31c, newSnapVersion: ))
2023-10-11 03:36:46.705694 DEBUG telemetry: Writing report to /var/log/installer/telemetry
2023-10-11 03:36:51.614979 INFO locale: Set en_US as system locale
2023-10-11 03:36:51.615205 DEBUG subiquity_client: POST http://localhost/locale
2023-10-11 03:36:51.617885 DEBUG subiquity_client: ==> setLocale(en_US.UTF-8) null
2023-10-11 03:36:54.798426 DEBUG url_launcher: Launching http://www.ubuntu.com/getubuntu/releasenotes?os=ubuntu&ver=23.10&lang=en
2023-10-11 03:37:46.472295 INFO welcome: Selected welcomeInstallOption option
2023-10-11 03:37:48.541221 DEBUG subiquity_client: GET http://localhost/storage/has_rst
2023-10-11 03:37:48.546470 DEBUG subiquity_client: ==> hasRst() false
2023-10-11 03:37:48.546656 DEBUG subiquity_client: GET http://localhost/keyboard
2023-10-11 03:37:48.558636 DEBUG subiquity_client: ==> keyboard() {"setting": {"layout": "us", "variant": "", "toggle": null}, "layouts": [{"code": "af", "name": "Afghani", "variants": [{"code": "", "name": "Afghani"}, {"code": "ps", "name": "Afghani - Pashto"}, {"code": "olpc-ps", "name": "Afghani - Pashto (Afghanistan, OLPC)"}, {"code": "fa-olpc", "name": "Afghani - Persian (Afghanistan, Dari OLPC)"}, {"code": "uz", "name": "Afghani - Uzbek (Afghanistan)"}, {"code": "uz-olpc", "name": "Afghani - Uzbek (Afghanistan, OLPC)"}]}, {"code": "al", "name": "Albanian", "variants": [{"code": "", "name": "Albanian"}, {"code": "plisi", "name": "Albanian - Albanian (Plisi)"}, {"code": "veqilharxhi", "name": "Albanian - Albanian (Veqilharxhi)"}]}, {"code": "et", "name": "Amharic", "variants": [{"code": "", "name": "Amharic"}]}, {"code": "ara", "name": "Arabic", "variants": [{"code": "", "name": "Arabic"}, {"code": "azerty", "name": "Arabic - Arabic (AZERTY)"}, {"code": "azerty_digits", "name": "Arabic - Arabic (AZERTY/digits)"}, {"code": "buckwalter", "name": "Arabic - Arabic (Buckwalter)"}, {"code": "mac", "name": "Arabic - Arabic (Macintosh)"}, {"code": "olpc", "name": "Arabic - Arabic (OLPC)"}, {"code": "qwerty", "name": "Arabic - Arabic (QWERTY)"}, {"cod...
2023-10-11 03:37:48.560844 INFO keyboard: Loaded 99 keyboard layouts
2023-10-11 03:37:48.561495 DEBUG subiquity_client: GET http://localhost/keyboard
2023-10-11 03:37:48.571697 DEBUG subiquity_client: ==> keyboard() {"setting": {"layout": "us", "variant": "", "toggle": null}, "layouts": [{"code": "af", "name": "Afghani", "variants": [{"code": "", "name": "Afghani"}, {"code": "ps", "name": "Afghani - Pashto"}, {"code": "olpc-ps", "name": "Afghani - Pashto (Afghanistan, OLPC)"}, {"code": "fa-olpc", "name": "Afghani - Persian (Afghanistan, Dari OLPC)"}, {"code": "uz", "name": "Afghani - Uzbek (Afghanistan)"}, {"code": "uz-olpc", "name": "Afghani - Uzbek (Afghanistan, OLPC)"}]}, {"code": "al", "name": "Albanian", "variants": [{"code": "", "name": "Albanian"}, {"code": "plisi", "name": "Albanian - Albanian (Plisi)"}, {"code": "veqilharxhi", "name": "Albanian - Albanian (Veqilharxhi)"}]}, {"code": "et", "name": "Amharic", "variants": [{"code": "", "name": "Amharic"}]}, {"code": "ara", "name": "Arabic", "variants": [{"code": "", "name": "Arabic"}, {"code": "azerty", "name": "Arabic - Arabic (AZERTY)"}, {"code": "azerty_digits", "name": "Arabic - Arabic (AZERTY/digits)"}, {"code": "buckwalter", "name": "Arabic - Arabic (Buckwalter)"}, {"code": "mac", "name": "Arabic - Arabic (Macintosh)"}, {"code": "olpc", "name": "Arabic - Arabic (OLPC)"}, {"code": "qwerty", "name": "Arabic - Arabic (QWERTY)"}, {"cod...
2023-10-11 03:37:48.572752 INFO keyboard: Initialized us () keyboard layout
2023-10-11 03:37:48.572778 INFO keyboard: Updated us () input source
2023-10-11 03:37:48.572808 DEBUG subiquity_client: POST http://localhost/keyboard/input_source?user=%22ubuntu%22
2023-10-11 03:37:48.644428 DEBUG subiquity_client: ==> setInputSource(KeyboardSetting(layout: us, variant: , toggle: null)) null
2023-10-11 03:37:50.846710 INFO keyboard: Saved us () keyboard layout
2023-10-11 03:37:50.847142 DEBUG subiquity_client: POST http://localhost/keyboard
2023-10-11 03:37:50.848665 DEBUG subiquity_client: ==> setKeyboard(KeyboardSetting(layout: us, variant: , toggle: null)) null
2023-10-11 03:37:50.849934 DEBUG network: Update devices: [EthernetDevice(vendor: Red Hat, Inc., model: Virtio network device, state: activated)]
2023-10-11 03:37:50.849985 DEBUG network: Selected connection mode: ethernet
2023-10-11 03:37:50.850007 DEBUG network: Update devices: []
2023-10-11 03:37:50.850033 DEBUG network: Update devices: []
2023-10-11 03:37:52.662774 DEBUG refresh: RefreshState.checking()
2023-10-11 03:37:52.662858 DEBUG subiquity_client: GET http://localhost/refresh?wait=true
2023-10-11 03:37:52.664039 DEBUG subiquity_client: ==> checkRefresh() {"availability": "UNAVAILABLE", "current_snap_version": "0+git.bca6e31c", "new_snap_version": ""}
2023-10-11 03:37:52.664085 DEBUG refresh: RefreshState.status(status: RefreshStatus(availability: RefreshCheckState.UNAVAILABLE, currentSnapVersion: 0+git.bca6e31c, newSnapVersion: ))
2023-10-11 03:37:52.664313 DEBUG subiquity_client: GET http://localhost/source
2023-10-11 03:37:52.664369 DEBUG subiquity_client: GET http://localhost/drivers
2023-10-11 03:37:52.664405 DEBUG subiquity_client: GET http://localhost/codecs
2023-10-11 03:37:52.665446 DEBUG subiquity_client: ==> source() {"sources": [{"name": "Ubuntu Desktop (minimized)", "description": "A minimal but usable Ubuntu Desktop.", "id": "ubuntu-desktop-minimal", "size": 4330471424, "variant": "desktop", "default": true}, {"name": "Ubuntu Desktop", "description": "A full featured Ubuntu Desktop.", "id": "ubuntu-desktop", "size": 6017581056, "variant": "desktop", "default": false}], "current_id": "ubuntu-desktop-minimal", "search_drivers": false}
2023-10-11 03:37:52.666586 DEBUG subiquity_client: ==> getDrivers() {"install": false, "drivers": null, "local_only": true, "search_drivers": false}
2023-10-11 03:37:52.667024 DEBUG subiquity_client: ==> getCodecs() {"install": false}
2023-10-11 03:38:03.277676 DEBUG subiquity_client: POST http://localhost/source?source_id=%22ubuntu-desktop-minimal%22&search_drivers=false
2023-10-11 03:38:03.277775 DEBUG subiquity_client: POST http://localhost/drivers
2023-10-11 03:38:03.277809 DEBUG subiquity_client: POST http://localhost/codecs
2023-10-11 03:38:03.279369 DEBUG subiquity_client: ==> setSource(ubuntu-desktop-minimal) null
2023-10-11 03:38:03.279626 DEBUG subiquity_client: GET http://localhost/storage/v2?wait=true
2023-10-11 03:38:03.349245 DEBUG subiquity_client: ==> setDrivers(false) null
2023-10-11 03:38:03.349363 DEBUG subiquity_client: ==> setCodecs(false) null
2023-10-11 03:38:05.783161 DEBUG subiquity_client: ==> getStorageV2() {"status": "DONE", "error_report": null, "disks": [{"id": "disk-sda", "label": "QEMU_HARDDISK_QM00003", "type": "local disk", "size": 32212254720, "usage_labels": [], "partitions": [{"size": 1127219200, "number": 1, "preserve": true, "wipe": null, "annotations": ["existing", "unused ESP", "already formatted as vfat"], "mount": null, "format": "vfat", "grub_device": false, "boot": true, "os": null, "offset": 1048576, "estimated_min_size": -1, "resize": null, "path": "/dev/sda1", "is_in_use": false, "$type": "Partition"}, {"size": 2147483648, "number": 2, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as ext4", "not mounted"], "mount": null, "format": "ext4", "grub_device": false, "boot": false, "os": null, "offset": 1128267776, "estimated_min_size": 249561088, "resize": null, "path": "/dev/sda2", "is_in_use": false, "$type": "Partition"}, {"size": 28935454720, "number": 3, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as crypto_LUKS", "not mounted"], "mount": null, "format": "crypto_LUKS", "grub_device": false, "boot": false, "os": null, "offset": 3275751424, "estimated_min_size": -1, "resize": null, "path": "/dev/sda3...
2023-10-11 03:38:05.786134 DEBUG storage: Update storage: StorageResponseV2(status: ProbeStatus.DONE, errorReport: null, disks: [Disk(id: disk-sda, label: QEMU_HARDDISK_QM00003, type: local disk, size: 32212254720, usageLabels: [], partitions: [PartitionOrGap.partition(size: 1127219200, number: 1, preserve: true, wipe: null, annotations: [existing, unused ESP, already formatted as vfat], mount: null, format: vfat, grubDevice: false, boot: true, os: null, offset: 1048576, estimatedMinSize: -1, resize: null, path: /dev/sda1, isInUse: false), PartitionOrGap.partition(size: 2147483648, number: 2, preserve: true, wipe: null, annotations: [existing, already formatted as ext4, not mounted], mount: null, format: ext4, grubDevice: false, boot: false, os: null, offset: 1128267776, estimatedMinSize: 249561088, resize: null, path: /dev/sda2, isInUse: false), PartitionOrGap.partition(size: 28935454720, number: 3, preserve: true, wipe: null, annotations: [existing, already formatted as crypto_LUKS, not mounted], mount: null, format: crypto_LUKS, grubDevice: false, boot: false, os: null, offset: 3275751424, estimatedMinSize: -1, resize: null, path: /dev/sda3, isInUse: false)], okForGuided: true, ptable: gpt, preserve: true, path: /dev/sda, bootDevice: false, canBeBootDevice: true, model: QEMU HARDDISK, vendor: null, hasInUsePartition: false)], needRoot: true, needBoot: true, installMinimumSize: 8939110400)
2023-10-11 03:38:05.786614 DEBUG subiquity_client: GET http://localhost/storage/v2?wait=true
2023-10-11 03:38:06.222750 DEBUG subiquity_client: ==> getStorageV2() {"status": "DONE", "error_report": null, "disks": [{"id": "disk-sda", "label": "QEMU_HARDDISK_QM00003", "type": "local disk", "size": 32212254720, "usage_labels": [], "partitions": [{"size": 1127219200, "number": 1, "preserve": true, "wipe": null, "annotations": ["existing", "unused ESP", "already formatted as vfat"], "mount": null, "format": "vfat", "grub_device": false, "boot": true, "os": null, "offset": 1048576, "estimated_min_size": -1, "resize": null, "path": "/dev/sda1", "is_in_use": false, "$type": "Partition"}, {"size": 2147483648, "number": 2, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as ext4", "not mounted"], "mount": null, "format": "ext4", "grub_device": false, "boot": false, "os": null, "offset": 1128267776, "estimated_min_size": 249561088, "resize": null, "path": "/dev/sda2", "is_in_use": false, "$type": "Partition"}, {"size": 28935454720, "number": 3, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as crypto_LUKS", "not mounted"], "mount": null, "format": "crypto_LUKS", "grub_device": false, "boot": false, "os": null, "offset": 3275751424, "estimated_min_size": -1, "resize": null, "path": "/dev/sda3...
2023-10-11 03:38:06.222874 DEBUG storage: Update storage: StorageResponseV2(status: ProbeStatus.DONE, errorReport: null, disks: [Disk(id: disk-sda, label: QEMU_HARDDISK_QM00003, type: local disk, size: 32212254720, usageLabels: [], partitions: [PartitionOrGap.partition(size: 1127219200, number: 1, preserve: true, wipe: null, annotations: [existing, unused ESP, already formatted as vfat], mount: null, format: vfat, grubDevice: false, boot: true, os: null, offset: 1048576, estimatedMinSize: -1, resize: null, path: /dev/sda1, isInUse: false), PartitionOrGap.partition(size: 2147483648, number: 2, preserve: true, wipe: null, annotations: [existing, already formatted as ext4, not mounted], mount: null, format: ext4, grubDevice: false, boot: false, os: null, offset: 1128267776, estimatedMinSize: 249561088, resize: null, path: /dev/sda2, isInUse: false), PartitionOrGap.partition(size: 28935454720, number: 3, preserve: true, wipe: null, annotations: [existing, already formatted as crypto_LUKS, not mounted], mount: null, format: crypto_LUKS, grubDevice: false, boot: false, os: null, offset: 3275751424, estimatedMinSize: -1, resize: null, path: /dev/sda3, isInUse: false)], okForGuided: true, ptable: gpt, preserve: true, path: /dev/sda, bootDevice: false, canBeBootDevice: true, model: QEMU HARDDISK, vendor: null, hasInUsePartition: false)], needRoot: true, needBoot: true, installMinimumSize: 8939110400)
2023-10-11 03:38:06.222939 DEBUG subiquity_client: GET http://localhost/storage/v2/guided?wait=true
2023-10-11 03:38:06.224461 DEBUG subiquity_client: ==> getGuidedStorageV2(true) {"status": "DONE", "error_report": null, "configured": null, "targets": [{"disk_id": "disk-sda", "allowed": ["DIRECT", "LVM", "LVM_LUKS", "ZFS", "CORE_BOOT_PREFER_ENCRYPTED"], "disallowed": [], "$type": "GuidedStorageTargetReformat"}, {"allowed": ["MANUAL"], "disallowed": [], "$type": "GuidedStorageTargetManual"}]}
2023-10-11 03:38:06.224608 DEBUG storage: select guided capability: GuidedCapability.DIRECT
2023-10-11 03:38:06.224632 DEBUG subiquity_client: GET http://localhost/storage/has_bitlocker
2023-10-11 03:38:06.225500 DEBUG subiquity_client: ==> hasBitLocker() []
2023-10-11 03:38:12.644941 DEBUG subiquity_client: GET http://localhost/storage/has_bitlocker
2023-10-11 03:38:12.646401 DEBUG subiquity_client: ==> hasBitLocker() []
2023-10-11 03:38:12.646613 DEBUG subiquity_client: GET http://localhost/storage/v2?wait=true
2023-10-11 03:38:12.648706 DEBUG subiquity_client: ==> getStorageV2() {"status": "DONE", "error_report": null, "disks": [{"id": "disk-sda", "label": "QEMU_HARDDISK_QM00003", "type": "local disk", "size": 32212254720, "usage_labels": [], "partitions": [{"size": 1127219200, "number": 1, "preserve": true, "wipe": null, "annotations": ["existing", "unused ESP", "already formatted as vfat"], "mount": null, "format": "vfat", "grub_device": false, "boot": true, "os": null, "offset": 1048576, "estimated_min_size": -1, "resize": null, "path": "/dev/sda1", "is_in_use": false, "$type": "Partition"}, {"size": 2147483648, "number": 2, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as ext4", "not mounted"], "mount": null, "format": "ext4", "grub_device": false, "boot": false, "os": null, "offset": 1128267776, "estimated_min_size": 249561088, "resize": null, "path": "/dev/sda2", "is_in_use": false, "$type": "Partition"}, {"size": 28935454720, "number": 3, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as crypto_LUKS", "not mounted"], "mount": null, "format": "crypto_LUKS", "grub_device": false, "boot": false, "os": null, "offset": 3275751424, "estimated_min_size": -1, "resize": null, "path": "/dev/sda3...
2023-10-11 03:38:12.648979 DEBUG storage: Update storage: StorageResponseV2(status: ProbeStatus.DONE, errorReport: null, disks: [Disk(id: disk-sda, label: QEMU_HARDDISK_QM00003, type: local disk, size: 32212254720, usageLabels: [], partitions: [PartitionOrGap.partition(size: 1127219200, number: 1, preserve: true, wipe: null, annotations: [existing, unused ESP, already formatted as vfat], mount: null, format: vfat, grubDevice: false, boot: true, os: null, offset: 1048576, estimatedMinSize: -1, resize: null, path: /dev/sda1, isInUse: false), PartitionOrGap.partition(size: 2147483648, number: 2, preserve: true, wipe: null, annotations: [existing, already formatted as ext4, not mounted], mount: null, format: ext4, grubDevice: false, boot: false, os: null, offset: 1128267776, estimatedMinSize: 249561088, resize: null, path: /dev/sda2, isInUse: false), PartitionOrGap.partition(size: 28935454720, number: 3, preserve: true, wipe: null, annotations: [existing, already formatted as crypto_LUKS, not mounted], mount: null, format: crypto_LUKS, grubDevice: false, boot: false, os: null, offset: 3275751424, estimatedMinSize: -1, resize: null, path: /dev/sda3, isInUse: false)], okForGuided: true, ptable: gpt, preserve: true, path: /dev/sda, bootDevice: false, canBeBootDevice: true, model: QEMU HARDDISK, vendor: null, hasInUsePartition: false)], needRoot: true, needBoot: true, installMinimumSize: 8939110400)
2023-10-11 03:38:12.649193 DEBUG subiquity_client: GET http://localhost/storage/v2/guided?wait=true
2023-10-11 03:38:12.650708 DEBUG subiquity_client: ==> getGuidedStorageV2(true) {"status": "DONE", "error_report": null, "configured": null, "targets": [{"disk_id": "disk-sda", "allowed": ["DIRECT", "LVM", "LVM_LUKS", "ZFS", "CORE_BOOT_PREFER_ENCRYPTED"], "disallowed": [], "$type": "GuidedStorageTargetReformat"}, {"allowed": ["MANUAL"], "disallowed": [], "$type": "GuidedStorageTargetManual"}]}
2023-10-11 03:38:12.650944 DEBUG storage: select guided target: GuidedStorageTarget.reformat(diskId: disk-sda, allowed: [GuidedCapability.DIRECT, GuidedCapability.LVM, GuidedCapability.LVM_LUKS, GuidedCapability.ZFS, GuidedCapability.CORE_BOOT_PREFER_ENCRYPTED], disallowed: [])
2023-10-11 03:38:12.651208 DEBUG subiquity_client: POST http://localhost/storage/v2/guided
2023-10-11 03:38:12.654395 DEBUG subiquity_client: ==> setGuidedStorageV2({"target":{"disk_id":"disk-sda","allowed":["DIRECT","LVM","LVM_LUKS","ZFS","CORE_BOOT_PREFER_ENCRYPTED"],"disallowed":[],"$type":"GuidedStorageTargetReformat"},"capability":"DIRECT","password":null,"recovery_key":null,"sizing_policy":"ALL","reset_partition":false}) {"status":"DONE","error_report":null,"configured":{"target":{"disk_id":"disk-sda","allowed":["DIRECT","LVM","LVM_LUKS","ZFS","CORE_BOOT_PREFER_ENCRYPTED"],"disallowed":[],"$type":"GuidedStorageTargetReformat"},"capability":"DIRECT","password":null,"recovery_key":null,"sizing_policy":"ALL","reset_partition":false},"targets":[{"disk_id":"disk-sda","allowed":["DIRECT","LVM","LVM_LUKS","ZFS","CORE_BOOT_PREFER_ENCRYPTED"],"disallowed":[],"$type":"GuidedStorageTargetReformat"},{"disk_id":"disk-sda","partition_number":2,"new_size":6573522944,"minimum":2397044736,"recommended":6573522944,"maximum":22143827968,"allowed":["DIRECT","LVM","LVM_LUKS","ZFS"],"disallowed":[],"$type":"GuidedStorageTargetResize"},{"allowed":["MANUAL"],"disallowed":[],"$type":"GuidedStorageTargetManual"}]}
2023-10-11 03:38:12.654700 DEBUG subiquity_client: POST http://localhost/storage/v2
2023-10-11 03:38:12.657683 DEBUG subiquity_client: ==> setStorageV2() {"status": "DONE", "error_report": null, "disks": [{"id": "disk-sda", "label": "QEMU_HARDDISK_QM00003", "type": "local disk", "size": 32212254720, "usage_labels": [], "partitions": [{"size": 1127219200, "number": 1, "preserve": false, "wipe": "superblock", "annotations": ["new", "primary ESP", "to be formatted as fat32", "mounted at /boot/efi"], "mount": "/boot/efi", "format": "fat32", "grub_device": true, "boot": true, "os": null, "offset": 1048576, "estimated_min_size": -1, "resize": null, "path": "/dev/sda1", "is_in_use": false, "$type": "Partition"}, {"size": 31082938368, "number": 2, "preserve": false, "wipe": "superblock", "annotations": ["new", "to be formatted as ext4", "mounted at /"], "mount": "/", "format": "ext4", "grub_device": null, "boot": false, "os": null, "offset": 1128267776, "estimated_min_size": 249561088, "resize": null, "path": "/dev/sda2", "is_in_use": false, "$type": "Partition"}], "ok_for_guided": true, "ptable": "gpt", "preserve": false, "path": "/dev/sda", "boot_device": true, "can_be_boot_device": true, "model": "QEMU HARDDISK", "vendor": null, "has_in_use_partition": false}], "need_root": false, "need_boot": false, "install_minimum_size": 8939110400}
2023-10-11 03:38:12.657993 DEBUG subiquity_client: GET http://localhost/storage/v2?wait=true
2023-10-11 03:38:12.662001 DEBUG subiquity_client: ==> getStorageV2() {"status": "DONE", "error_report": null, "disks": [{"id": "disk-sda", "label": "QEMU_HARDDISK_QM00003", "type": "local disk", "size": 32212254720, "usage_labels": [], "partitions": [{"size": 1127219200, "number": 1, "preserve": false, "wipe": "superblock", "annotations": ["new", "primary ESP", "to be formatted as fat32", "mounted at /boot/efi"], "mount": "/boot/efi", "format": "fat32", "grub_device": true, "boot": true, "os": null, "offset": 1048576, "estimated_min_size": -1, "resize": null, "path": "/dev/sda1", "is_in_use": false, "$type": "Partition"}, {"size": 31082938368, "number": 2, "preserve": false, "wipe": "superblock", "annotations": ["new", "to be formatted as ext4", "mounted at /"], "mount": "/", "format": "ext4", "grub_device": null, "boot": false, "os": null, "offset": 1128267776, "estimated_min_size": 249561088, "resize": null, "path": "/dev/sda2", "is_in_use": false, "$type": "Partition"}], "ok_for_guided": true, "ptable": "gpt", "preserve": false, "path": "/dev/sda", "boot_device": true, "can_be_boot_device": true, "model": "QEMU HARDDISK", "vendor": null, "has_in_use_partition": false}], "need_root": false, "need_boot": false, "install_minimum_size": 8939110400}
2023-10-11 03:38:12.662478 DEBUG storage: Update storage: StorageResponseV2(status: ProbeStatus.DONE, errorReport: null, disks: [Disk(id: disk-sda, label: QEMU_HARDDISK_QM00003, type: local disk, size: 32212254720, usageLabels: [], partitions: [PartitionOrGap.partition(size: 1127219200, number: 1, preserve: false, wipe: superblock, annotations: [new, primary ESP, to be formatted as fat32, mounted at /boot/efi], mount: /boot/efi, format: fat32, grubDevice: true, boot: true, os: null, offset: 1048576, estimatedMinSize: -1, resize: null, path: /dev/sda1, isInUse: false), PartitionOrGap.partition(size: 31082938368, number: 2, preserve: false, wipe: superblock, annotations: [new, to be formatted as ext4, mounted at /], mount: /, format: ext4, grubDevice: null, boot: false, os: null, offset: 1128267776, estimatedMinSize: 249561088, resize: null, path: /dev/sda2, isInUse: false)], okForGuided: true, ptable: gpt, preserve: false, path: /dev/sda, bootDevice: true, canBeBootDevice: true, model: QEMU HARDDISK, vendor: null, hasInUsePartition: false)], needRoot: false, needBoot: false, installMinimumSize: 8939110400)
2023-10-11 03:38:12.662784 DEBUG subiquity_client: GET http://localhost/storage/v2/orig_config
2023-10-11 03:38:12.765337 DEBUG subiquity_client: ==> getOriginalStorageV2() {"status": "DONE", "error_report": null, "disks": [{"id": "disk-sda", "label": "QEMU_HARDDISK_QM00003", "type": "local disk", "size": 32212254720, "usage_labels": [], "partitions": [{"size": 1127219200, "number": 1, "preserve": true, "wipe": null, "annotations": ["existing", "unused ESP", "already formatted as vfat"], "mount": null, "format": "vfat", "grub_device": false, "boot": true, "os": null, "offset": 1048576, "estimated_min_size": -1, "resize": null, "path": "/dev/sda1", "is_in_use": false, "$type": "Partition"}, {"size": 2147483648, "number": 2, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as ext4", "not mounted"], "mount": null, "format": "ext4", "grub_device": false, "boot": false, "os": null, "offset": 1128267776, "estimated_min_size": 249561088, "resize": null, "path": "/dev/sda2", "is_in_use": false, "$type": "Partition"}, {"size": 28935454720, "number": 3, "preserve": true, "wipe": null, "annotations": ["existing", "already formatted as crypto_LUKS", "not mounted"], "mount": null, "format": "crypto_LUKS", "grub_device": false, "boot": false, "os": null, "offset": 3275751424, "estimated_min_size": -1, "resize": null, "path": "/dev/sda3...
2023-10-11 03:38:14.740400 DEBUG subiquity_client: GET http://localhost/timezone
2023-10-11 03:38:14.744771 DEBUG subiquity_client: ==> timezone() {"timezone": "None", "from_geoip": true}
2023-10-11 03:38:14.744858 DEBUG timezone: Initialized None
2023-10-11 03:38:14.943080 DEBUG subiquity_client: POST http://localhost/meta/mark_configured?endpoint_names=%5B%22network%22%5D
2023-10-11 03:38:14.946918 DEBUG subiquity_client: ==> markConfigured([network]) null
2023-10-11 03:38:14.947207 DEBUG subiquity_client: POST http://localhost/meta/confirm?tty=%22%2Fdev%2Ftty1%22
2023-10-11 03:38:14.956633 INFO subiquity_status: WAITING => ApplicationStatus(state: ApplicationState.NEEDS_CONFIRMATION, confirmingTty: , error: null, cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:38:14.956987 DEBUG subiquity_client: ==> confirm(/dev/tty1) null
2023-10-11 03:38:14.990891 INFO subiquity_status: NEEDS_CONFIRMATION => ApplicationStatus(state: ApplicationState.RUNNING, confirmingTty: /dev/tty1, error: null, cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:38:18.446981 DEBUG timezone: Saved Pacific/Auckland
2023-10-11 03:38:18.447706 DEBUG subiquity_client: POST http://localhost/timezone?tz=%22Pacific%2FAuckland%22
2023-10-11 03:38:18.448664 DEBUG subiquity_client: GET http://localhost/identity
2023-10-11 03:38:18.591675 DEBUG subiquity_client: ==> setTimezone(Pacific/Auckland) null
2023-10-11 03:38:18.592400 DEBUG subiquity_client: ==> identity() {"realname": "", "username": "", "crypted_password": "", "hostname": ""}
2023-10-11 03:38:18.592653 INFO identity: Loaded identity: Identity(realname: , username: , password: , hostname: , autoLogin: false)
2023-10-11 03:38:18.593128 INFO identity: Read product name: pc-q35-6-2
2023-10-11 03:38:18.593205 DEBUG subiquity_client: GET http://localhost/active_directory/has_support
2023-10-11 03:38:18.594018 DEBUG subiquity_client: ==> hasActiveDirectorySupport() true
2023-10-11 03:38:22.607057 DEBUG subiquity_client: GET http://localhost/identity/validate_username?username=%22h%22
2023-10-11 03:38:22.612535 DEBUG subiquity_client: ==> identity/validate_username() "OK"
2023-10-11 03:38:22.894130 DEBUG subiquity_client: GET http://localhost/identity/validate_username?username=%22he%22
2023-10-11 03:38:22.898967 DEBUG subiquity_client: ==> identity/validate_username() "OK"
2023-10-11 03:38:23.086404 DEBUG subiquity_client: GET http://localhost/identity/validate_username?username=%22hen%22
2023-10-11 03:38:23.098164 DEBUG subiquity_client: ==> identity/validate_username() "OK"
2023-10-11 03:38:23.342287 DEBUG subiquity_client: GET http://localhost/identity/validate_username?username=%22heni%22
2023-10-11 03:38:23.346952 DEBUG subiquity_client: ==> identity/validate_username() "OK"
2023-10-11 03:38:39.027342 INFO identity: Saved identity: Identity(realname: Heni, username: heni, password: ********, hostname: ubuntu2310, autoLogin: false)
2023-10-11 03:38:39.028454 DEBUG subiquity_client: POST http://localhost/meta/mark_configured?endpoint_names=%5B%22active_directory%22%5D
2023-10-11 03:38:39.031899 DEBUG subiquity_client: ==> markConfigured([active_directory]) null
2023-10-11 03:38:39.032699 DEBUG post-install: saved 0 entries to /tmp/ubuntu_desktop_installer.conf
2023-10-11 03:38:39.060583 DEBUG subiquity_client: POST http://localhost/identity
2023-10-11 03:38:39.063083 DEBUG subiquity_client: ==> setIdentity(IdentityData(realname: Heni, username: heni, cryptedPassword: $6$iNv8ttu0MAZ5j3yb$zxE47rEXCtgQMhPyKz2.qBvidF2Tt39bE8FCrO7NHf4aT1LYHAUJVP7B1/DDtPMKzXxv35m4RSimbN9pg2HpR/, hostname: ubuntu2310)) null
2023-10-11 03:38:41.105724 DEBUG subiquity_client: GET http://localhost/meta/status
2023-10-11 03:38:41.125056 DEBUG subiquity_client: ==> status() {"state": "RUNNING", "confirming_tty": "/dev/tty1", "error": null, "cloud_init_ok": true, "interactive": true, "echo_syslog_id": "subiquity_echo.2060", "log_syslog_id": "subiquity_log.2060", "event_syslog_id": "subiquity_event.2060"}
2023-10-11 03:38:41.125289 INFO subiquity_client: state: null => RUNNING
2023-10-11 03:38:41.410525 INFO subiquity_status: null => ApplicationStatus(state: ApplicationState.RUNNING, confirmingTty: /dev/tty1, error: null, cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:38:46.279424 INFO subiquity_status: RUNNING => ApplicationStatus(state: ApplicationState.ERROR, confirmingTty: /dev/tty1, error: ErrorReportRef(state: ErrorReportState.INCOMPLETE, base: 1696995526.230397224.install_fail, kind: ErrorReportKind.INSTALL_FAIL, seen: false, oopsId: null), cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)
2023-10-11 03:38:46.279763 INFO subiquity_status: RUNNING => ApplicationStatus(state: ApplicationState.ERROR, confirmingTty: /dev/tty1, error: ErrorReportRef(state: ErrorReportState.INCOMPLETE, base: 1696995526.230397224.install_fail, kind: ErrorReportKind.INSTALL_FAIL, seen: false, oopsId: null), cloudInitOk: true, interactive: true, echoSyslogId: subiquity_echo.2060, logSyslogId: subiquity_log.2060, eventSyslogId: subiquity_event.2060)