Attachment 1476455 Details for Bug 1618443 – File: anaconda.log

File: anaconda.log

anaconda.log (text/plain), 52.22 KB, created by Bilal on 2018-08-16 16:37:45 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Bilal

Created: 2018-08-16 16:37:45 UTC

Size: 52.22 KB

patch

obsolete

>16:19:15,209 INF main: /sbin/anaconda 29.23-3.fc29
>16:19:15,338 INF isys: 16516752 kB (16129 MB) are available
>16:19:15,365 INF startup_utils: check_memory(): total:16129, needed:320, graphical:410
>16:19:15,378 INF main: anaconda called with cmdline = ['/sbin/anaconda']
>16:19:15,378 INF main: Default encoding = utf-8 
>16:19:15,396 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-26w1GpvvHc,guid=da99aa08ce45686967502d045b75a403.
>16:19:15,577 INF startup_utils: Waiting 600 sec for modules to be started.
>16:19:16,625 INF startup_utils: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>16:19:16,661 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'
>16:19:16,898 WRN kickstart: Command firstboot will be parsed in DBus module.
>16:19:16,913 DBG localization: setting locale to: en_US.UTF-8
>16:19:16,923 DBG network: devices found ['enp24s0']
>16:19:16,931 DBG network: ensure single initramfs connections
>16:19:16,968 DBG network: apply kickstart
>16:19:16,968 DBG network: create missing ifcfg files
>16:19:17,020 DBG network: ifcfg file for enp24s0 not found
>16:19:17,156 DBG network: dumping ifcfg file for enp24s0 from default autoconnection 55e35190-5ba7-3693-991e-07c7df65acb9
>16:19:17,156 DBG network: missing ifcfgs created for devices ['enp24s0']
>16:19:17,166 DBG network: set real ONBOOT value
>16:19:17,170 INF threading: Running Thread: AnaWaitForConnectingNMThread (139834217805568)
>16:19:17,172 DBG anaconda: setting display mode to GUI
>16:19:17,179 INF anaconda: Display mode is set to 'interactive graphical mode'.
>16:19:17,180 INF isys: 16516752 kB (16129 MB) are available
>16:19:17,195 INF startup_utils: check_memory(): total:16129, needed:320, graphical:410
>16:19:17,196 DBG core.util: Setting timeout 60 seconds for starting X.
>16:19:17,211 INF network: got 0 NTP servers from DHCP
>16:19:17,214 INF threading: Thread Done: AnaWaitForConnectingNMThread (139834217805568)
>16:19:19,869 DBG core.util: X server has signalled a successful start.
>16:19:19,979 INF display: spice-vdagent exited with status 1
>16:19:20,501 DBG installclass: Searching /usr/lib64/python3.7/site-packages/pyanaconda/installclasses.
>16:19:20,534 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>16:19:20,535 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>16:19:20,535 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>16:19:20,535 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>16:19:20,535 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>16:19:20,535 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>16:19:20,535 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>16:19:20,535 DBG installclass: Found Fedora (DefaultInstallClass).
>16:19:20,535 INF installclass: Using a visible install class Fedora Workstation (FedoraWorkstationInstallClass).
>16:19:21,052 DBG payload: getting release version from tree at None (rawhide)
>16:19:21,052 DBG payload: using default release version of rawhide
>16:19:21,300 INF bootloader: bootloader EFIGRUB on EFI platform
>16:19:21,301 INF autopart: Detected 15.75 GiB of memory
>16:19:21,302 INF autopart: Suggested swap size (7.88 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>16:19:21,302 INF autopart: Swap attempt of 0.0
>16:19:21,302 INF bootloader: bootloader EFIGRUB on EFI platform
>16:19:21,387 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>16:19:21,388 INF threading: Running Thread: AnaStorageThread (139834031146752)
>16:19:21,391 INF threading: Running Thread: AnaTimeInitThread (139834022754048)
>16:19:21,407 DBG payload: Restarting payload thread
>16:19:21,408 INF threading: Running Thread: AnaPayloadRestartThread (139834014361344)
>16:19:21,408 INF geoloc: Geolocation is enabled.
>16:19:21,408 INF threading: Running Thread: AnaPayloadThread (139834005968640)
>16:19:21,409 DBG payload: Updating payload thread state: 0
>16:19:21,409 DBG payload: Updating payload thread state: 1
>16:19:21,409 INF threading: Thread Done: AnaPayloadRestartThread (139834014361344)
>16:19:21,410 INF threading: Running Thread: AnaGeolocationRefreshThread (139833997575936)
>16:19:21,410 INF geoloc: Starting geolocation lookup
>16:19:21,410 INF geoloc: Geolocation provider: Fedora GeoIP
>16:19:22,336 DBG ui.gui: Detected primary monitor: 2560x1440 89dpix 85dpiy
>16:19:22,709 INF geoloc: Geolocation lookup finished in 1.3 seconds
>16:19:22,709 INF geoloc: got results from geolocation
>16:19:22,709 INF threading: Thread Done: AnaGeolocationRefreshThread (139833997575936)
>16:19:22,899 DBG localization: setting locale to: tr_TR.UTF-8
>16:19:22,941 DBG localization: setting locale to: tr_TR.UTF-8
>16:19:23,011 DBG ui.common: Entered spoke: WelcomeLanguageSpoke
>16:19:23,012 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/Gdk.py:336: DeprecationWarning: Gdk.Cursor.new is deprecated
>  return cls.new(*args, **kwds)
>
>16:19:25,760 DBG localization: setting locale to: en_US.UTF-8
>16:19:27,632 DBG storage: protected device spec LABEL=FEDORA-WS-D resolved to sdc1
>16:19:28,874 DBG localization: setting locale to: en_US.UTF-8
>16:19:28,878 INF ui.gui.spokes.welcome: using timezone determined by geolocation
>16:19:28,957 DBG ui.gui.spokes.network: network standalone spoke (init): completed: ['enp24s0']
>16:19:28,971 DBG ui.common: Left spoke: WelcomeLanguageSpoke
>16:19:28,974 DBG storage: blkid.tab devs: []
>16:19:28,974 DBG storage: parsing /mnt/sysimage/etc/crypttab
>16:19:28,974 DBG storage: crypttab maps: []
>16:19:28,975 DBG storage: parsing /mnt/sysimage/etc/fstab
>16:19:29,018 INF lifecycle: Adding controller: SummaryHub
>16:19:29,927 INF threading: Running Thread: AnaAddLayoutsInitThread (139834014361344)
>16:19:29,928 DBG ui.gui.utils: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f2da2d93cf8>> on <list object at 0x7f2da2e00c48>
>16:19:29,929 INF threading: Running Thread: AnaGtkBatchPre1 (139833954154240)
>16:19:29,932 INF threading: Thread Done: AnaGtkBatchPre1 (139833954154240)
>16:19:29,983 INF threading: Running Thread: AnaKeyboardThread (139833954154240)
>16:19:30,169 INF lifecycle: Module initialized: LangsupportSpoke
>16:19:30,526 INF threading: Running Thread: AnaNTPserver1 (139833945761536)
>16:19:30,526 INF threading: Running Thread: AnaDateTimeThread (139833937368832)
>16:19:30,634 INF threading: Thread Done: AnaNTPserver1 (139833945761536)
>16:19:30,980 INF threading: Thread Done: AnaStorageThread (139834031146752)
>16:19:30,981 DBG payload: Updating payload thread state: 2
>16:19:31,613 DBG payload: Updating payload thread state: 4
>16:19:31,613 INF threading: Running Thread: AnaSourceWatcher (139834031146752)
>16:19:31,617 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke]
>16:19:31,629 INF threading: Running Thread: AnaSoftwareWatcher (139833945761536)
>16:19:31,631 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke, SoftwareSelectionSpoke]
>16:19:31,670 DBG payload: retrieving treeinfo from file:///run/install/repo (proxy: None ; sslverify: True)
>16:19:31,671 INF payload: Trying to download '.treeinfo'
>16:19:31,671 INF payload: Server returned 404 code
>16:19:31,672 INF payload: Trying to download 'treeinfo'
>16:19:31,672 INF payload: Server returned 404 code
>16:19:31,672 ERR payload: Got HTTP 404 Error when downloading [.]treeinfo files
>16:19:31,672 DBG payload: getting release version from tree at file:///run/install/repo (rawhide)
>16:19:31,673 DBG payload: using default release version of rawhide
>16:19:31,678 INF threading: Running Thread: AnaStorageWatcher (139833790437120)
>16:19:31,679 INF lifecycle: Module initialized: StorageSpoke
>16:19:31,679 INF threading: Thread Done: AnaStorageWatcher (139833790437120)
>16:19:31,682 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke, SoftwareSelectionSpoke, StorageSpoke]
>16:19:31,703 INF threading: Running Thread: AnaCustomStorageInit (139833790437120)
>16:19:31,754 INF lifecycle: Module initialized: BlivetGuiSpoke
>16:19:31,776 INF lifecycle: Module initialized: FilterSpoke
>16:19:31,805 DBG ui.gui.spokes.network: can't get remote connection of active connection of device enp24s0
>16:19:31,805 DBG ui.gui.spokes.network: device configuration added: connection 55e35190-5ba7-3693-991e-07c7df65acb9 device enp24s0
>16:19:31,808 DBG ui.gui.spokes.network: not adding connection 55e35190-5ba7-3693-991e-07c7df65acb9, already in list
>16:19:32,012 INF threading: Thread Done: AnaTimeInitThread (139834022754048)
>16:19:32,041 DBG network: updating host name localhost.localdomain
>16:19:32,064 INF lifecycle: Module initialized: NetworkSpoke
>16:19:32,126 DBG payload: Source doesn't require network for installation
>16:19:32,126 INF lifecycle: Initialization of all modules (10) has been started.
>16:19:32,128 DBG ui.gui.hubs: Starting event loop for hub SummaryHub
>16:19:32,135 DBG ui.common: Entered hub: SummaryHub
>16:19:32,253 INF lifecycle: Module initialized: CustomPartitioningSpoke
>16:19:32,253 INF threading: Thread Done: AnaCustomStorageInit (139833790437120)
>18:19:32,000 INF isys: System time set to Thu Aug 16 16:19:32 2018 UTC
>18:19:32,000 INF isys: System time set to Thu Aug 16 16:19:32 2018 UTC
>18:19:32,000 INF isys: System time set to Thu Aug 16 16:19:32 2018 UTC
>19:19:32,046 INF lifecycle: Module initialized: DatetimeSpoke
>19:19:32,046 INF threading: Thread Done: AnaDateTimeThread (139833937368832)
>19:19:32,051 DBG ui.gui.hubs: spoke is not ready: KeyboardSpoke
>19:19:32,052 DBG ui.gui.hubs: setting KeyboardSpoke status to: Getting list of layouts...
>19:19:32,053 DBG ui.gui.hubs: spoke is not ready: SoftwareSelectionSpoke
>19:19:32,054 DBG ui.gui.hubs: spoke is not ready: SourceSpoke
>19:19:32,054 DBG ui.gui.hubs: setting SourceSpoke status to: Setting up installation source...
>19:19:32,054 DBG ui.gui.hubs: setting SourceSpoke status to: Probing storage...
>19:19:32,054 DBG ui.gui.hubs: setting SourceSpoke status to: Downloading package metadata...
>19:19:32,055 DBG ui.gui.hubs: setting SoftwareSelectionSpoke status to: Downloading package metadata...
>19:19:32,055 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>19:19:32,055 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>19:19:32,059 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>19:19:32,064 DBG ui.gui.hubs: spoke is ready: DatetimeSpoke
>19:19:32,415 DBG payload: Updating payload thread state: 5
>19:19:32,450 DBG ui.gui.hubs: setting SourceSpoke status to: Downloading group metadata...
>19:19:32,450 DBG ui.gui.hubs: setting SoftwareSelectionSpoke status to: Downloading group metadata...
>19:19:33,187 DBG ui.gui.utils: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f2da2d93cf8>> on <list object at 0x7f2da2e00c48>
>19:19:33,187 INF threading: Thread Done: AnaAddLayoutsInitThread (139834014361344)
>19:19:33,188 INF lifecycle: Module initialized: KeyboardSpoke
>19:19:33,188 INF threading: Thread Done: AnaKeyboardThread (139833954154240)
>19:19:33,200 DBG ui.gui.hubs: spoke is ready: KeyboardSpoke
>19:19:41,494 DBG ui.common: Entered spoke: StorageSpoke
>19:19:45,007 INF autopart: Detected 15.75 GiB of memory
>19:19:45,008 INF autopart: Swap attempt of 7.88 GiB
>19:19:45,008 DBG ui.gui.spokes.storage: disk free: 1014.5 KiB  fs free: 829 MiB  sw needs: 2.79 GiB  auto swap: 7.88 GiB
>19:19:46,475 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c609b370' has no handler with id '19623'
>  return func(*args, **kwargs)
>
>19:19:46,476 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c609b370' has no handler with id '19624'
>  return func(*args, **kwargs)
>
>19:20:01,141 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c39a1ec0' has no handler with id '20138'
>  return func(*args, **kwargs)
>
>19:20:01,141 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c39a1ec0' has no handler with id '20139'
>  return func(*args, **kwargs)
>
>19:20:03,639 INF autopart: Detected 15.75 GiB of memory
>19:20:03,640 INF autopart: Swap attempt of 7.88 GiB
>19:20:03,640 DBG ui.gui.spokes.storage: disk free: 1014.5 KiB  fs free: 829 MiB  sw needs: 2.79 GiB  auto swap: 7.88 GiB
>19:20:07,224 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c39a0840' has no handler with id '20825'
>  return func(*args, **kwargs)
>
>19:20:07,224 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c39a0840' has no handler with id '20826'
>  return func(*args, **kwargs)
>
>19:20:14,034 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c39a0de0' has no handler with id '21396'
>  return func(*args, **kwargs)
>
>19:20:14,035 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c39a0de0' has no handler with id '21397'
>  return func(*args, **kwargs)
>
>19:20:18,592 INF ui.gui.spokes.storage: Partitioning method changed from auto to custom.
>19:20:18,593 INF ui.gui.spokes.storage: Rolling back planed storage configuration changes.
>19:20:18,689 INF threading: Running Thread: AnaExecuteStorageThread (139833937368832)
>19:20:18,690 DBG ui.common: Left spoke: StorageSpoke
>19:20:18,698 DBG storage: clearpart: looking at sda3
>19:20:18,698 DBG storage: clearpart: looking at sda2
>19:20:18,698 DBG storage: clearpart: looking at sda1
>19:20:18,702 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run True.
>19:20:18,708 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>19:20:18,709 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>19:20:18,712 DBG kickstart.kickstart.bootloader: Applying drive order: []
>19:20:18,712 DBG bootloader: new disk order: []
>19:20:18,714 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>19:20:18,714 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>19:20:18,714 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>19:20:18,725 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>19:20:18,731 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>19:20:18,733 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>19:20:18,736 DBG kickstart.kickstart.bootloader: Applying drive order: []
>19:20:18,736 DBG bootloader: new disk order: []
>19:20:18,739 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>19:20:18,739 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>19:20:18,739 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>19:20:18,747 DBG bootloader: stage1 device cannot be of type lvmvg
>19:20:18,747 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:18,748 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:18,748 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:18,749 DBG bootloader: stage1 device cannot be of type disk
>19:20:18,750 DBG bootloader: _is_valid_disklabel(sda1) returning True
>19:20:18,750 DBG bootloader: _is_valid_size(sda1) returning True
>19:20:18,750 DBG bootloader: _is_valid_location(sda1) returning True
>19:20:18,751 DBG bootloader: _is_valid_format(sda1) returning False
>19:20:18,751 DBG bootloader: is_valid_stage1_device(sda1) returning False
>19:20:18,752 DBG bootloader: _is_valid_disklabel(sda2) returning True
>19:20:18,752 DBG bootloader: _is_valid_size(sda2) returning True
>19:20:18,752 DBG bootloader: _is_valid_location(sda2) returning True
>19:20:18,752 WRN bootloader: sda2 not bootable
>19:20:18,753 DBG bootloader: _is_valid_format(sda2) returning False
>19:20:18,753 DBG bootloader: is_valid_stage1_device(sda2) returning False
>19:20:18,754 DBG bootloader: _is_valid_disklabel(sda3) returning True
>19:20:18,754 DBG bootloader: _is_valid_size(sda3) returning True
>19:20:18,754 DBG bootloader: _is_valid_location(sda3) returning True
>19:20:18,754 WRN bootloader: sda3 not bootable
>19:20:18,754 DBG bootloader: _is_valid_format(sda3) returning False
>19:20:18,754 DBG bootloader: is_valid_stage1_device(sda3) returning False
>19:20:18,755 ERR ui.gui.spokes.storage: BootLoader setup failed: Failed to find a suitable stage1 device: EFI System Partition must be mounted on one of /boot/efi.; EFI System Partition cannot be of type ext4.; EFI System Partition must be mounted on one of /boot/efi.; EFI System Partition cannot be of type lvmpv.
>19:20:18,761 INF threading: Thread Done: AnaExecuteStorageThread (139833937368832)
>19:20:18,872 DBG ui.gui.spokes.custom_storage: ui: devices=['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'fedora_desktop-o0cp5m4', 'fedora_desktop-o0cp5m4-home', 'fedora_desktop-o0cp5m4-root', 'fedora_desktop-o0cp5m4-swap', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sda1', 'sda2', 'sda3']
>19:20:18,872 DBG ui.gui.spokes.custom_storage: ui: unused=[]
>19:20:18,873 DBG ui.gui.spokes.custom_storage: ui: new_devices=[]
>19:20:19,705 DBG ui.gui.spokes.custom_storage: page clicked: New Fedora Rawhide Installation
>19:20:19,705 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora Rawhide Installation
>19:20:19,706 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora Rawhide Installation
>19:20:19,719 DBG ui.common: Entered spoke: CustomPartitioningSpoke
>19:20:19,723 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>19:20:19,723 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>19:20:19,723 DBG ui.gui.hubs: setting StorageSpoke status to: Failed to save storage configuration...
>19:20:19,728 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>19:20:21,345 DBG ui.gui.spokes.custom_storage: page clicked: Fedora Linux 29 for x86_64
>19:20:21,345 DBG ui.gui.spokes.custom_storage: show mountpoint: Fedora Linux 29 for x86_64
>19:20:21,345 DBG ui.gui.spokes.lib.accordion: Accordion: unselecting all items
>19:20:21,346 DBG ui.gui.spokes.lib.accordion: Accordion: select existing 50 GiB lvmlv fedora_desktop-o0cp5m4-root (74) with existing ext4 filesystem device
>19:20:21,359 DBG ui.gui.spokes.custom_storage: populate_right_side: existing 50 GiB lvmlv fedora_desktop-o0cp5m4-root (74) with existing ext4 filesystem
>19:20:21,369 DBG ui.gui.spokes.custom_storage: updated device_disks to ['sda']
>19:20:21,369 DBG ui.gui.spokes.custom_storage: updated device_container_name to fedora_desktop-o0cp5m4
>19:20:21,370 DBG ui.gui.spokes.custom_storage: updated device_container_raid_level to None
>19:20:21,370 DBG ui.gui.spokes.custom_storage: updated device_container_encrypted to False
>19:20:21,370 DBG ui.gui.spokes.custom_storage: updated device_container_size to 464.56 GiB
>19:20:21,376 DBG ui.gui.spokes.custom_storage: device_type_changed: None
>19:20:21,377 DBG ui.gui.spokes.custom_storage: device_type_changed: DEVICE_TYPE_LVM
>19:20:21,378 DBG ui.gui.spokes.custom_storage: populate_raid: 0, None
>19:20:21,381 DBG ui.gui.spokes.custom_storage: new container selection: fedora_desktop-o0cp5m4
>19:20:21,381 DBG ui.gui.spokes.custom_storage: default container is fedora_desktop-o0cp5m4
>19:20:21,381 DBG ui.gui.spokes.custom_storage: populate_raid: 0, None
>19:20:21,384 DBG ui.gui.spokes.custom_storage: new container selection: fedora_desktop-o0cp5m4
>19:20:21,384 DBG ui.gui.spokes.custom_storage: default container is fedora_desktop-o0cp5m4
>19:20:30,813 DBG ui.gui.spokes.lib.accordion: Accordion: unselecting all items
>19:20:30,814 DBG ui.gui.spokes.lib.accordion: Accordion: select existing 406.68 GiB lvmlv fedora_desktop-o0cp5m4-home (61) with existing ext4 filesystem device
>19:20:30,826 DBG ui.gui.spokes.custom_storage: Saving current selector: existing 50 GiB lvmlv fedora_desktop-o0cp5m4-root (74) with existing ext4 filesystem
>19:20:30,835 DBG ui.gui.spokes.custom_storage: populate_right_side: existing 406.68 GiB lvmlv fedora_desktop-o0cp5m4-home (61) with existing ext4 filesystem
>19:20:30,845 DBG ui.gui.spokes.custom_storage: updated device_disks to ['sda']
>19:20:30,845 DBG ui.gui.spokes.custom_storage: updated device_container_name to fedora_desktop-o0cp5m4
>19:20:30,845 DBG ui.gui.spokes.custom_storage: updated device_container_raid_level to None
>19:20:30,845 DBG ui.gui.spokes.custom_storage: updated device_container_encrypted to False
>19:20:30,845 DBG ui.gui.spokes.custom_storage: updated device_container_size to 464.56 GiB
>19:20:30,851 DBG ui.gui.spokes.custom_storage: device_type_changed: DEVICE_TYPE_LVM
>19:20:30,851 DBG ui.gui.spokes.custom_storage: populate_raid: 0, None
>19:20:30,854 DBG ui.gui.spokes.custom_storage: new container selection: fedora_desktop-o0cp5m4
>19:20:30,854 DBG ui.gui.spokes.custom_storage: default container is fedora_desktop-o0cp5m4
>19:20:30,855 DBG ui.gui.spokes.custom_storage: populate_raid: 0, None
>19:20:30,857 DBG ui.gui.spokes.custom_storage: new container selection: fedora_desktop-o0cp5m4
>19:20:30,857 DBG ui.gui.spokes.custom_storage: default container is fedora_desktop-o0cp5m4
>19:20:31,579 DBG ui.gui.spokes.custom_storage: page clicked: Fedora Linux 29 for x86_64
>19:20:31,579 DBG ui.gui.spokes.custom_storage: Saving current selector: existing 406.68 GiB lvmlv fedora_desktop-o0cp5m4-home (61) with existing ext4 filesystem
>19:20:31,596 DBG ui.gui.spokes.custom_storage: show mountpoint: Fedora Linux 29 for x86_64
>19:20:32,831 DBG ui.gui.spokes.custom_storage: page clicked: Fedora Linux 29 for x86_64
>19:20:32,831 DBG ui.gui.spokes.custom_storage: Saving current selector: existing 406.68 GiB lvmlv fedora_desktop-o0cp5m4-home (61) with existing ext4 filesystem
>19:20:32,843 DBG ui.gui.spokes.custom_storage: show mountpoint: Fedora Linux 29 for x86_64
>19:20:35,382 DBG ui.gui.spokes.custom_storage: removing device 'existing 406.68 GiB lvmlv fedora_desktop-o0cp5m4-home (61) with existing ext4 filesystem' from page Fedora Linux 29 for x86_64
>19:20:37,915 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c689a2f0' has no handler with id '23735'
>  return func(*args, **kwargs)
>
>19:20:37,915 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c689a2f0' has no handler with id '23736'
>  return func(*args, **kwargs)
>
>19:20:37,922 DBG ui.gui.spokes.custom_storage: deleteall: removed fedora_desktop-o0cp5m4-root
>19:20:37,957 DBG ui.gui.spokes.custom_storage: deleteall: removed sda2
>19:20:37,962 DBG ui.gui.spokes.custom_storage: deleteall: removed sda1
>19:20:37,967 DBG ui.gui.spokes.custom_storage: deleteall: removed fedora_desktop-o0cp5m4-home
>19:20:37,971 DBG ui.gui.spokes.custom_storage: deleteall: removed fedora_desktop-o0cp5m4-swap
>19:20:38,012 INF ui.gui.spokes.custom_storage: ui: removed device fedora_desktop-o0cp5m4-home
>19:20:38,053 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']
>19:20:38,054 DBG ui.gui.spokes.custom_storage: ui: unused=[]
>19:20:38,054 DBG ui.gui.spokes.custom_storage: ui: new_devices=[]
>19:20:38,059 DBG ui.gui.spokes.custom_storage: page clicked: New Fedora Rawhide Installation
>19:20:38,059 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora Rawhide Installation
>19:20:38,059 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora Rawhide Installation
>19:20:39,845 DBG ui.gui.spokes.custom_storage: running automatic partitioning
>19:20:39,846 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>19:20:39,852 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>19:20:39,853 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>19:20:39,856 DBG kickstart.kickstart.bootloader: Applying drive order: []
>19:20:39,856 DBG bootloader: new disk order: []
>19:20:39,858 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>19:20:39,859 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>19:20:39,859 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>19:20:39,864 INF autopart: Detected 15.75 GiB of memory
>19:20:39,865 INF autopart: Swap attempt of 7.88 GiB
>19:20:39,865 DBG autopart: do_autopart: True
>19:20:39,865 DBG autopart: encrypted_autopart: False
>19:20:39,865 DBG autopart: autopart_type: 2
>19:20:39,865 DBG autopart: clear_part_type: 0
>19:20:39,866 DBG autopart: clear_part_disks: ['sda']
>19:20:39,866 DBG autopart: autopart_requests:
>PartSpec instance (0x7f2da527c668) -- 
>  mountpoint = /  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024 MiB  max_size = 50 GiB  grow = True
>PartSpec instance (0x7f2da527ceb8) -- 
>  mountpoint = /home  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500 MiB  max_size = None  grow = True
>PartSpec instance (0x7f2da527c5c0) -- 
>  mountpoint = /boot/efi  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = efi  encrypted = False
>  size = 20 MiB  max_size = 200 MiB  grow = True
>PartSpec instance (0x7f2da521d630) -- 
>  mountpoint = /boot  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = ext4  encrypted = False
>  size = 1024 MiB  max_size = None  grow = False
>PartSpec instance (0x7f2da521d6d8) -- 
>  mountpoint = None  lv = True  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 7.88 GiB  max_size = None  grow = False
>
>19:20:39,866 DBG autopart: storage.disks: ['sda']
>19:20:39,866 DBG autopart: storage.partitioned: ['sda']
>19:20:39,867 DBG autopart: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda']
>19:20:39,867 DBG autopart: boot disk: sda
>19:20:39,875 DBG autopart: candidate disks: [DiskDevice instance (0x7f2da521d470) --
>  name = sda  status = True  id = 20
>  children = []
>  parents = []
>  uuid = None  size = 465.76 GiB
>  format = non-existent gpt disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /sys/devices/pci0000:00/0000:00:01.3/0000:03:00.1/ata1/host0/target0:0:0/0:0:0:0/block/sda
>  target size = 465.76 GiB  path = /dev/sda
>  format args = []  original_format = disklabel  removable = False  wwn = 5002538da01e65f9]
>19:20:39,876 DBG autopart: devs: [PartitionDevice instance (0x7f2da5196fd0) --
>  name = req0  status = False  id = 423
>  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
>]
>19:20:39,877 DBG bootloader: stage1 device cannot be of type disk
>19:20:40,151 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>19:20:40,156 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>19:20:40,157 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>19:20:40,160 DBG kickstart.kickstart.bootloader: Applying drive order: []
>19:20:40,160 DBG bootloader: new disk order: []
>19:20:40,162 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>19:20:40,251 DBG storage_utils: sda matches ['sda'] for devicetree=existing 465.76 GiB disk sda (20) with non-existent gpt disklabel
>  non-existent 200 MiB partition sda1 (430) with non-existent efi filesystem mounted at /boot/efi
>  non-existent 1024 MiB partition sda2 (437) with non-existent ext4 filesystem mounted at /boot
>  non-existent 464.57 GiB partition sda3 (423) with non-existent lvmpv
>    non-existent 464.56 GiB lvmvg fedora (443)
>      non-existent 50 GiB lvmlv fedora-root (449) with non-existent ext4 filesystem mounted at /
>      non-existent 406.68 GiB lvmlv fedora-home (458) with non-existent ext4 filesystem mounted at /home
>      non-existent 7.88 GiB lvmlv fedora-swap (467) with non-existent swap
>existing 483.25 MiB file /run/install/repo/images/install.img (121)
>  existing 483.25 MiB loop loop0 (125)
>existing 0 B file /LiveOS/rootfs.img (135)
>  existing 0 B loop loop1 (139) with existing ext4 filesystem
>    existing 2 GiB dm live-rw (158) with existing ext4 filesystem
>    existing 2 GiB dm live-base (168) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (149)
>  existing 0 B loop loop2 (153)
> and disks_only=True
>19:20:40,253 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>19:20:40,259 DBG bootloader: stage1 device cannot be of type lvmvg
>19:20:40,259 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:40,260 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:40,260 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:40,260 DBG bootloader: stage1 device cannot be of type disk
>19:20:40,261 DBG bootloader: _is_valid_disklabel(sda1) returning True
>19:20:40,262 DBG bootloader: _is_valid_size(sda1) returning True
>19:20:40,262 DBG bootloader: _is_valid_location(sda1) returning True
>19:20:40,262 WRN bootloader: sda1 not bootable
>19:20:40,262 DBG bootloader: _is_valid_format(sda1) returning True
>19:20:40,262 DBG bootloader: is_valid_stage1_device(sda1) returning True
>19:20:40,263 DBG ui.gui.spokes.custom_storage: finished automatic partitioning
>19:20:40,265 DBG bootloader: _is_valid_disklabel(sda1) returning True
>19:20:40,265 DBG bootloader: _is_valid_size(sda1) returning True
>19:20:40,266 DBG bootloader: _is_valid_location(sda1) returning True
>19:20:40,266 WRN bootloader: sda1 not bootable
>19:20:40,266 DBG bootloader: _is_valid_format(sda1) returning True
>19:20:40,266 DBG bootloader: is_valid_stage1_device(sda1) returning True
>19:20:40,266 DBG bootloader: _is_valid_disklabel(sda2) returning True
>19:20:40,266 DBG bootloader: _is_valid_size(sda2) returning True
>19:20:40,267 DBG bootloader: _is_valid_partition(sda2) returning True
>19:20:40,267 DBG bootloader: _is_valid_format(sda2) returning True
>19:20:40,267 DBG bootloader: is_valid_stage2_device(sda2) returning True
>19:20:40,280 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': {'/tmp', '/var', '/usr/lib', '/usr', '/home', '/usr/share', '/'}, 'must_be_on_root': {'/root', 'lost+found', '/mnt', '/proc', '/dev', '/etc', '/lib', '/bin', '/sbin'}, 'swap_is_recommended': True}.
>19:20:40,280 DBG ui.gui.spokes.custom_storage: Run sanity check verify_root.
>19:20:40,280 DBG ui.gui.spokes.custom_storage: Run sanity check verify_s390_constraints.
>19:20:40,280 DBG ui.gui.spokes.custom_storage: Run sanity check verify_partition_sizes.
>19:20:40,280 DBG ui.gui.spokes.custom_storage: Run sanity check verify_partition_format_sizes.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_bootloader.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_gpt_biosboot.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_swap.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_swap_uuid.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_mountpoints_on_linuxfs.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_mountpoints_on_root.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Skipped sanity check verify_luks_devices_have_key.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Run sanity check verify_mounted_partitions.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: Storage check finished with success.
>19:20:40,281 DBG ui.gui.spokes.custom_storage: refreshing ui
>19:20:40,285 DBG ui.gui.spokes.custom_storage: ui: devices=['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'fedora', 'fedora-home', 'fedora-root', 'fedora-swap', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sda1', 'sda2', 'sda3']
>19:20:40,285 DBG ui.gui.spokes.custom_storage: ui: unused=[]
>19:20:40,285 DBG ui.gui.spokes.custom_storage: ui: new_devices=['sda2', 'fedora-swap', 'sda1', 'fedora-home', 'fedora-root']
>19:20:40,292 DBG ui.gui.spokes.custom_storage: page clicked: New Fedora Rawhide Installation
>19:20:40,292 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora Rawhide Installation
>19:20:40,292 DBG ui.gui.spokes.lib.accordion: Accordion: unselecting all items
>19:20:40,292 DBG ui.gui.spokes.lib.accordion: Accordion: select non-existent 1024 MiB partition sda2 (437) with non-existent ext4 filesystem mounted at /boot device
>19:20:40,295 DBG ui.gui.spokes.custom_storage: populate_right_side: non-existent 1024 MiB partition sda2 (437) with non-existent ext4 filesystem mounted at /boot
>19:20:40,297 DBG ui.gui.spokes.custom_storage: updated device_disks to ['sda']
>19:20:40,297 DBG ui.gui.spokes.custom_storage: updated device_container_name to None
>19:20:40,297 DBG ui.gui.spokes.custom_storage: updated device_container_raid_level to None
>19:20:40,297 DBG ui.gui.spokes.custom_storage: updated device_container_encrypted to False
>19:20:40,298 DBG ui.gui.spokes.custom_storage: updated device_container_size to 0
>19:20:40,305 DBG ui.gui.spokes.custom_storage: device_type_changed: DEVICE_TYPE_PARTITION
>19:20:40,305 DBG ui.gui.spokes.custom_storage: populate_raid: 2, None
>19:20:40,305 DBG ui.gui.spokes.custom_storage: populate_raid: 2, None
>19:20:40,306 DBG ui.gui.spokes.custom_storage: show mountpoint: New Fedora Rawhide Installation
>19:20:40,306 DBG ui.gui.spokes.custom_storage: finished refreshing ui
>19:20:40,306 DBG ui.gui.spokes.custom_storage: updating space display
>19:20:40,310 DBG ui.gui.spokes.custom_storage: finished updating space display
>19:20:44,320 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>19:20:44,326 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>19:20:44,327 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>19:20:44,330 DBG kickstart.kickstart.bootloader: Applying drive order: []
>19:20:44,330 DBG bootloader: new disk order: []
>19:20:44,332 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>19:20:44,379 DBG storage_utils: sda matches ['sda'] for devicetree=existing 465.76 GiB disk sda (20) with non-existent gpt disklabel
>  non-existent 200 MiB partition sda1 (430) with non-existent efi filesystem mounted at /boot/efi
>  non-existent 1024 MiB partition sda2 (437) with non-existent ext4 filesystem mounted at /boot
>  non-existent 464.57 GiB partition sda3 (423) with non-existent lvmpv
>    non-existent 464.56 GiB lvmvg fedora (443)
>      non-existent 50 GiB lvmlv fedora-root (449) with non-existent ext4 filesystem mounted at /
>      non-existent 406.68 GiB lvmlv fedora-home (458) with non-existent ext4 filesystem mounted at /home
>      non-existent 7.88 GiB lvmlv fedora-swap (467) with non-existent swap
>existing 483.25 MiB file /run/install/repo/images/install.img (121)
>  existing 483.25 MiB loop loop0 (125)
>existing 0 B file /LiveOS/rootfs.img (135)
>  existing 0 B loop loop1 (139) with existing ext4 filesystem
>    existing 2 GiB dm live-rw (158) with existing ext4 filesystem
>    existing 2 GiB dm live-base (168) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (149)
>  existing 0 B loop loop2 (153)
> and disks_only=True
>19:20:44,381 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>19:20:44,386 DBG bootloader: stage1 device cannot be of type lvmvg
>19:20:44,386 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:44,387 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:44,387 DBG bootloader: stage1 device cannot be of type lvmlv
>19:20:44,387 DBG bootloader: stage1 device cannot be of type disk
>19:20:44,388 DBG bootloader: _is_valid_disklabel(sda1) returning True
>19:20:44,388 DBG bootloader: _is_valid_size(sda1) returning True
>19:20:44,388 DBG bootloader: _is_valid_location(sda1) returning True
>19:20:44,389 WRN bootloader: sda1 not bootable
>19:20:44,389 DBG bootloader: _is_valid_format(sda1) returning True
>19:20:44,389 DBG bootloader: is_valid_stage1_device(sda1) returning True
>19:20:44,391 DBG bootloader: _is_valid_disklabel(sda1) returning True
>19:20:44,392 DBG bootloader: _is_valid_size(sda1) returning True
>19:20:44,392 DBG bootloader: _is_valid_location(sda1) returning True
>19:20:44,392 WRN bootloader: sda1 not bootable
>19:20:44,392 DBG bootloader: _is_valid_format(sda1) returning True
>19:20:44,392 DBG bootloader: is_valid_stage1_device(sda1) returning True
>19:20:44,392 DBG bootloader: _is_valid_disklabel(sda2) returning True
>19:20:44,393 DBG bootloader: _is_valid_size(sda2) returning True
>19:20:44,393 DBG bootloader: _is_valid_partition(sda2) returning True
>19:20:44,393 DBG bootloader: _is_valid_format(sda2) returning True
>19:20:44,393 DBG bootloader: is_valid_stage2_device(sda2) returning True
>19:20:44,406 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': {'/tmp', '/var', '/usr/lib', '/usr', '/home', '/usr/share', '/'}, 'must_be_on_root': {'/root', 'lost+found', '/mnt', '/proc', '/dev', '/etc', '/lib', '/bin', '/sbin'}, 'swap_is_recommended': True}.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_root.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_s390_constraints.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_partition_sizes.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_bootloader.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_swap.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_swap_uuid.
>19:20:44,406 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>19:20:44,407 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>19:20:44,407 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>19:20:44,407 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>19:20:44,407 DBG ui.helpers: Storage check finished with success.
>19:20:44,442 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke, SoftwareSelectionSpoke]
>19:20:44,442 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>19:20:44,443 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>19:20:44,448 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>19:20:46,591 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c6657f80' has no handler with id '25180'
>  return func(*args, **kwargs)
>
>19:20:46,592 WRN misc: /usr/lib64/python3.7/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x5582c6657f80' has no handler with id '25181'
>  return func(*args, **kwargs)
>
>19:20:46,599 DBG ui.common: Left spoke: CustomPartitioningSpoke
>19:20:46,707 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>19:21:44,655 INF payload: Refreshing environmentAddons
>19:21:46,566 DBG payload: Updating payload thread state: 6
>19:21:46,566 INF ui.gui.spokes.software_selection: using environment from kickstart: None
>19:21:46,566 INF threading: Thread Done: AnaPayloadThread (139834005968640)
>19:21:46,567 DBG ui.gui.spokes.installation_source: Clearing checks in source spoke
>19:21:46,567 DBG ui.gui.spokes.installation_source: Setting up repos: []
>19:21:46,615 INF threading: Running Thread: AnaCheckSoftwareThread (139834005968640)
>19:21:46,616 INF lifecycle: Module initialized: SoftwareSelectionSpoke
>19:21:46,616 INF threading: Thread Done: AnaSoftwareWatcher (139833945761536)
>19:21:46,651 DBG payload: apply with result True called on requirements []
>19:21:46,752 DBG ui.gui.hubs: spoke is ready: SoftwareSelectionSpoke
>19:21:47,090 DBG ui.gui.hubs: spoke is ready: SourceSpoke
>19:21:47,197 DBG ui.gui.hubs: spoke is ready: SoftwareSelectionSpoke
>19:21:47,300 DBG ui.gui.hubs: spoke is not ready: SoftwareSelectionSpoke
>19:21:47,432 DBG ui.gui.hubs: spoke is not ready: SourceSpoke
>19:21:47,437 DBG ui.gui.hubs: setting SoftwareSelectionSpoke status to: Checking software dependencies...
>19:21:47,882 INF threading: Thread Done: AnaCheckSoftwareThread (139834005968640)
>19:21:47,950 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke]
>19:21:47,951 DBG ui.gui.hubs: spoke is ready: SoftwareSelectionSpoke
>19:21:47,954 DBG ui.gui.hubs: incomplete spokes: []
>19:21:48,367 INF ui.lib.space: fs space: 42.5 GiB  needed: 6.07 GiB
>19:21:48,368 DBG ui.gui.hubs: spoke is ready: SourceSpoke
>19:21:48,589 INF lifecycle: Module initialized: SourceSpoke
>19:21:48,590 INF lifecycle: All modules have been initialized.
>19:21:48,590 INF threading: Thread Done: AnaSourceWatcher (139834031146752)
>19:21:49,084 INF ui.lib.space: fs space: 42.5 GiB  needed: 6.07 GiB
>19:21:49,084 DBG ui.gui.hubs: spoke is ready: SourceSpoke
>19:22:18,799 DBG ui.common: Left hub: SummaryHub
>19:22:18,811 INF lifecycle: Adding controller: ProgressHub
>19:22:18,822 INF lifecycle: Module initialized: PasswordSpoke
>19:22:18,831 DBG ui.gui.hubs: incomplete spokes: [PasswordSpoke]
>19:22:18,848 INF lifecycle: Module initialized: UserSpoke
>19:22:18,855 DBG ui.gui.hubs: incomplete spokes: [PasswordSpoke, UserSpoke]
>19:22:18,855 INF lifecycle: Initialization of all modules (2) has been started.
>19:22:18,855 INF lifecycle: All modules have been initialized.
>19:22:18,856 DBG ui.gui.hubs: Disabling event loop for hub SummaryHub
>19:22:18,857 DBG ui.gui.hubs: Starting event loop for hub ProgressHub
>19:22:18,857 INF threading: Running Thread: AnaInstallThread (139834031146752)
>19:22:18,863 DBG ui.common: Entered hub: ProgressHub
>19:22:18,865 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
>19:22:18,866 INF installation: Task started: Save system time to HW clock (1/18)
>19:22:18,970 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>19:22:19,502 DBG installation: Task completed: Save system time to HW clock (1/18) (0.6 s)
>19:22:19,502 INF progress: Save system time to HW clock
>19:22:19,502 INF installation: Queue started: Installation environment setup (1/9)
>19:22:19,503 INF progress: Setting up the installation environment
>19:22:19,503 INF installation: Task started: Setup addons (2/18)
>19:22:19,503 DBG installation: Task completed: Setup addons (2/18) (0.0 s)
>19:22:19,504 INF progress: Setup addons
>19:22:19,504 INF installation: Queue started: Early storage configuration (2/9)
>19:22:19,504 INF progress: Configuring storage
>19:22:19,505 INF installation: Task started: Insert custom storage to ksdata (3/18)
>19:22:19,522 INF storage: omitting ksdata: existing 465.76 GiB disk sda (20) with non-existent gpt disklabel
>19:22:19,526 DBG installation: Task completed: Insert custom storage to ksdata (3/18) (0.0 s)
>19:22:19,526 INF progress: Insert custom storage to ksdata
>19:22:19,526 INF installation: Task started: Run pre-storage tasks (4/18)
>19:22:19,526 DBG installation: Task completed: Run pre-storage tasks (4/18) (0.0 s)
>19:22:19,526 INF progress: Run pre-storage tasks
>19:22:19,527 INF installation: Task started: Activate filesystems (5/18)
>19:22:20,381 DBG ui.common: Entered spoke: PasswordSpoke
>19:22:23,349 INF progress: Creating disklabel on /dev/sda
>19:22:23,764 INF progress: Creating efi on /dev/sda1
>19:22:24,500 INF progress: Creating lvmpv on /dev/sda3
>19:22:25,210 INF progress: Creating ext4 on /dev/mapper/fedora-root
>19:22:26,387 INF progress: Creating ext4 on /dev/mapper/fedora-home
>19:22:30,427 INF progress: Creating swap on /dev/mapper/fedora-swap
>19:22:30,501 INF progress: Creating ext4 on /dev/sda2
>19:22:30,818 INF storage: setting boot flag on sda1
>19:22:30,819 INF storage: Setting label on existing 200 MiB partition sda1 (430) with existing efi filesystem mounted at /boot/efi to 'EFI System Partition'
>19:22:32,398 DBG ui.common: Left spoke: PasswordSpoke
>19:22:32,409 DBG ui.gui.hubs: incomplete spokes: [UserSpoke]
>19:22:32,412 DBG ui.gui.hubs: incomplete spokes: []
>19:22:32,440 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>19:22:34,000 DBG ui.common: Entered spoke: UserSpoke
>19:22:35,258 DBG installation: Task completed: Activate filesystems (5/18) (15.7 s)
>19:22:35,258 INF progress: Activate filesystems
>19:22:35,258 INF installation: Task started: Write early storage (6/18)
>19:22:35,261 INF storage: not writing out mpath configuration
>19:22:35,261 DBG installation: Task completed: Write early storage (6/18) (0.0 s)
>19:22:35,261 INF progress: Write early storage
>19:22:35,262 INF installation: Queue started: Pre-install scripts (3/9)
>19:22:35,262 INF progress: Running pre-installation scripts
>19:22:35,262 INF installation: Task started: Run %pre-install scripts (7/18)
>19:22:35,262 DBG installation: Task completed: Run %pre-install scripts (7/18) (0.0 s)
>19:22:35,262 INF progress: Run %pre-install scripts
>19:22:35,262 INF installation: Queue started: Realm discover (4/9)
>19:22:35,263 INF progress: Discovering realm to join
>19:22:35,263 INF installation: Task started: Discover realm to join (8/18)
>19:22:35,267 DBG installation: Task completed: Discover realm to join (8/18) (0.0 s)
>19:22:35,267 INF progress: Discover realm to join
>19:22:35,267 INF installation: Queue started: Pre install tasks (5/9)
>19:22:35,267 INF progress: Running pre-installation tasks
>19:22:35,268 INF installation: Task started: Setup authselect (9/18)
>19:22:35,271 DBG installation: Task completed: Setup authselect (9/18) (0.0 s)
>19:22:35,271 INF progress: Setup authselect
>19:22:35,272 INF installation: Task started: Setup firewall (10/18)
>19:22:35,274 DBG installation: Task completed: Setup firewall (10/18) (0.0 s)
>19:22:35,274 INF progress: Setup firewall
>19:22:35,275 INF installation: Task started: Setup network (11/18)
>19:22:35,288 DBG installation: Task completed: Setup network (11/18) (0.0 s)
>19:22:35,288 INF progress: Setup network
>19:22:35,288 INF installation: Task started: Setup timezone (12/18)
>19:22:35,338 DBG installation: Task completed: Setup timezone (12/18) (0.0 s)
>19:22:35,338 INF progress: Setup timezone
>19:22:35,338 INF installation: Task started: Copy /resolv.conf to sysroot (13/18)
>19:22:35,339 DBG installation: Task completed: Copy /resolv.conf to sysroot (13/18) (0.0 s)
>19:22:35,339 INF progress: Copy /resolv.conf to sysroot
>19:22:35,339 INF installation: Task started: Find additional packages & run preInstall() (14/18)
>19:22:35,341 DBG payload: added package requirement 'e2fsprogs' for storage, strong=True
>19:22:35,341 DBG payload: added package requirement 'dosfstools' for storage, strong=True
>19:22:35,341 DBG payload: added package requirement 'lvm2' for storage, strong=True
>19:22:35,341 DBG payload: no package requirement added for realm
>19:22:35,341 DBG payload: added package requirement 'authselect' for authselect, strong=True
>19:22:35,341 DBG payload: no package requirement added for firewall
>19:22:35,342 DBG payload: no package requirement added for network
>19:22:35,342 DBG payload: added package requirement 'chrony' for ntp, strong=False
>19:22:35,342 DBG payload: added package requirement 'grub2-efi-x64' for bootloader, strong=True
>19:22:35,342 DBG payload: added package requirement 'shim-x64' for bootloader, strong=True
>19:22:35,342 DBG payload: added package requirement 'efibootmgr' for bootloader, strong=True
>19:22:35,342 DBG payload: added package requirement 'grub2' for bootloader, strong=True
>19:22:35,343 DBG payload: added package requirement 'grub2-tools' for bootloader, strong=True
>19:22:35,351 DBG payload: no group requirement added for language groups
>19:22:35,376 DBG payload: added package requirement 'langpacks-en' for langpacks, strong=False
>19:22:35,424 DBG installation: Task completed: Find additional packages & run preInstall() (14/18) (0.1 s)
>19:22:35,425 INF progress: Find additional packages & run preInstall()
>19:22:35,425 INF installation: Queue started: Payload installation (6/9)
>19:22:35,426 INF progress: Installing.
>19:22:35,426 INF installation: Task started: Install the payload (15/18)
>19:22:35,426 INF progress: Starting package installation process
>19:22:35,438 DBG payload: apply with result True called on requirements [('package', 'e2fsprogs', PayloadRequirement(id=e2fsprogs, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'dosfstools', PayloadRequirement(id=dosfstools, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'lvm2', PayloadRequirement(id=lvm2, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'authselect', PayloadRequirement(id=authselect, reasons=[PayloadRequirementReason(reason='authselect', strong=True)])), ('package', 'chrony', PayloadRequirement(id=chrony, reasons=[PayloadRequirementReason(reason='ntp', strong=False)])), ('package', 'grub2-efi-x64', PayloadRequirement(id=grub2-efi-x64, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'shim-x64', PayloadRequirement(id=shim-x64, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'efibootmgr', PayloadRequirement(id=efibootmgr, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'grub2', PayloadRequirement(id=grub2, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'grub2-tools', PayloadRequirement(id=grub2-tools, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'langpacks-en', PayloadRequirement(id=langpacks-en, reasons=[PayloadRequirementReason(reason='langpacks', strong=False)]))]
>19:23:04,834 DBG ui.common: Left spoke: UserSpoke
>19:32:06,929 INF threading: Thread Failed: AnaInstallThread (139834031146752)
>19:32:06,930 DBG exception: running handleException
>19:32:06,931 CRT exception: Traceback (most recent call last):
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/threading.py", line 286, in run
>    threading.Thread.run(self)
>
>  File "/usr/lib64/python3.7/threading.py", line 865, in run
>    self._target(*self._args, **self._kwargs)
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/installation.py", line 375, in doInstall
>    installation_queue.start()
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/installation_tasks.py", line 304, in start
>    item.start()
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/installation_tasks.py", line 304, in start
>    item.start()
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/installation_tasks.py", line 472, in start
>    self.run_task()
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/installation_tasks.py", line 438, in run_task
>    self._task(*self._task_args, **self._task_kwargs)
>
>  File "/usr/lib64/python3.7/site-packages/pyanaconda/payload/dnfpayload.py", line 1008, in install
>    self._base.download_packages(pkgs_to_download, progress)
>
>  File "/usr/lib/python3.7/site-packages/dnf/base.py", line 1132, in download_packages
>    errors = dnf.repo._download_payloads(payloads, drpm)
>
>  File "/usr/lib/python3.7/site-packages/dnf/repo.py", line 137, in _download_payloads
>    librepo.download_packages(targets, failfast=True)
>
>  File "/usr/lib64/python3.7/site-packages/librepo/__init__.py", line 1616, in download_packages
>    return _librepo.download_packages(list, failfast)
>
>OSError: [Errno unknown] Cannot open /mnt/sysimage/home/dnf.package.cache/samba-client-libs-4.9.0-0.2.rc2.fc29.x86_64.rpm: Read-only file system: 'Input/Output error'
>
>19:32:06,931 DBG exception: Gtk running, queuing exception handler to the main loop
>19:32:06,931 INF threading: Thread Done: AnaInstallThread (139834031146752)
>19:34:16,041 INF core.util: Running kickstart %%onerror script(s)
>19:34:16,042 INF core.util: All kickstart %%onerror script(s) have been run
>19:34:16,042 INF kickstart.script: Running kickstart %%traceback script(s)
>19:34:16,042 INF kickstart.script: All kickstart %%traceback script(s) have been run

Actions: View

Attachments on bug 1618443: 1476454 | 1476455 | 1476456 | 1476457 | 1476458 | 1476459 | 1476460 | 1476461 | 1476462 | 1476463 | 1476464 | 1476465 | 1476466 | 1476467 | 1476468 | 1476469