Attachment 1489815 Details for Bug 1635514 – anaconda log

anaconda log

anaconda.log (text/plain), 55.83 KB, created by Paul Dufresne on 2018-10-03 07:39:15 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Paul Dufresne

Created: 2018-10-03 07:39:15 UTC

Size: 55.83 KB

patch

obsolete

>07:06:27,699 INF main: /sbin/anaconda 29.24.3-1.fc29
>07:06:28,069 INF isys: 4100992 kB (4004 MB) are available
>07:06:28,102 INF startup_utils: check_memory(): total:4004, needed:320, graphical:410
>07:06:28,115 INF main: anaconda called with cmdline = ['/sbin/anaconda']
>07:06:28,115 INF main: Default encoding = utf-8 
>07:06:28,143 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-CcGCDlibh1,guid=43516912b4ee2340c0b08f705bb46a74.
>07:06:28,685 INF startup_utils: Waiting 600 sec for modules to be started.
>07:06:29,688 INF startup_utils: Waiting 599 sec for modules to be started.
>07:06:30,692 INF startup_utils: Waiting 598 sec for modules to be started.
>07:06:31,696 INF startup_utils: Waiting 597 sec for modules to be started.
>07:06:32,700 INF startup_utils: Waiting 596 sec for modules to be started.
>07:06:33,707 INF startup_utils: Waiting 595 sec for modules to be started.
>07:06:34,857 INF startup_utils: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>07:06:34,941 ERR core.util: Failed to import module docker from path /usr/share/anaconda/addons/com_redhat_docker/ks/docker.py in collect: No module named 'pyanaconda.iutil'
>07:06:35,480 WRN kickstart: Command firstboot will be parsed in DBus module.
>07:06:35,484 WRN kickstart: Command firewall will be parsed in DBus module.
>07:06:35,517 DBG localization: setting locale to: en_US.UTF-8
>07:06:35,543 DBG network: devices found ['enp3s0']
>07:06:35,563 DBG network: ensure single initramfs connections
>07:06:35,677 DBG network: apply kickstart
>07:06:35,681 DBG network: create missing ifcfg files
>07:06:35,848 DBG network: ifcfg file for enp3s0 not found
>07:06:36,242 DBG network: dumping ifcfg file for enp3s0 from default autoconnection 0d70a267-dad1-327d-84a3-1128cdddcb7f
>07:06:36,243 DBG network: missing ifcfgs created for devices ['enp3s0']
>07:06:36,273 DBG network: set real ONBOOT value
>07:06:36,279 INF threading: Running Thread: AnaWaitForConnectingNMThread (139898455025408)
>07:06:36,281 DBG anaconda: setting display mode to GUI
>07:06:36,299 INF anaconda: Display mode is set to 'interactive graphical mode'.
>07:06:36,306 INF isys: 4100992 kB (4004 MB) are available
>07:06:36,355 INF startup_utils: check_memory(): total:4004, needed:320, graphical:410
>07:06:36,356 DBG core.util: Setting timeout 60 seconds for starting X.
>07:06:36,379 INF network: got 0 NTP servers from DHCP
>07:06:36,397 INF threading: Thread Done: AnaWaitForConnectingNMThread (139898455025408)
>07:06:39,590 DBG core.util: X server has signalled a successful start.
>07:06:39,750 INF display: spice-vdagent exited with status 1
>07:06:41,327 DBG installclass: Searching /usr/lib64/python3.7/site-packages/pyanaconda/installclasses.
>07:06:41,346 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>07:06:41,347 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>07:06:41,347 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>07:06:41,347 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>07:06:41,348 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>07:06:41,348 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>07:06:41,349 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>07:06:41,349 DBG installclass: Found Fedora (DefaultInstallClass).
>07:06:41,350 INF installclass: Using a visible install class Fedora (FedoraBaseInstallClass).
>07:06:41,350 DBG storage: trying to set new default luks version to 'luks1'
>07:06:41,737 INF bootloader: bootloader GRUB2 on X86 platform
>07:06:41,745 INF autopart: Detected 3.91 GiB of memory
>07:06:41,753 INF autopart: Suggested swap size (3.91 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>07:06:41,764 INF autopart: Swap attempt of 0.0
>07:06:41,768 INF bootloader: bootloader GRUB2 on X86 platform
>07:06:41,925 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>07:06:41,928 INF threading: Running Thread: AnaStorageThread (139898352486144)
>07:06:41,935 INF threading: Running Thread: AnaTimeInitThread (139898344093440)
>07:06:42,026 DBG payload: Restarting payload thread
>07:06:42,032 INF threading: Running Thread: AnaPayloadRestartThread (139898334914304)
>07:06:42,032 INF geoloc: Geolocation is enabled.
>07:06:42,037 INF threading: Running Thread: AnaPayloadThread (139898326521600)
>07:06:42,037 INF threading: Thread Done: AnaPayloadRestartThread (139898334914304)
>07:06:42,038 DBG payload: Updating payload thread state: 0
>07:06:42,039 DBG payload: Updating payload thread state: 1
>07:06:42,040 INF threading: Running Thread: AnaGeolocationRefreshThread (139898318128896)
>07:06:42,053 INF geoloc: Starting geolocation lookup
>07:06:42,054 INF geoloc: Geolocation provider: Fedora GeoIP
>07:06:42,874 INF geoloc: Geolocation lookup finished in 0.8 seconds
>07:06:42,957 INF geoloc: got results from geolocation
>07:06:42,958 INF threading: Thread Done: AnaGeolocationRefreshThread (139898318128896)
>07:06:44,635 DBG ui.gui: Detected primary monitor: 1280x1024 86dpix 86dpiy
>07:06:45,581 DBG localization: setting locale to: en_CA.UTF-8
>07:06:45,633 DBG localization: setting locale to: en_US.UTF-8
>07:06:45,652 DBG localization: setting locale to: en_CA.UTF-8
>07:06:45,731 DBG ui.common: Entered spoke: WelcomeLanguageSpoke
>07:06:45,738 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/Gdk.py:346: DeprecationWarning: Gdk.Cursor.new is deprecated
>  return cls.new(*args, **kwds)
>
>07:06:52,584 DBG storage: protected device spec LABEL=Fedora-SB-ostree-x86_64-29 resolved to sdb
>07:06:53,062 DBG storage: blkid.tab devs: []
>07:06:53,063 DBG storage: crypttab maps: []
>07:06:53,063 DBG storage: parsing /mnt/sysimage/etc/fstab
>07:06:54,562 INF threading: Thread Done: AnaStorageThread (139898352486144)
>07:06:54,564 DBG payload: Updating payload thread state: 2
>07:06:54,565 DBG payload: Updating payload thread state: 6
>07:06:54,565 INF threading: Thread Done: AnaPayloadThread (139898326521600)
>07:06:55,004 INF threading: Thread Done: AnaTimeInitThread (139898344093440)
>07:07:28,552 DBG localization: setting locale to: en_CA.UTF-8
>07:07:28,561 INF ui.gui.spokes.welcome: using timezone determined by geolocation
>07:07:28,772 DBG ui.gui.spokes.network: network standalone spoke (init): completed: ['enp3s0']
>07:07:28,800 DBG ui.common: Left spoke: WelcomeLanguageSpoke
>07:07:28,827 INF lifecycle: Adding controller: SummaryHub
>07:07:31,793 INF threading: Running Thread: AnaAddLayoutsInitThread (139898318128896)
>07:07:31,802 DBG ui.gui.utils: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f3c9c438fd0>> on <list object at 0x7f3c9c47d248>
>07:07:31,808 INF threading: Running Thread: AnaGtkBatchPre1 (139898344093440)
>07:07:31,813 INF threading: Thread Done: AnaGtkBatchPre1 (139898344093440)
>07:07:31,886 INF threading: Running Thread: AnaKeyboardThread (139898344093440)
>07:07:31,988 INF lifecycle: Module initialized: LangsupportSpoke
>07:07:36,039 INF threading: Running Thread: AnaNTPserver1 (139898352486144)
>07:07:36,060 INF threading: Running Thread: AnaDateTimeThread (139898326521600)
>07:07:36,245 INF ui.gui.spokes.software_selection: using environment from kickstart: None
>07:07:36,288 INF threading: Thread Done: AnaNTPserver1 (139898352486144)
>07:07:36,314 INF threading: Running Thread: AnaStorageWatcher (139898352486144)
>07:07:36,326 DBG ui.gui.hubs: incomplete spokes: [StorageSpoke]
>07:07:36,345 INF lifecycle: Module initialized: StorageSpoke
>07:07:36,346 INF threading: Thread Done: AnaStorageWatcher (139898352486144)
>07:07:36,405 INF threading: Running Thread: AnaCustomStorageInit (139898352486144)
>07:07:36,566 INF lifecycle: Module initialized: BlivetGuiSpoke
>07:07:36,761 INF lifecycle: Module initialized: FilterSpoke
>07:07:36,916 DBG ui.gui.spokes.network: can't get remote connection of active connection of device enp3s0
>07:07:36,917 DBG ui.gui.spokes.network: device configuration added: connection 0d70a267-dad1-327d-84a3-1128cdddcb7f device enp3s0
>07:07:36,926 DBG ui.gui.spokes.network: not adding connection 0d70a267-dad1-327d-84a3-1128cdddcb7f, already in list
>07:07:36,949 INF lifecycle: Module initialized: NetworkSpoke
>07:07:37,198 INF lifecycle: Initialization of all modules (8) has been started.
>07:07:37,203 DBG ui.gui.hubs: Starting event loop for hub SummaryHub
>07:07:37,248 DBG ui.common: Entered hub: SummaryHub
>07:07:37,496 DBG ui.gui.hubs: spoke is not ready: KeyboardSpoke
>07:07:37,500 DBG ui.gui.hubs: setting KeyboardSpoke status to: Getting list of layouts...
>07:07:37,501 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>07:07:37,503 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>07:07:37,691 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>07:07:37,972 INF lifecycle: Module initialized: CustomPartitioningSpoke
>07:07:37,972 INF threading: Thread Done: AnaCustomStorageInit (139898352486144)
>02:07:38,000 INF isys: System time set to Wed Oct  3 07:07:38 2018 UTC
>02:07:38,000 INF isys: System time set to Wed Oct  3 07:07:38 2018 UTC
>02:07:38,000 INF isys: System time set to Wed Oct  3 07:07:38 2018 UTC
>02:07:38,009 INF lifecycle: Module initialized: DatetimeSpoke
>02:07:38,010 INF threading: Thread Done: AnaDateTimeThread (139898326521600)
>02:07:38,024 DBG ui.gui.hubs: spoke is ready: DatetimeSpoke
>02:07:41,976 DBG ui.gui.utils: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f3c9c438fd0>> on <list object at 0x7f3c9c47d248>
>02:07:41,977 INF threading: Thread Done: AnaAddLayoutsInitThread (139898318128896)
>02:07:41,977 INF lifecycle: Module initialized: KeyboardSpoke
>02:07:41,978 INF lifecycle: All modules have been initialized.
>02:07:41,978 INF threading: Thread Done: AnaKeyboardThread (139898344093440)
>02:07:41,987 DBG ui.gui.hubs: spoke is ready: KeyboardSpoke
>02:07:47,168 DBG ui.common: Entered spoke: StorageSpoke
>02:08:05,811 INF ui.gui.spokes.storage: Partitioning method changed from auto to custom.
>02:08:05,811 INF ui.gui.spokes.storage: Rolling back planed storage configuration changes.
>02:08:05,958 INF threading: Running Thread: AnaExecuteStorageThread (139898344093440)
>02:08:05,958 DBG ui.common: Left spoke: StorageSpoke
>02:08:05,993 DBG storage: clearpart: looking at sda4
>02:08:05,994 DBG storage: clearpart: looking at sda3
>02:08:05,999 DBG storage: clearpart: looking at sda2
>02:08:06,000 DBG storage: clearpart: looking at sda1
>02:08:06,023 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run True.
>02:08:06,055 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:08:06,062 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:08:06,078 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:08:06,079 DBG bootloader: new disk order: []
>02:08:06,089 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>02:08:06,090 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>02:08:06,095 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:08:06,173 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:08:06,202 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:08:06,208 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:08:06,224 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:08:06,225 DBG bootloader: new disk order: []
>02:08:06,240 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>02:08:06,240 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>02:08:06,241 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:08:06,314 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:08:06,315 DBG bootloader: _is_valid_size(sda) returning True
>02:08:06,315 DBG bootloader: _is_valid_location(sda) returning True
>02:08:06,316 DBG bootloader: _is_valid_format(sda) returning True
>02:08:06,316 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:08:06,334 INF threading: Thread Done: AnaExecuteStorageThread (139898344093440)
>02:08:06,415 DBG ui.gui.spokes.custom_storage: ui: devices=['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sda1', 'sda2', 'sda3', 'sda4', 'sr0']
>02:08:06,416 DBG ui.gui.spokes.custom_storage: ui: unused=['sda3', 'sda1']
>02:08:06,416 DBG ui.gui.spokes.custom_storage: ui: new_devices=[]
>02:08:06,562 DBG ui.gui.spokes.custom_storage: page clicked: New Fedora 29 Installation
>02:08:06,563 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora 29 Installation
>02:08:06,564 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora 29 Installation
>02:08:06,598 DBG ui.common: Entered spoke: CustomPartitioningSpoke
>02:08:06,614 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>02:08:06,614 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>02:08:06,627 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:08:41,321 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:08:41,333 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:08:41,336 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:08:41,343 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:08:41,343 DBG bootloader: new disk order: []
>02:08:41,348 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:08:41,491 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
> and disks_only=True
>02:08:41,497 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:08:41,515 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:08:41,516 DBG bootloader: _is_valid_size(sda) returning True
>02:08:41,516 DBG bootloader: _is_valid_location(sda) returning True
>02:08:41,516 DBG bootloader: _is_valid_format(sda) returning True
>02:08:41,517 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:08:41,524 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:08:41,525 DBG bootloader: _is_valid_size(sda) returning True
>02:08:41,525 DBG bootloader: _is_valid_location(sda) returning True
>02:08:41,526 DBG bootloader: _is_valid_format(sda) returning True
>02:08:41,526 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:08:41,530 DBG storage_utils: Available memory: 3 GiB
>02:08:41,582 DBG ui.helpers: Storage check started with constraints {'min_ram': 410, 'min_root': Size (250 MiB), 'min_partition_sizes': {'/usr': Size (250 MiB), '/tmp': Size (50 MiB), '/var': Size (384 MiB), '/home': Size (100 MiB), '/boot': Size (200 MiB)}, 'must_be_on_linuxfs': {'/home', '/var', '/usr/share', '/', '/tmp', '/usr/lib', '/usr'}, 'must_be_on_root': {'/sbin', '/proc', '/root', '/etc', '/dev', 'lost+found', '/lib', '/mnt', '/bin'}, 'swap_is_recommended': True, 'luks2_min_ram': Size (128 MiB)}.
>02:08:41,584 DBG ui.helpers: Run sanity check verify_root.
>02:08:41,585 DBG ui.helpers: Found sanity error: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>02:08:41,586 DBG ui.helpers: Run sanity check verify_s390_constraints.
>02:08:41,586 DBG ui.helpers: Run sanity check verify_partition_sizes.
>02:08:41,586 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>02:08:41,587 DBG ui.helpers: Run sanity check verify_bootloader.
>02:08:41,587 DBG ui.helpers: Found sanity error: You have not created a bootable partition.
>02:08:41,588 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>02:08:41,588 DBG ui.helpers: Run sanity check verify_swap.
>02:08:41,588 DBG ui.helpers: Run sanity check verify_swap_uuid.
>02:08:41,589 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>02:08:41,589 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>02:08:41,590 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>02:08:41,590 DBG ui.helpers: Run sanity check verify_luks2_memory_requirements.
>02:08:41,590 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>02:08:41,591 DBG ui.helpers: Storage check finished with failure(s).
>02:08:41,591 ERR ui.helpers: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>02:08:41,592 ERR ui.helpers: You have not created a bootable partition.
>02:08:41,605 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>02:08:41,606 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>02:08:41,616 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:08:53,601 DBG ui.common: Left spoke: CustomPartitioningSpoke
>02:08:53,822 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:08:59,484 DBG ui.common: Entered spoke: StorageSpoke
>02:09:06,002 INF threading: Running Thread: AnaExecuteStorageThread (139898344093440)
>02:09:06,002 DBG ui.common: Left spoke: StorageSpoke
>02:09:06,037 DBG storage: clearpart: looking at sda4
>02:09:06,038 DBG storage: clearpart: looking at sda3
>02:09:06,038 DBG storage: clearpart: looking at sda2
>02:09:06,039 DBG storage: clearpart: looking at sda1
>02:09:06,066 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run True.
>02:09:06,098 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:09:06,106 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:09:06,120 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:09:06,122 DBG bootloader: new disk order: []
>02:09:06,127 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:09:06,366 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
>existing 3.73 GiB disk sdb (3) with existing iso9660 filesystem
> and disks_only=True
>02:09:06,372 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:09:06,392 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:09:06,404 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:09:06,407 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:09:06,414 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:09:06,415 DBG bootloader: new disk order: []
>02:09:06,420 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:09:06,509 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
>existing 3.73 GiB disk sdb (3) with existing iso9660 filesystem
> and disks_only=True
>02:09:06,516 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:09:06,534 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:09:06,535 DBG bootloader: _is_valid_size(sda) returning True
>02:09:06,535 DBG bootloader: _is_valid_location(sda) returning True
>02:09:06,536 DBG bootloader: _is_valid_format(sda) returning True
>02:09:06,536 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:09:06,556 INF threading: Thread Done: AnaExecuteStorageThread (139898344093440)
>02:09:06,643 DBG ui.gui.spokes.custom_storage: ui: devices=['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sda1', 'sda2', 'sda3', 'sda4', 'sr0']
>02:09:06,644 DBG ui.gui.spokes.custom_storage: ui: unused=['sda1', 'sda3']
>02:09:06,645 DBG ui.gui.spokes.custom_storage: ui: new_devices=[]
>02:09:06,672 DBG ui.gui.spokes.custom_storage: page clicked: New Fedora 29 Installation
>02:09:06,673 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora 29 Installation
>02:09:06,674 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora 29 Installation
>02:09:06,689 DBG ui.common: Entered spoke: CustomPartitioningSpoke
>02:09:06,700 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>02:09:06,701 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>02:09:06,711 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:09:11,232 DBG ui.gui.spokes.custom_storage: running automatic partitioning
>02:09:11,237 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:09:11,248 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:09:11,251 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:09:11,258 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:09:11,259 DBG bootloader: new disk order: []
>02:09:11,265 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:09:11,345 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
> and disks_only=True
>02:09:11,351 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:09:11,366 INF autopart: Detected 3.91 GiB of memory
>02:09:11,367 INF autopart: Swap attempt of 3.91 GiB
>02:09:11,368 DBG autopart: do_autopart: True
>02:09:11,368 DBG autopart: encrypted_autopart: False
>02:09:11,369 DBG autopart: autopart_type: 2
>02:09:11,369 DBG autopart: clear_part_type: 0
>02:09:11,369 DBG autopart: clear_part_disks: ['sda']
>02:09:11,370 DBG autopart: autopart_requests:
>PartSpec instance (0x7f3c9e142e80) -- 
>  mountpoint = /  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024 MiB  max_size = 50 GiB  grow = True
>PartSpec instance (0x7f3c9e104978) -- 
>  mountpoint = /home  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500 MiB  max_size = None  grow = True
>PartSpec instance (0x7f3c9e104b00) -- 
>  mountpoint = None  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = biosboot  encrypted = False
>  size = 1024 KiB  max_size = None  grow = False
>PartSpec instance (0x7f3c9e104ba8) -- 
>  mountpoint = /boot  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = ext4  encrypted = False
>  size = 1024 MiB  max_size = None  grow = False
>PartSpec instance (0x7f3c9e104a20) -- 
>  mountpoint = None  lv = True  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 3.91 GiB  max_size = None  grow = False
>
>02:09:11,371 DBG autopart: storage.disks: ['sda']
>02:09:11,372 DBG autopart: storage.partitioned: ['sda']
>02:09:11,373 DBG autopart: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sda1', 'sda2', 'sda3', 'sda4', 'sr0']
>02:09:11,373 DBG autopart: boot disk: sda
>02:09:11,403 DBG autopart: candidate disks: [DiskDevice instance (0x7f3c9e1082e8) --
>  name = sda  status = True  id = 18
>  children = ['existing 14.65 GiB partition sda1 (28)',
> 'existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem',
> 'existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem',
> 'existing 3 GiB partition sda4 (58) with existing swap']
>  parents = []
>  uuid = None  size = 232.89 GiB
>  format = existing msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /sys/devices/pci0000:00/0000:00:1f.2/ata2/host1/target1:0:0/1:0:0:0/block/sda
>  target size = 232.89 GiB  path = /dev/sda
>  format args = []  original_format = disklabel  removable = False  wwn = 5000c50051b52488]
>02:09:11,411 DBG autopart: devs: [PartitionDevice instance (0x7f3c9e1375c0) --
>  name = req0  status = False  id = 349
>  children = []
>  parents = []
>  uuid = None  size = 500 MiB
>  format = non-existent lvmpv
>  major = 0  minor = 0  exists = False  protected = False
>  sysfs path = 
>  target size = 500 MiB  path = /dev/req0
>  format args = []  original_format = lvmpv  grow = True  max size = 0 B  bootable = None
>  part type = None  primary = False  start sector = None  end sector = None
>  parted_partition = None
>  disk = None
>]
>02:09:11,417 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:09:11,418 DBG bootloader: _is_valid_size(sda) returning True
>02:09:11,419 DBG bootloader: _is_valid_location(sda) returning True
>02:09:11,419 DBG bootloader: _is_valid_format(sda) returning True
>02:09:11,420 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:09:11,421 INF autopart: skipping unneeded stage1 biosboot request
>02:09:11,421 DBG autopart: PartSpec instance (0x7f3c9e104b00) -- 
>  mountpoint = None  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = biosboot  encrypted = False
>  size = 1024 KiB  max_size = None  grow = False
>
>02:09:11,422 DBG autopart: existing 232.89 GiB disk sda (18) with existing msdos disklabel
>02:09:11,463 ERR ui.gui.spokes.custom_storage: do_autopart failed: Unable to allocate requested partition scheme.
>02:09:11,543 DBG ui.gui.spokes.custom_storage: finished automatic partitioning
>02:09:11,550 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:09:11,551 DBG bootloader: _is_valid_size(sda) returning True
>02:09:11,552 DBG bootloader: _is_valid_location(sda) returning True
>02:09:11,552 DBG bootloader: _is_valid_format(sda) returning True
>02:09:11,553 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:09:11,556 DBG storage_utils: Available memory: 3 GiB
>02:09:11,604 DBG ui.gui.spokes.custom_storage: Storage check started with constraints {'min_ram': 410, 'min_root': Size (250 MiB), 'min_partition_sizes': {'/usr': Size (250 MiB), '/tmp': Size (50 MiB), '/var': Size (384 MiB), '/home': Size (100 MiB), '/boot': Size (200 MiB)}, 'must_be_on_linuxfs': {'/home', '/var', '/usr/share', '/', '/tmp', '/usr/lib', '/usr'}, 'must_be_on_root': {'/sbin', '/proc', '/root', '/etc', '/dev', 'lost+found', '/lib', '/mnt', '/bin'}, 'swap_is_recommended': True, 'luks2_min_ram': Size (128 MiB)}.
>02:09:11,605 DBG ui.gui.spokes.custom_storage: Run sanity check verify_root.
>02:09:11,605 DBG ui.gui.spokes.custom_storage: Found sanity error: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>02:09:11,605 DBG ui.gui.spokes.custom_storage: Run sanity check verify_s390_constraints.
>02:09:11,606 DBG ui.gui.spokes.custom_storage: Run sanity check verify_partition_sizes.
>02:09:11,606 DBG ui.gui.spokes.custom_storage: Run sanity check verify_partition_format_sizes.
>02:09:11,607 DBG ui.gui.spokes.custom_storage: Run sanity check verify_bootloader.
>02:09:11,607 DBG ui.gui.spokes.custom_storage: Found sanity error: You have not created a bootable partition.
>02:09:11,607 DBG ui.gui.spokes.custom_storage: Run sanity check verify_gpt_biosboot.
>02:09:11,608 DBG ui.gui.spokes.custom_storage: Run sanity check verify_swap.
>02:09:11,609 DBG ui.gui.spokes.custom_storage: Run sanity check verify_swap_uuid.
>02:09:11,609 DBG ui.gui.spokes.custom_storage: Run sanity check verify_mountpoints_on_linuxfs.
>02:09:11,609 DBG ui.gui.spokes.custom_storage: Run sanity check verify_mountpoints_on_root.
>02:09:11,610 DBG ui.gui.spokes.custom_storage: Skipped sanity check verify_luks_devices_have_key.
>02:09:11,610 DBG ui.gui.spokes.custom_storage: Run sanity check verify_luks2_memory_requirements.
>02:09:11,611 DBG ui.gui.spokes.custom_storage: Run sanity check verify_mounted_partitions.
>02:09:11,611 DBG ui.gui.spokes.custom_storage: Storage check finished with failure(s).
>02:09:11,611 ERR ui.gui.spokes.custom_storage: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>02:09:11,612 ERR ui.gui.spokes.custom_storage: You have not created a bootable partition.
>02:09:11,612 ERR ui.gui.spokes.custom_storage: do_autopart failed: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>You have not created a bootable partition.
>02:09:11,678 DBG ui.gui.spokes.custom_storage: refreshing ui
>02:09:11,691 DBG ui.gui.spokes.custom_storage: ui: devices=['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sda1', 'sda2', 'sda3', 'sda4', 'sr0']
>02:09:11,692 DBG ui.gui.spokes.custom_storage: ui: unused=['sda3', 'sda1']
>02:09:11,692 DBG ui.gui.spokes.custom_storage: ui: new_devices=[]
>02:09:11,725 DBG ui.gui.spokes.custom_storage: page clicked: New Fedora 29 Installation
>02:09:11,726 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora 29 Installation
>02:09:11,727 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora 29 Installation
>02:09:11,727 DBG ui.gui.spokes.custom_storage: finished refreshing ui
>02:09:11,728 DBG ui.gui.spokes.custom_storage: updating space display
>02:09:11,737 DBG ui.gui.spokes.custom_storage: finished updating space display
>02:09:17,056 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:09:17,068 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:09:17,071 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:09:17,078 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:09:17,078 DBG bootloader: new disk order: []
>02:09:17,083 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:09:17,164 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
> and disks_only=True
>02:09:17,169 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:09:17,186 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:09:17,186 DBG bootloader: _is_valid_size(sda) returning True
>02:09:17,187 DBG bootloader: _is_valid_location(sda) returning True
>02:09:17,187 DBG bootloader: _is_valid_format(sda) returning True
>02:09:17,188 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:09:17,195 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:09:17,196 DBG bootloader: _is_valid_size(sda) returning True
>02:09:17,196 DBG bootloader: _is_valid_location(sda) returning True
>02:09:17,197 DBG bootloader: _is_valid_format(sda) returning True
>02:09:17,197 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:09:17,200 DBG storage_utils: Available memory: 3 GiB
>02:09:17,246 DBG ui.helpers: Storage check started with constraints {'min_ram': 410, 'min_root': Size (250 MiB), 'min_partition_sizes': {'/usr': Size (250 MiB), '/tmp': Size (50 MiB), '/var': Size (384 MiB), '/home': Size (100 MiB), '/boot': Size (200 MiB)}, 'must_be_on_linuxfs': {'/home', '/var', '/usr/share', '/', '/tmp', '/usr/lib', '/usr'}, 'must_be_on_root': {'/sbin', '/proc', '/root', '/etc', '/dev', 'lost+found', '/lib', '/mnt', '/bin'}, 'swap_is_recommended': True, 'luks2_min_ram': Size (128 MiB)}.
>02:09:17,247 DBG ui.helpers: Run sanity check verify_root.
>02:09:17,247 DBG ui.helpers: Found sanity error: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>02:09:17,248 DBG ui.helpers: Run sanity check verify_s390_constraints.
>02:09:17,248 DBG ui.helpers: Run sanity check verify_partition_sizes.
>02:09:17,249 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>02:09:17,249 DBG ui.helpers: Run sanity check verify_bootloader.
>02:09:17,249 DBG ui.helpers: Found sanity error: You have not created a bootable partition.
>02:09:17,250 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>02:09:17,250 DBG ui.helpers: Run sanity check verify_swap.
>02:09:17,251 DBG ui.helpers: Run sanity check verify_swap_uuid.
>02:09:17,251 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>02:09:17,252 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>02:09:17,252 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>02:09:17,252 DBG ui.helpers: Run sanity check verify_luks2_memory_requirements.
>02:09:17,253 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>02:09:17,253 DBG ui.helpers: Storage check finished with failure(s).
>02:09:17,254 ERR ui.helpers: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>02:09:17,254 ERR ui.helpers: You have not created a bootable partition.
>02:09:17,266 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>02:09:17,267 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>02:09:17,276 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:09:23,239 DBG ui.gui.spokes.custom_storage: info bar clicked: You have not defined a root partition (/), which is required for installation of Fedora to continue.
>You have not created a bootable partition. ((<AnacondaWidgets.SpokeWindow object at 0x7f3c9e4f3c60 (AnacondaSpokeWindow at 0x55cb22b70d80)>,))
>02:09:23,242 WRN misc: /usr/lib64/python3.7/site-packages/pyanaconda/ui/gui/spokes/custom_storage.py:2874: PyGTKDeprecationWarning: The keyword(s) "message_format" have been deprecated in favor of "text" respectively. See: https://wiki.gnome.org/PyGObject/InitializerDeprecations
>  message_format=str(self._error))
>
>02:09:23,242 WRN misc: /usr/lib64/python3.7/site-packages/pyanaconda/ui/gui/spokes/custom_storage.py:2874: PyGTKDeprecationWarning: The "flags" argument for dialog construction is deprecated. Please use initializer keywords: modal=True and/or destroy_with_parent=True. See: https://wiki.gnome.org/PyGObject/InitializerDeprecations
>  message_format=str(self._error))
>
>02:09:31,765 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:554: Warning: gsignal.c:2641: instance '0x55cb25b0e2d0' has no handler with id '23958'
>  return func(*args, **kwargs)
>
>02:09:31,766 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:554: Warning: gsignal.c:2641: instance '0x55cb25b0e2d0' has no handler with id '23959'
>  return func(*args, **kwargs)
>
>02:09:51,485 DBG ui.common: Left spoke: CustomPartitioningSpoke
>02:09:51,708 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:09:54,226 DBG ui.common: Entered spoke: StorageSpoke
>02:10:04,368 INF ui.gui.spokes.storage: Partitioning method changed from custom to blivet-gui.
>02:10:04,368 INF ui.gui.spokes.storage: Rolling back planed storage configuration changes.
>02:10:04,503 INF threading: Running Thread: AnaExecuteStorageThread (139898344093440)
>02:10:04,503 DBG ui.common: Left spoke: StorageSpoke
>02:10:04,537 DBG storage: clearpart: looking at sda4
>02:10:04,539 DBG storage: clearpart: looking at sda3
>02:10:04,540 DBG storage: clearpart: looking at sda2
>02:10:04,544 DBG storage: clearpart: looking at sda1
>02:10:04,561 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run True.
>02:10:04,593 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:10:04,599 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:10:04,616 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:10:04,616 DBG bootloader: new disk order: []
>02:10:04,624 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:10:04,960 DBG storage_utils: sda matches ['sda'] for devicetree=existing 3.73 GiB disk sdb (3) with existing iso9660 filesystem
>existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
> and disks_only=True
>02:10:04,966 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:10:05,006 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:10:05,018 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:10:05,021 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:10:05,027 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:10:05,028 DBG bootloader: new disk order: []
>02:10:05,033 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:10:05,119 DBG storage_utils: sda matches ['sda'] for devicetree=existing 3.73 GiB disk sdb (3) with existing iso9660 filesystem
>existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with existing ext4 filesystem
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
> and disks_only=True
>02:10:05,125 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:10:05,149 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:10:05,150 DBG bootloader: _is_valid_size(sda) returning True
>02:10:05,151 DBG bootloader: _is_valid_location(sda) returning True
>02:10:05,151 DBG bootloader: _is_valid_format(sda) returning True
>02:10:05,152 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:10:05,190 INF threading: Thread Done: AnaExecuteStorageThread (139898344093440)
>02:10:05,247 DBG ui.common: Entered spoke: BlivetGuiSpoke
>02:10:05,322 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>02:10:05,323 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>02:10:05,333 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:11:06,458 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>02:11:06,472 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>02:11:06,474 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>02:11:06,481 DBG kickstart.kickstart.bootloader: Applying drive order: []
>02:11:06,482 DBG bootloader: new disk order: []
>02:11:06,487 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>02:11:06,568 DBG storage_utils: sda matches ['sda'] for devicetree=existing 3.73 GiB disk sdb (3) with existing iso9660 filesystem
>existing 1024 MiB cdrom sr0 (13)
>existing 232.89 GiB disk sda (18) with existing msdos disklabel
>  existing 14.65 GiB partition sda1 (28)
>  existing 74.5 GiB partition sda2 (38) with existing ext4 filesystem
>  existing 81.05 GiB partition sda3 (48) with non-existent ext4 filesystem mounted at /
>  existing 3 GiB partition sda4 (58) with existing swap
>existing 0 B file /run/install/repo/images/install.img (68)
>  existing 0 B loop loop0 (72)
>existing 0 B file /LiveOS/rootfs.img (82)
>  existing 0 B loop loop1 (86) with existing ext4 filesystem
>    existing 8 GiB dm live-rw (110) with existing ext4 filesystem
>    existing 8 GiB dm live-base (120) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (96)
>  existing 0 B loop loop2 (100)
> and disks_only=True
>02:11:06,574 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>02:11:06,591 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:11:06,591 DBG bootloader: _is_valid_size(sda) returning True
>02:11:06,592 DBG bootloader: _is_valid_location(sda) returning True
>02:11:06,592 DBG bootloader: _is_valid_format(sda) returning True
>02:11:06,593 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:11:06,599 DBG bootloader: _is_valid_disklabel(sda) returning True
>02:11:06,600 DBG bootloader: _is_valid_size(sda) returning True
>02:11:06,601 DBG bootloader: _is_valid_location(sda) returning True
>02:11:06,601 DBG bootloader: _is_valid_format(sda) returning True
>02:11:06,602 DBG bootloader: is_valid_stage1_device(sda) returning True
>02:11:06,603 DBG bootloader: _is_valid_disklabel(sda3) returning True
>02:11:06,604 DBG bootloader: _is_valid_size(sda3) returning True
>02:11:06,604 DBG bootloader: _is_valid_partition(sda3) returning True
>02:11:06,605 DBG bootloader: _is_valid_format(sda3) returning True
>02:11:06,606 DBG bootloader: is_valid_stage2_device(sda3) returning True
>02:11:06,610 DBG storage_utils: Available memory: 2.99 GiB
>02:11:06,656 DBG ui.helpers: Storage check started with constraints {'min_ram': 410, 'min_root': Size (250 MiB), 'min_partition_sizes': {'/usr': Size (250 MiB), '/tmp': Size (50 MiB), '/var': Size (384 MiB), '/home': Size (100 MiB), '/boot': Size (200 MiB)}, 'must_be_on_linuxfs': {'/home', '/var', '/usr/share', '/', '/tmp', '/usr/lib', '/usr'}, 'must_be_on_root': {'/sbin', '/proc', '/root', '/etc', '/dev', 'lost+found', '/lib', '/mnt', '/bin'}, 'swap_is_recommended': True, 'luks2_min_ram': Size (128 MiB)}.
>02:11:06,656 DBG ui.helpers: Run sanity check verify_root.
>02:11:06,657 DBG ui.helpers: Run sanity check verify_s390_constraints.
>02:11:06,657 DBG ui.helpers: Run sanity check verify_partition_sizes.
>02:11:06,658 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>02:11:06,658 DBG ui.helpers: Run sanity check verify_bootloader.
>02:11:06,658 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>02:11:06,659 DBG ui.helpers: Run sanity check verify_swap.
>02:11:06,659 DBG ui.helpers: Run sanity check verify_swap_uuid.
>02:11:06,659 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>02:11:06,660 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>02:11:06,660 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>02:11:06,661 DBG ui.helpers: Run sanity check verify_luks2_memory_requirements.
>02:11:06,661 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>02:11:06,661 DBG ui.helpers: Storage check finished with success.
>02:11:06,774 DBG ui.gui.hubs: incomplete spokes: []
>02:11:06,776 INF ui.lib.space: fs space: 68.89 GiB  needed: 476.84 MiB
>02:11:06,778 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>02:11:06,779 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>02:11:06,791 INF ui.lib.space: fs space: 68.89 GiB  needed: 476.84 MiB
>02:11:06,792 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>02:11:12,302 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:554: Warning: gsignal.c:2641: instance '0x55cb25565ef0' has no handler with id '29591'
>  return func(*args, **kwargs)
>
>02:11:12,303 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:554: Warning: gsignal.c:2641: instance '0x55cb25565ef0' has no handler with id '29592'
>  return func(*args, **kwargs)
>
>02:11:12,307 DBG ui.common: Left spoke: BlivetGuiSpoke
>02:11:12,531 INF ui.lib.space: fs space: 68.89 GiB  needed: 476.84 MiB
>02:11:19,877 DBG ui.common: Left hub: SummaryHub
>02:11:19,905 INF lifecycle: Adding controller: ProgressHub
>02:11:19,935 INF lifecycle: Module initialized: PasswordSpoke
>02:11:19,956 DBG ui.gui.hubs: incomplete spokes: [PasswordSpoke]
>02:11:19,993 INF lifecycle: Module initialized: UserSpoke
>02:11:20,007 DBG ui.gui.hubs: incomplete spokes: [PasswordSpoke, UserSpoke]
>02:11:20,008 INF lifecycle: Initialization of all modules (2) has been started.
>02:11:20,009 INF lifecycle: All modules have been initialized.
>02:11:20,012 DBG ui.gui.hubs: Disabling event loop for hub SummaryHub
>02:11:20,013 DBG ui.gui.hubs: Starting event loop for hub ProgressHub
>02:11:20,014 INF threading: Running Thread: AnaInstallThread (139898318128896)
>02:11:20,031 DBG ui.common: Entered hub: ProgressHub
>02:11:20,042 INF installation: Top-level task queue: Installation queue
>Number of task queues: 9
>Number of tasks: 18
>Task & task group listing:
> Task: Save system time to HW clock
> Task queue: Installation environment setup
>  Task: Setup addons
> Task queue: Early storage configuration
>  Task: Insert custom storage to ksdata
>  Task: Run pre-storage tasks
>  Task: Activate filesystems
>  Task: Write early storage
> Task queue: Pre-install scripts
>  Task: Run %pre-install scripts
> Task queue: Realm discover
>  Task: Discover realm to join
> Task queue: Pre install tasks
>  Task: Setup authselect
>  Task: Setup firewall
>  Task: Setup network
>  Task: Setup timezone
>  Task: Copy /resolv.conf to sysroot
>  Task: Find additional packages & run preInstall()
> Task queue: Payload installation
>  Task: Install the payload
> Task queue: Late storage configuration
>  Task: Write late storage
> Task queue: Bootloader installation
>  Task: Install bootloader
> Task queue: Post-installation setup tasks
>  Task: Run post-installation setup tasks
>02:11:20,043 INF installation: Task started: Save system time to HW clock (1/18)
>02:11:20,151 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>02:11:22,504 INF progress: Save system time to HW clock
>02:11:22,505 DBG installation: Task completed: Save system time to HW clock (1/18) (2.5 s)
>02:11:22,506 INF installation: Queue started: Installation environment setup (1/9)
>02:11:22,507 INF progress: Setting up the installation environment
>02:11:22,507 INF installation: Task started: Setup addons (2/18)
>02:11:22,508 INF progress: Setup addons
>02:11:22,508 DBG installation: Task completed: Setup addons (2/18) (0.0 s)
>02:11:22,509 INF installation: Queue started: Early storage configuration (2/9)
>02:11:22,510 INF progress: Configuring storage
>02:11:22,510 INF installation: Task started: Insert custom storage to ksdata (3/18)
>02:11:22,570 INF storage: omitting ksdata: existing 232.89 GiB disk sda (18) with existing msdos disklabel
>02:11:22,577 INF progress: Insert custom storage to ksdata
>02:11:22,580 DBG installation: Task completed: Insert custom storage to ksdata (3/18) (0.1 s)
>02:11:22,580 INF installation: Task started: Run pre-storage tasks (4/18)
>02:11:22,581 INF progress: Run pre-storage tasks
>02:11:22,581 DBG installation: Task completed: Run pre-storage tasks (4/18) (0.0 s)
>02:11:22,582 INF installation: Task started: Activate filesystems (5/18)
>02:11:25,280 INF progress: Creating ext4 on /dev/sda3
>02:11:26,569 DBG ui.common: Entered spoke: PasswordSpoke
>02:11:34,187 INF storage: Skipping sda3
>02:11:35,114 DBG ui.common: Left spoke: PasswordSpoke
>02:11:35,139 DBG ui.gui.hubs: incomplete spokes: [UserSpoke]
>02:11:35,147 DBG ui.gui.hubs: incomplete spokes: []
>02:11:35,189 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>02:11:36,537 DBG ui.common: Entered spoke: UserSpoke
>02:11:38,293 INF progress: Activate filesystems
>02:11:38,294 DBG installation: Task completed: Activate filesystems (5/18) (15.7 s)
>02:11:38,295 INF installation: Task started: Write early storage (6/18)
>02:11:38,296 INF progress: Write early storage
>02:11:38,296 DBG installation: Task completed: Write early storage (6/18) (0.0 s)
>02:11:38,297 INF installation: Queue started: Pre-install scripts (3/9)
>02:11:38,297 INF progress: Running pre-installation scripts
>02:11:38,298 INF installation: Task started: Run %pre-install scripts (7/18)
>02:11:38,299 INF progress: Run %pre-install scripts
>02:11:38,299 DBG installation: Task completed: Run %pre-install scripts (7/18) (0.0 s)
>02:11:38,300 INF installation: Queue started: Realm discover (4/9)
>02:11:38,300 INF progress: Discovering realm to join
>02:11:38,301 INF installation: Task started: Discover realm to join (8/18)
>02:11:38,309 INF progress: Discover realm to join
>02:11:38,310 DBG installation: Task completed: Discover realm to join (8/18) (0.0 s)
>02:11:38,311 INF installation: Queue started: Pre install tasks (5/9)
>02:11:38,312 INF progress: Running pre-installation tasks
>02:11:38,312 INF installation: Task started: Setup authselect (9/18)
>02:11:38,320 INF progress: Setup authselect
>02:11:38,321 DBG installation: Task completed: Setup authselect (9/18) (0.0 s)
>02:11:38,321 INF installation: Task started: Setup firewall (10/18)
>02:11:38,327 INF progress: Setup firewall
>02:11:38,328 DBG installation: Task completed: Setup firewall (10/18) (0.0 s)
>02:11:38,329 INF installation: Task started: Setup network (11/18)
>02:11:38,360 INF progress: Setup network
>02:11:38,361 DBG installation: Task completed: Setup network (11/18) (0.0 s)
>02:11:38,362 INF installation: Task started: Setup timezone (12/18)
>02:11:38,425 INF progress: Setup timezone
>02:11:38,426 DBG installation: Task completed: Setup timezone (12/18) (0.1 s)
>02:11:38,427 INF installation: Task started: Copy /resolv.conf to sysroot (13/18)
>02:11:38,444 INF progress: Copy /resolv.conf to sysroot
>02:11:38,445 DBG installation: Task completed: Copy /resolv.conf to sysroot (13/18) (0.0 s)
>02:11:38,446 INF installation: Task started: Find additional packages & run preInstall() (14/18)
>02:11:38,448 DBG payload: added package requirement 'e2fsprogs' for storage, strong=True
>02:11:38,448 DBG payload: no package requirement added for realm
>02:11:38,449 DBG payload: added package requirement 'authselect' for authselect, strong=True
>02:11:38,449 DBG payload: added package requirement 'firewalld' for firewall, strong=True
>02:11:38,450 DBG payload: no package requirement added for network
>02:11:38,450 DBG payload: added package requirement 'chrony' for ntp, strong=False
>02:11:38,451 DBG payload: added package requirement 'grub2' for bootloader, strong=True
>02:11:38,455 DBG payload: added package requirement 'grub2-tools' for bootloader, strong=True
>02:11:38,456 DBG payload: no group requirement added for language groups
>02:11:38,457 DBG payload: no package requirement added for langpacks
>02:11:38,470 INF progress: Find additional packages & run preInstall()
>02:11:38,471 DBG installation: Task completed: Find additional packages & run preInstall() (14/18) (0.0 s)
>02:11:38,471 INF installation: Queue started: Payload installation (6/9)
>02:11:38,474 INF progress: Installing.
>02:11:38,474 INF installation: Task started: Install the payload (15/18)
>02:11:38,478 INF payload.rpmostreepayload: executing ostreesetup=<pykickstart.commands.ostreesetup.F21_OSTreeSetup object at 0x7f3ca5d72b38>
>02:12:00,122 INF ui.gui.spokes.user: Return to hub prevented by password checking rules.
>02:12:10,955 DBG ui.common: Left spoke: UserSpoke
>02:20:24,800 INF payload.rpmostreepayload: ostree pull: 6994 metadata, 96750 content objects imported
>02:20:26,667 INF payload.rpmostreepayload: ostree admin deploy starting
>02:21:04,441 DBG ihelp: starting yelp
>02:21:11,971 INF payload.rpmostreepayload: ostree admin deploy complete
>02:21:11,982 INF payload.rpmostreepayload: Copying bootloader data: grub2
>02:21:12,131 INF progress: Install the payload
>02:21:12,133 DBG installation: Task completed: Install the payload (15/18) (573.7 s)
>02:21:12,135 INF installation: Queue started: Late storage configuration (7/9)
>02:21:12,137 INF progress: Configuring storage
>02:21:12,139 INF installation: Task started: Write late storage (16/18)
>02:21:14,072 INF storage: not writing out mpath configuration
>02:21:14,074 INF progress: Write late storage
>02:21:14,074 DBG installation: Task completed: Write late storage (16/18) (1.9 s)
>02:21:14,075 INF installation: Queue started: Bootloader installation (8/9)
>02:21:14,078 INF progress: Installing boot loader
>02:21:14,079 INF installation: Task started: Install bootloader (17/18)
>02:21:14,079 INF bootloader: boot loader stage1 target device is sda
>02:21:14,080 INF bootloader: boot loader stage2 target device is sda3
>02:21:15,042 INF bootloader: bootloader.py: used boot args: resume=UUID=3ed5af1e-e215-4441-a764-927d8cf3ae59 rhgb quiet 
>02:21:18,105 ERR bootloader: bootloader.write failed: failed to write boot loader configuration
>02:21:18,107 WRN misc: /usr/lib64/python3.7/site-packages/pyanaconda/ui/gui/__init__.py:919: PyGTKDeprecationWarning: The keyword(s) "message_format" have been deprecated in favor of "text" respectively. See: https://wiki.gnome.org/PyGObject/InitializerDeprecations
>  message_format=message)
>
>02:21:18,110 WRN misc: /usr/lib64/python3.7/site-packages/pyanaconda/ui/gui/__init__.py:919: PyGTKDeprecationWarning: The "flags" argument for dialog construction is deprecated. Please use initializer keywords: modal=True and/or destroy_with_parent=True. See: https://wiki.gnome.org/PyGObject/InitializerDeprecations
>  message_format=message)
>
>02:24:12,463 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:554: Warning: gsignal.c:2641: instance '0x55cb25b0e5e0' has no handler with id '51000'
>  return func(*args, **kwargs)
>
>02:24:12,465 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:554: Warning: gsignal.c:2641: instance '0x55cb25b0e5e0' has no handler with id '51001'
>  return func(*args, **kwargs)
>
>02:24:12,467 INF progress: Install bootloader
>02:24:12,468 DBG installation: Task completed: Install bootloader (17/18) (178.4 s)
>02:24:12,469 INF installation: Queue started: Post-installation setup tasks (9/9)
>02:24:12,470 INF progress: Performing post-installation setup tasks
>02:24:12,470 INF installation: Task started: Run post-installation setup tasks (18/18)
>02:24:12,530 INF payload: Installation requirements: [('package', 'e2fsprogs', PayloadRequirement(id=e2fsprogs, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'authselect', PayloadRequirement(id=authselect, reasons=[PayloadRequirementReason(reason='authselect', strong=True)])), ('package', 'firewalld', PayloadRequirement(id=firewalld, reasons=[PayloadRequirementReason(reason='firewall', strong=True)])), ('package', 'chrony', PayloadRequirement(id=chrony, reasons=[PayloadRequirementReason(reason='ntp', strong=False)])), ('package', 'grub2', PayloadRequirement(id=grub2, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'grub2-tools', PayloadRequirement(id=grub2-tools, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)]))]
>02:24:12,531 INF payload: Some of the requirements were not applied.

Actions: View

Attachments on bug 1635514: 1489815 | 1489816 | 1489817 | 1489818 | 1489829 | 1489834