2021-11-12 09:32:38,051 INFO subiquity:118 Starting Subiquity revision 2651
2021-11-12 09:32:38,052 INFO subiquity:119 Arguments passed: ['/snap/subiquity/2651/usr/bin/subiquity']
2021-11-12 09:32:38,052 DEBUG subiquitycore.screen:135 KDGKBTYPE returned b'\x02', is_linux_tty True
2021-11-12 09:32:38,053 DEBUG asyncio:54 Using selector: EpollSelector
2021-11-12 09:33:08,242 DEBUG subiquitycore.core:113 starting controllers
2021-11-12 09:33:08,242 DEBUG subiquitycore.core:116 controllers started
2021-11-12 09:33:08,245 DEBUG subiquity/Progress/_wait_status:100 start: 
2021-11-12 09:33:08,286 INFO subiquity/Serial:100 start: starting UI
2021-11-12 09:33:08,286 INFO subiquity/Serial:105 finish: (skipped) SUCCESS
2021-11-12 09:33:08,286 DEBUG subiquitycore.tui:228 skipping screen Serial
2021-11-12 09:33:08,286 INFO subiquity/Welcome:100 start: starting UI
2021-11-12 09:33:08,296 DEBUG subiquity.views.welcome:81 ('ast_ES.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,298 DEBUG subiquity.views.welcome:81 ('id_ID.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,298 DEBUG subiquity.views.welcome:81 ('ca_ES.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,298 DEBUG subiquity.views.welcome:81 ('de_DE.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,298 DEBUG subiquity.views.welcome:81 ('en_US.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,298 DEBUG subiquity.views.welcome:81 ('en_GB.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,298 DEBUG subiquity.views.welcome:81 ('es_ES.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,299 DEBUG subiquity.views.welcome:81 ('fr_FR.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,299 DEBUG subiquity.views.welcome:81 ('hr_HR.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,299 DEBUG subiquity.views.welcome:81 ('lv_LV.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,299 DEBUG subiquity.views.welcome:81 ('lt_LT.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,299 DEBUG subiquity.views.welcome:81 ('hu_HU.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,300 DEBUG subiquity.views.welcome:81 ('nl_NL.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,300 DEBUG subiquity.views.welcome:81 ('nb', 'en_US.UTF-8')
2021-11-12 09:33:08,300 DEBUG subiquity.views.welcome:81 ('pl_PL.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,300 DEBUG subiquity.views.welcome:81 ('fi_FI.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,300 DEBUG subiquity.views.welcome:81 ('sv_SE.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,300 DEBUG subiquity.views.welcome:81 ('cs_CZ.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,301 DEBUG subiquity.views.welcome:81 ('el_GR.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,301 DEBUG subiquity.views.welcome:81 ('be_BY.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,301 DEBUG subiquity.views.welcome:81 ('ru_RU.UTF-8', 'en_US.UTF-8')
2021-11-12 09:33:08,301 DEBUG subiquity.views.welcome:81 ('sr_RS', 'en_US.UTF-8')
2021-11-12 09:33:08,301 DEBUG subiquity.views.welcome:81 ('uk_UA.UTF-8', 'en_US.UTF-8')
2021-11-12 09:41:26,248 DEBUG subiquity.views.welcome:102 WelcomeView en_US.UTF-8
2021-11-12 09:41:26,249 DEBUG subiquity.client.controllers.welcome:43 WelcomeController.done en_US.UTF-8 next_screen
2021-11-12 09:41:26,255 INFO subiquity/Welcome:105 finish: completed SUCCESS
2021-11-12 09:41:26,255 INFO subiquity/Refresh:100 start: starting UI
2021-11-12 09:41:26,259 INFO subiquity/Refresh:105 finish: (skipped) SUCCESS
2021-11-12 09:41:26,259 DEBUG subiquitycore.tui:228 skipping screen Refresh
2021-11-12 09:41:26,259 INFO subiquity/Keyboard:100 start: starting UI
2021-11-12 09:41:41,586 DEBUG subiquity.ui.views.keyboard:440 select_layout KeyboardLayout(code='it', name='Italian', variants=[KeyboardVariant(code='', name='Italian'), KeyboardVariant(code='geo', name='Italian - Georgian (Italy)'), KeyboardVariant(code='ibm', name='Italian - Italian (IBM 142)'), KeyboardVariant(code='mac', name='Italian - Italian (Macintosh)'), KeyboardVariant(code='us', name='Italian - Italian (US, with Italian letters)'), KeyboardVariant(code='winkeys', name='Italian - Italian (Winkeys)'), KeyboardVariant(code='intl', name='Italian - Italian (intl., with dead keys)'), KeyboardVariant(code='nodeadkeys', name='Italian - Italian (no dead keys)'), KeyboardVariant(code='scn', name='Italian - Sicilian')])
2021-11-12 09:41:46,440 INFO subiquity/Keyboard:105 finish: completed SUCCESS
2021-11-12 09:41:46,440 INFO subiquity/Zdev:100 start: starting UI
2021-11-12 09:41:46,451 INFO subiquity/Zdev:105 finish: (skipped) SUCCESS
2021-11-12 09:41:46,451 DEBUG subiquitycore.tui:228 skipping screen Zdev
2021-11-12 09:41:46,451 INFO subiquity/Network:100 start: starting UI
2021-11-12 09:41:46,457 DEBUG subiquitycore.views.network:361 new_link eth0 False
2021-11-12 09:41:46,513 DEBUG subiquity/Network/route_watch_POST:100 start: 
2021-11-12 09:41:46,514 DEBUG subiquitycore.views.network:328 view route_watcher []
2021-11-12 09:41:46,516 DEBUG subiquity/Network/route_watch_POST:105 finish: 200 null SUCCESS
2021-11-12 09:41:46,516 INFO aiohttp.access:206  [12/Nov/2021:09:41:46 +0000] "POST /route_watch?routes=%5B%5D HTTP/1.1" 200 180 "-" "Python/3.6 aiohttp/3.7.4.post0"
2021-11-12 09:41:47,667 DEBUG subiquity/Network/update_link_POST:100 start: {"name": "eth0", "type": "eth", "is_connected": true, "bond_master": null, "i...
2021-11-12 09:41:47,668 DEBUG subiquitycore.views.network:379 update_link eth0 True
2021-11-12 09:41:47,669 DEBUG subiquity/Network/update_link_POST:105 finish: 200 null SUCCESS
2021-11-12 09:41:47,669 INFO aiohttp.access:206  [12/Nov/2021:09:41:47 +0000] "POST /update_link?act=%22CHANGE%22 HTTP/1.1" 200 180 "-" "Python/3.6 aiohttp/3.7.4.post0"
2021-11-12 09:43:28,077 INFO subiquity/Network:105 finish: completed SUCCESS
2021-11-12 09:43:28,078 INFO subiquity/Proxy:100 start: starting UI
2021-11-12 09:43:30,026 DEBUG subiquity.ui.views.proxy:63 User input: {'url': ''}
2021-11-12 09:43:30,026 DEBUG subiquity.client.controllers.proxy:40 ProxyController.done next_screen proxy=
2021-11-12 09:43:30,031 INFO subiquity/Proxy:105 finish: completed SUCCESS
2021-11-12 09:43:30,032 INFO subiquity/Mirror:100 start: starting UI
2021-11-12 09:43:31,650 DEBUG subiquity.ui.mirror:60 User input: {'url': 'http://archive.ubuntu.com/ubuntu'}
2021-11-12 09:43:31,651 DEBUG subiquity.client.controllers.mirror:43 MirrorController.done next_screen mirror=http://archive.ubuntu.com/ubuntu
2021-11-12 09:43:31,658 INFO subiquity/Mirror:105 finish: completed SUCCESS
2021-11-12 09:43:31,658 INFO subiquity/Refresh:100 start: starting UI
2021-11-12 09:43:33,322 DEBUG subiquity.client.controllers.refresh:86 RefreshController.done next_screen
2021-11-12 09:43:33,323 INFO subiquity/Refresh:105 finish: completed SUCCESS
2021-11-12 09:43:33,323 INFO subiquity/Filesystem:100 start: starting UI
2021-11-12 09:43:37,843 DEBUG subiquity.models.filesystem:937 load_server_data StorageResponse(status=<ProbeStatus.DONE: 3>, error_report=None, bootloader=<Bootloader.BIOS: 'BIOS'>, orig_config=[{'type': 'disk', 'id': 'disk-xvda', 'path': '/dev/xvda'}], config=[{'ptable': 'gpt', 'path': '/dev/xvda', 'wipe': 'superblock', 'preserve': False, 'name': '', 'grub_device': True, 'type': 'disk', 'id': 'disk-xvda'}, {'device': 'disk-xvda', 'size': 1048576, 'flag': 'bios_grub', 'number': 1, 'preserve': False, 'type': 'partition', 'id': 'partition-0'}, {'device': 'disk-xvda', 'size': 1073741824, 'wipe': 'superblock', 'flag': '', 'number': 2, 'preserve': False, 'type': 'partition', 'id': 'partition-1'}, {'fstype': 'ext4', 'volume': 'partition-1', 'preserve': False, 'type': 'format', 'id': 'format-0'}, {'device': 'disk-xvda', 'size': 52610203648, 'wipe': 'superblock', 'flag': '', 'number': 3, 'preserve': False, 'type': 'partition', 'id': 'partition-2'}, {'name': 'ubuntu-vg', 'devices': ['partition-2'], 'preserve': False, 'type': 'lvm_volgroup', 'id': 'lvm_volgroup-0'}, {'name': 'ubuntu-lv', 'volgroup': 'lvm_volgroup-0', 'size': '26304577536B', 'wipe': 'superblock', 'preserve': False, 'type': 'lvm_partition', 'id': 'lvm_partition-0'}, {'fstype': 'ext4', 'volume': 'lvm_partition-0', 'preserve': False, 'type': 'format', 'id': 'format-1'}, {'path': '/', 'device': 'format-1', 'type': 'mount', 'id': 'mount-1'}, {'path': '/boot', 'device': 'format-0', 'type': 'mount', 'id': 'mount-0'}], blockdev={'/dev/sr0': {'DEVLINKS': '/dev/disk/by-path/pci-0000:00:01.1-ata-2 /dev/dvd /dev/cdrom /dev/disk/by-label/Ubuntu-Server\\x2020.04.3\\x20LTS\\x20amd64 /dev/disk/by-uuid/2021-08-24-09-09-05-00 /dev/disk/by-id/ata-QEMU_DVD-ROM_QM00004', 'DEVNAME': '/dev/sr0', 'DEVPATH': '/devices/pci0000:00/0000:00:01.1/ata2/host1/target1:0:1/1:0:1:0/block/sr0', 'DEVTYPE': 'disk', 'ID_ATA': '1', 'ID_BUS': 'ata', 'ID_CDROM': '1', 'ID_CDROM_DVD': '1', 'ID_CDROM_MEDIA': '1', 'ID_CDROM_MEDIA_DVD': '1', 'ID_CDROM_MEDIA_SESSION_COUNT': '1', 'ID_CDROM_MEDIA_STATE': 'complete', 'ID_CDROM_MEDIA_TRACK_COUNT': '1', 'ID_CDROM_MEDIA_TRACK_COUNT_DATA': '1', 'ID_CDROM_MRW': '1', 'ID_CDROM_MRW_W': '1', 'ID_FOR_SEAT': 'block-pci-0000_00_01_1-ata-2', 'ID_FS_BOOT_SYSTEM_ID': 'EL\\x20TORITO\\x20SPECIFICATION', 'ID_FS_LABEL': 'Ubuntu-Server_20.04.3_LTS_amd64', 'ID_FS_LABEL_ENC': 'Ubuntu-Server\\x2020.04.3\\x20LTS\\x20amd64', 'ID_FS_TYPE': 'iso9660', 'ID_FS_USAGE': 'filesystem', 'ID_FS_UUID': '2021-08-24-09-09-05-00', 'ID_FS_UUID_ENC': '2021-08-24-09-09-05-00', 'ID_FS_VERSION': 'Joliet Extension', 'ID_MODEL': 'QEMU_DVD-ROM', 'ID_MODEL_ENC': 'QEMU\\x20DVD-ROM\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20\\x20', 'ID_PART_TABLE_TYPE': 'dos', 'ID_PART_TABLE_UUID': '7fcaeaa1', 'ID_PATH': 'pci-0000:00:01.1-ata-2', 'ID_PATH_TAG': 'pci-0000_00_01_1-ata-2', 'ID_REVISION': '0.10', 'ID_SCSI': '1', 'ID_SCSI_INQUIRY': '1', 'ID_SERIAL': 'QEMU_DVD-ROM_QM00004', 'ID_SERIAL_SHORT': 'QM00004', 'ID_TYPE': 'cd', 'ID_VENDOR': 'QEMU', 'ID_VENDOR_ENC': 'QEMU\\x20\\x20\\x20\\x20', 'MAJOR': '11', 'MINOR': '0', 'SCSI_MODEL': 'QEMU_DVD-ROM', 'SCSI_MODEL_ENC': 'QEMU\\x20DVD-ROM\\x20\\x20\\x20\\x20', 'SCSI_REVISION': '0.10', 'SCSI_TPGS': '0', 'SCSI_TYPE': 'cd/dvd', 'SCSI_VENDOR': 'QEMU', 'SCSI_VENDOR_ENC': 'QEMU\\x20\\x20\\x20\\x20', 'SUBSYSTEM': 'block', 'SYSTEMD_MOUNT_DEVICE_BOUND': '1', 'TAGS': ':seat:systemd:uaccess:', 'USEC_INITIALIZED': '2200698', 'attrs': {'alignment_offset': '0', 'bdi': None, 'capability': '119', 'dev': '11:0', 'device': None, 'discard_alignment': '0', 'events': 'media_change eject_request', 'events_async': '', 'events_poll_msecs': '-1', 'ext_range': '1', 'hidden': '0', 'inflight': '       0        0', 'range': '1', 'removable': '1', 'ro': '0', 'size': '1261371392', 'stat': '   10481       41  2459132    57762        0        0        0        0        0    42824    42344        0        0        0        0', 'subsystem': 'block', 'uevent': 'MAJOR=11\nMINOR=0\nDEVNAME=sr0\nDEVTYPE=disk'}, 'partitiontable': {'label': 'dos', 'id': '0x7fcaeaa1', 'device': '/dev/sr0', 'unit': 'sectors', 'partitions': [{'node': '/dev/sr0p1', 'start': 0, 'size': 2463616, 'type': '0', 'bootable': True}, {'node': '/dev/sr0p2', 'start': 656164, 'size': 8000, 'type': 'ef'}]}}, '/dev/xvda': {'DEVNAME': '/dev/xvda', 'DEVPATH': '/devices/vbd-768/block/xvda', 'DEVTYPE': 'disk', 'MAJOR': '202', 'MINOR': '0', 'SUBSYSTEM': 'block', 'TAGS': ':systemd:', 'USEC_INITIALIZED': '1980128', 'attrs': {'alignment_offset': '0', 'bdi': None, 'capability': '10', 'dev': '202:0', 'device': None, 'discard_alignment': '0', 'events': '', 'events_async': '', 'events_poll_msecs': '-1', 'ext_range': '16', 'hidden': '0', 'inflight': '       0        0', 'range': '16', 'removable': '0', 'ro': '0', 'size': '53687091200', 'stat': '     588        0    21120       77        0        0        0        0        0      136        0        0        0        0        0', 'subsystem': 'block', 'uevent': 'MAJOR=202\nMINOR=0\nDEVNAME=xvda\nDEVTYPE=disk'}}}, dasd={})
2021-11-12 09:43:37,846 DEBUG subiquity.models.filesystem:1121 exclusions set()
2021-11-12 09:43:42,083 DEBUG subiquity.client.controllers.filesystem:247 FilesystemController.finish next_screen
2021-11-12 09:43:42,083 DEBUG subiquity.models.filesystem:1186 mountpoints {'/': 'mount-1', '/boot': 'mount-0'}
2021-11-12 09:43:42,093 INFO subiquity/Filesystem:105 finish: completed SUCCESS
2021-11-12 09:43:42,093 INFO subiquity/Identity:100 start: starting UI
2021-11-12 09:43:42,097 DEBUG subiquity.client.client:449 showing InstallConfirmation over <FilesystemView selectable box/flow widget>
2021-11-12 09:43:44,763 INFO subiquity/Identity:100 start: starting UI
2021-11-12 09:44:20,896 DEBUG subiquity.client.controllers.identity:49 IdentityController.done next_screen user_spec=IdentityData(realname='ubuntu', username='ubuntu', hostname='ubuntu')
2021-11-12 09:44:20,907 INFO subiquity/Identity:105 finish: completed SUCCESS
2021-11-12 09:44:20,907 INFO subiquity/SSH:100 start: starting UI
2021-11-12 09:50:58,541 DEBUG subiquity.ui.ssh:272 User input: {'install_server': True, 'ssh_import_id': None}
2021-11-12 09:50:58,541 DEBUG subiquity.client.controllers.ssh:127 SSHController.done next_screen result=SSHData(install_server=True, allow_pw=True, authorized_keys=[])
2021-11-12 09:50:58,549 INFO subiquity/SSH:105 finish: completed SUCCESS
2021-11-12 09:50:58,549 INFO subiquity/SnapList:100 start: starting UI
2021-11-12 09:50:58,553 INFO subiquity/SnapList:105 finish: (skipped) SUCCESS
2021-11-12 09:50:58,553 DEBUG subiquitycore.tui:228 skipping screen SnapList
2021-11-12 09:50:58,553 INFO subiquity/Progress:100 start: starting UI