Attachment 1447380 Details for Bug 1585231 – anaconda.log from the installation attempt

anaconda.log from the installation attempt

anaconda.log (text/plain), 37.18 KB, created by Martin Kolman on 2018-06-04 09:56:50 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Martin Kolman

Created: 2018-06-04 09:56:50 UTC

Size: 37.18 KB

patch

obsolete

>13:51:17,492 INF main: /sbin/anaconda 29.15-1.fc29
>13:51:17,493 INF main: Using updates in /tmp/updates/ from http://cobra02/ks/mk/master_updates.img
>13:51:17,660 INF isys: 8164372 kB (7973 MB) are available
>13:51:17,685 INF startup_utils: check_memory(): total:7973, needed:320, graphical:410
>13:51:17,685 INF startup_utils: Switching logging level to debug
>13:51:17,698 INF main: anaconda called with cmdline = ['/sbin/anaconda']
>13:51:17,698 INF main: Default encoding = utf-8 
>13:51:17,778 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-RB8jCBA7E9,guid=b501b14d86dd46d3ebda300b5b114f55.
>13:51:18,188 INF startup_utils: Waiting 600 sec for modules to be started.
>13:51:19,279 INF startup_utils: Parsing kickstart: /run/install/ks.cfg
>13:51:19,332 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'
>13:51:19,932 WRN kickstart: Command xconfig will be parsed in DBus module.
>13:51:19,933 WRN kickstart: Command lang will be parsed in DBus module.
>13:51:19,933 WRN kickstart: Command keyboard will be parsed in DBus module.
>13:51:19,933 WRN kickstart: Command rootpw will be parsed in DBus module.
>13:51:19,934 WRN kickstart: Command firewall will be parsed in DBus module.
>13:51:19,934 WRN kickstart: Command selinux will be parsed in DBus module.
>13:51:19,934 WRN kickstart: Command firstboot will be parsed in DBus module.
>13:51:19,935 WRN kickstart: Command timezone will be parsed in DBus module.
>13:51:19,935 WRN kickstart: Command zerombr will be parsed in DBus module.
>13:51:19,935 WRN kickstart: Command clearpart will be parsed in DBus module.
>13:51:19,936 WRN kickstart: Command autopart will be parsed in DBus module.
>13:51:20,308 DBG localization: setting locale to: en_US.UTF-8
>13:51:20,325 DBG network: devices found ['ens3']
>13:51:20,339 DBG network: ensure single initramfs connections
>13:51:20,412 DBG network: apply kickstart
>13:51:20,412 DBG network: create missing ifcfg files
>13:51:20,523 DBG network: set real ONBOOT value
>13:51:20,528 INF threading: Running Thread: AnaWaitForConnectingNMThread (139635885369088)
>13:51:20,530 DBG anaconda: setting display mode to GUI
>13:51:20,540 INF anaconda: Display mode is set to 'interactive graphical mode'.
>13:51:20,542 INF isys: 8164372 kB (7973 MB) are available
>13:51:20,561 INF startup_utils: check_memory(): total:7973, needed:320, graphical:410
>13:51:20,562 DBG core.util: Setting timeout 60 seconds for starting X.
>13:51:20,593 INF network: got 2 NTP servers from DHCP
>13:51:20,624 INF threading: Thread Done: AnaWaitForConnectingNMThread (139635885369088)
>13:51:22,153 DBG core.util: X server has signalled a successful start.
>13:51:22,175 INF display: Setting the screen resolution to: 1024x768.
>13:51:22,986 INF display: Started spice-vdagent.
>13:51:23,306 DBG installclass: Searching /tmp/updates/pyanaconda/installclasses.
>13:51:23,317 DBG installclass: Found Fedora (DefaultInstallClass).
>13:51:23,317 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>13:51:23,317 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>13:51:23,318 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>13:51:23,318 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>13:51:23,318 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>13:51:23,318 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>13:51:23,318 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>13:51:23,318 DBG installclass: Searching /usr/lib64/python3.6/site-packages/pyanaconda/installclasses.
>13:51:23,320 INF installclass: Using a visible install class Fedora (FedoraBaseInstallClass).
>13:51:23,783 DBG payload: getting release version from tree at None (rawhide)
>13:51:23,783 DBG payload: using default release version of rawhide
>13:51:24,090 INF bootloader: bootloader GRUB2 on X86 platform
>13:51:24,091 INF autopart: Detected 7.79 GiB of memory
>13:51:24,092 INF autopart: Suggested swap size (7.79 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>13:51:24,092 INF autopart: Swap attempt of 0.0
>13:51:24,093 INF bootloader: bootloader GRUB2 on X86 platform
>13:51:24,298 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>13:51:24,300 INF threading: Running Thread: AnaStorageThread (139635885369088)
>13:51:24,307 INF threading: Running Thread: AnaTimeInitThread (139635663935232)
>13:51:24,353 DBG payload: Restarting payload thread
>13:51:24,353 INF threading: Running Thread: AnaPayloadRestartThread (139635655542528)
>13:51:24,354 INF geoloc: Geolocation is enabled during kickstart installation due to use of the geoloc-use-with-ks option.
>13:51:24,356 INF threading: Running Thread: AnaPayloadThread (139635647149824)
>13:51:24,356 INF threading: Thread Done: AnaPayloadRestartThread (139635655542528)
>13:51:24,356 DBG payload: Updating payload thread state: 0
>13:51:24,358 INF threading: Running Thread: AnaGeolocationRefreshThread (139635638757120)
>13:51:24,360 DBG payload: Updating payload thread state: 1
>13:51:24,371 INF geoloc: Starting geolocation lookup
>13:51:24,371 INF geoloc: Geolocation provider: Fedora GeoIP
>13:51:25,061 DBG ui.gui: Detected primary monitor: 1024x768 95dpix 96dpiy
>13:51:25,002 INF threading: Thread Done: AnaTimeInitThread (139635663935232)
>13:51:25,219 DBG ui.gui.spokes.network: network standalone spoke (init): completed: ['ens3']
>13:51:25,274 INF lifecycle: Adding controller: SummaryHub
>13:51:25,398 INF geoloc: Geolocation lookup finished in 1.0 seconds
>13:51:25,399 INF geoloc: got results from geolocation
>13:51:25,400 INF threading: Thread Done: AnaGeolocationRefreshThread (139635638757120)
>13:51:26,106 INF threading: Running Thread: AnaAddLayoutsInitThread (139635638757120)
>13:51:26,111 DBG ui.gui.utils: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7eff74163518>> on <list object at 0x7eff7424f308>
>13:51:26,111 INF threading: Running Thread: AnaGtkBatchPre1 (139635663935232)
>13:51:26,115 INF threading: Thread Done: AnaGtkBatchPre1 (139635663935232)
>13:51:26,152 INF threading: Running Thread: AnaKeyboardThread (139635663935232)
>13:51:26,682 INF lifecycle: Module initialized: LangsupportSpoke
>13:51:26,976 INF threading: Running Thread: AnaNTPserver1 (139635655542528)
>13:51:26,977 INF threading: Running Thread: AnaNTPserver2 (139635604707072)
>13:51:26,978 INF threading: Running Thread: AnaDateTimeThread (139635596314368)
>13:51:27,199 INF threading: Thread Done: AnaNTPserver1 (139635655542528)
>13:51:27,344 INF threading: Thread Done: AnaNTPserver2 (139635604707072)
>13:51:28,076 INF threading: Running Thread: AnaSourceWatcher (139635604707072)
>13:51:28,087 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke]
>13:51:28,102 INF threading: Running Thread: AnaSoftwareWatcher (139635655542528)
>13:51:28,106 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke, SoftwareSelectionSpoke]
>13:51:28,193 INF threading: Running Thread: AnaStorageWatcher (139635587921664)
>13:51:31,696 DBG storage: blkid.tab devs: []
>13:51:31,696 DBG storage: parsing /mnt/sysimage/etc/crypttab
>13:51:31,697 DBG storage: crypttab maps: []
>13:51:31,697 DBG storage: parsing /mnt/sysimage/etc/fstab
>13:51:33,403 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke, SoftwareSelectionSpoke, StorageSpoke]
>13:51:33,408 DBG storage: onlyuse is now: vda
>13:51:33,408 INF threading: Thread Done: AnaStorageThread (139635885369088)
>13:51:33,409 DBG payload: Updating payload thread state: 2
>13:51:33,409 DBG payload: Updating payload thread state: 4
>13:51:33,422 INF lifecycle: Module initialized: StorageSpoke
>13:51:33,422 INF threading: Thread Done: AnaStorageWatcher (139635587921664)
>13:51:33,461 DBG payload: getting release version from tree at http://cobra02/trees/rawhide (rawhide)
>13:51:33,461 DBG payload: retrieving treeinfo from http://cobra02/trees/rawhide (proxy:  ; sslverify: True)
>13:51:33,461 INF payload: Trying to download '.treeinfo'
>13:51:33,468 INF threading: Running Thread: AnaCustomStorageInit (139635587921664)
>13:51:33,469 DBG payload: Retrieved '.treeinfo' from http://cobra02/trees/rawhide
>13:51:33,471 DBG payload: using treeinfo release version of rawhide
>13:51:33,673 INF lifecycle: Module initialized: BlivetGuiSpoke
>13:51:33,714 INF lifecycle: Module initialized: FilterSpoke
>13:51:33,759 DBG ui.gui.spokes.network: can't get remote connection of active connection of device ens3
>13:51:33,760 DBG ui.gui.spokes.network: device configuration added: connection 6bedcf09-0711-4267-99bf-38153a75ac28 device ens3
>13:51:33,764 DBG ui.gui.spokes.network: not adding connection 6bedcf09-0711-4267-99bf-38153a75ac28, already in list
>13:51:33,770 INF lifecycle: Module initialized: NetworkSpoke
>13:51:33,868 DBG payload: Source http://cobra02/trees/rawhide needs network for installation
>13:51:33,879 INF lifecycle: Initialization of all modules (10) has been started.
>13:51:33,881 DBG ui.gui.hubs: Starting event loop for hub SummaryHub
>13:51:33,974 DBG ui.common: Entered hub: SummaryHub
>13:51:33,976 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/Gdk.py:336: DeprecationWarning: Gdk.Cursor.new is deprecated
>  return cls.new(*args, **kwds)
>
>13:51:33,992 DBG ui.gui.hubs: spoke is not ready: KeyboardSpoke
>13:51:33,992 DBG ui.gui.hubs: setting KeyboardSpoke status to: Getting list of layouts...
>13:51:33,994 DBG ui.gui.hubs: spoke is not ready: SoftwareSelectionSpoke
>13:51:33,995 DBG ui.gui.hubs: spoke is not ready: SourceSpoke
>13:51:33,996 DBG ui.gui.hubs: setting SourceSpoke status to: Setting up installation source...
>13:51:33,996 DBG ui.gui.hubs: setting SourceSpoke status to: Probing storage...
>13:51:33,996 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>13:51:33,996 DBG ui.gui.hubs: setting SourceSpoke status to: Downloading package metadata...
>13:51:33,996 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>13:51:33,996 DBG ui.gui.hubs: setting SoftwareSelectionSpoke status to: Downloading package metadata...
>13:51:34,196 INF lifecycle: Module initialized: CustomPartitioningSpoke
>13:51:34,196 INF threading: Thread Done: AnaCustomStorageInit (139635587921664)
>09:51:34,000 INF isys: System time set to Fri Jun  1 13:51:34 2018 UTC
>09:51:34,000 INF isys: System time set to Fri Jun  1 13:51:34 2018 UTC
>09:51:34,000 INF isys: System time set to Fri Jun  1 13:51:34 2018 UTC
>09:51:34,000 INF lifecycle: Module initialized: DatetimeSpoke
>09:51:34,001 INF threading: Thread Done: AnaDateTimeThread (139635596314368)
>09:51:34,002 INF threading: Running Thread: AnaExecuteStorageThread (139635596314368)
>09:51:34,019 DBG ui.gui.hubs: spoke is ready: DatetimeSpoke
>09:51:34,022 DBG storage: clearpart: looking at vda2
>09:51:34,023 DBG ui.gui.hubs: kickstart installation, spoke TIME & DATE is ready
>09:51:34,024 DBG ui.gui.hubs: execute spoke from event loop TIME & DATE
>09:51:34,068 DBG payload: Updating payload thread state: 5
>09:51:34,089 DBG storage: partitions: ['vda1']
>09:51:34,090 DBG storage: clearpart: looking at vda1
>09:51:34,112 DBG storage: partitions: []
>09:51:34,124 DBG storage: clearpart: initializing vda
>09:51:34,227 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run True.
>09:51:34,229 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>09:51:34,230 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>09:51:34,230 DBG ui.gui.hubs: setting SourceSpoke status to: Downloading group metadata...
>09:51:34,231 DBG ui.gui.hubs: setting SoftwareSelectionSpoke status to: Downloading group metadata...
>09:51:34,240 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>09:51:34,242 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>09:51:34,247 DBG kickstart.kickstart.bootloader: Applying drive order: []
>09:51:34,248 DBG bootloader: new disk order: []
>09:51:34,260 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>09:51:34,260 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>09:51:34,261 DBG kickstart.kickstart.bootloader: Using a boot drive: vda
>09:51:34,282 INF autopart: Detected 7.79 GiB of memory
>09:51:34,285 INF autopart: Suggested swap size (7.79 GiB) exceeds 10 % of disk space, using 10 % of disk space (3.2 GiB) instead.
>09:51:34,287 INF autopart: Swap attempt of 3.2 GiB
>09:51:34,293 DBG autopart: do_autopart: True
>09:51:34,293 DBG autopart: encrypted_autopart: False
>09:51:34,294 DBG autopart: autopart_type: 2
>09:51:34,294 DBG autopart: clear_part_type: 1
>09:51:34,294 DBG autopart: clear_part_disks: ['vda']
>09:51:34,296 DBG autopart: autopart_requests:
>PartSpec instance (0x7eff7bf9eb38) -- 
>  mountpoint = /  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024 MiB  max_size = 50 GiB  grow = True
>PartSpec instance (0x7eff7bf9ea90) -- 
>  mountpoint = /home  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500 MiB  max_size = None  grow = True
>PartSpec instance (0x7eff7bf9ea20) -- 
>  mountpoint = None  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = biosboot  encrypted = False
>  size = 1024 KiB  max_size = None  grow = False
>PartSpec instance (0x7eff7bf9e978) -- 
>  mountpoint = /boot  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = ext4  encrypted = False
>  size = 1024 MiB  max_size = None  grow = False
>PartSpec instance (0x7eff7bf9ee80) -- 
>  mountpoint = None  lv = True  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 3.2 GiB  max_size = None  grow = False
>
>09:51:34,296 DBG autopart: storage.disks: ['vda']
>09:51:34,297 DBG autopart: storage.partitioned: ['vda']
>09:51:34,298 DBG autopart: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/tmp/curl_fetch_url1/install.img (deleted)', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'vda']
>09:51:34,298 DBG autopart: boot disk: vda
>09:51:34,332 DBG autopart: candidate disks: [DiskDevice instance (0x7eff7bf0c3c8) --
>  name = vda  status = True  id = 2
>  children = []
>  parents = []
>  uuid = None  size = 32 GiB
>  format = non-existent msdos disklabel
>  major = 252  minor = 0  exists = True  protected = False
>  sysfs path = /sys/devices/pci0000:00/0000:00:07.0/virtio2/block/vda
>  target size = 32 GiB  path = /dev/vda
>  format args = []  original_format = disklabel  removable = False  wwn = None]
>09:51:34,335 DBG autopart: devs: [PartitionDevice instance (0x7eff83576240) --
>  name = req0  status = False  id = 176
>  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
>]
>09:51:34,339 DBG bootloader: _is_valid_disklabel(vda) returning True
>09:51:34,339 DBG bootloader: _is_valid_size(vda) returning True
>09:51:34,339 DBG bootloader: _is_valid_location(vda) returning True
>09:51:34,339 DBG bootloader: _is_valid_format(vda) returning True
>09:51:34,340 DBG bootloader: is_valid_stage1_device(vda) returning True
>09:51:34,340 INF autopart: skipping unneeded stage1 biosboot request
>09:51:34,340 DBG autopart: PartSpec instance (0x7eff7bf9ea20) -- 
>  mountpoint = None  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = biosboot  encrypted = False
>  size = 1024 KiB  max_size = None  grow = False
>
>09:51:34,341 DBG autopart: existing 32 GiB disk vda (2) with non-existent msdos disklabel
>09:51:34,802 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>09:51:34,812 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>09:51:34,814 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>09:51:34,819 DBG kickstart.kickstart.bootloader: Applying drive order: []
>09:51:34,819 DBG bootloader: new disk order: []
>09:51:34,824 DBG kickstart.kickstart.bootloader: Found a boot drive: vda
>09:51:34,824 DBG kickstart.kickstart.bootloader: Use a usable drive with a /boot partition.
>09:51:34,824 DBG kickstart.kickstart.bootloader: Using a boot drive: vda
>09:51:34,839 DBG bootloader: stage1 device cannot be of type lvmvg
>09:51:34,840 DBG bootloader: stage1 device cannot be of type lvmlv
>09:51:34,841 DBG bootloader: stage1 device cannot be of type lvmlv
>09:51:34,842 DBG bootloader: _is_valid_disklabel(vda) returning True
>09:51:34,843 DBG bootloader: _is_valid_size(vda) returning True
>09:51:34,843 DBG bootloader: _is_valid_location(vda) returning True
>09:51:34,843 DBG bootloader: _is_valid_format(vda) returning True
>09:51:34,843 DBG bootloader: is_valid_stage1_device(vda) returning True
>09:51:34,847 DBG bootloader: _is_valid_disklabel(vda) returning True
>09:51:34,847 DBG bootloader: _is_valid_size(vda) returning True
>09:51:34,847 DBG bootloader: _is_valid_location(vda) returning True
>09:51:34,847 DBG bootloader: _is_valid_format(vda) returning True
>09:51:34,848 DBG bootloader: is_valid_stage1_device(vda) returning True
>09:51:34,848 DBG bootloader: _is_valid_disklabel(vda1) returning True
>09:51:34,849 DBG bootloader: _is_valid_size(vda1) returning True
>09:51:34,849 DBG bootloader: _is_valid_partition(vda1) returning True
>09:51:34,850 DBG bootloader: _is_valid_format(vda1) returning True
>09:51:34,850 DBG bootloader: is_valid_stage2_device(vda1) returning True
>09:51:34,874 DBG kickstart.kickstart.autopart: 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': {'/usr/share', '/var', '/usr', '/', '/usr/lib', '/home', '/tmp'}, 'must_be_on_root': {'/bin', '/lib', '/root', '/dev', '/proc', '/sbin', 'lost+found', '/mnt', '/etc'}, 'swap_is_recommended': True}.
>09:51:34,874 DBG kickstart.kickstart.autopart: Run sanity check verify_root.
>09:51:34,874 DBG kickstart.kickstart.autopart: Run sanity check verify_s390_constraints.
>09:51:34,874 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_sizes.
>09:51:34,874 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_format_sizes.
>09:51:34,874 DBG kickstart.kickstart.autopart: Run sanity check verify_bootloader.
>09:51:34,875 DBG kickstart.kickstart.autopart: Run sanity check verify_gpt_biosboot.
>09:51:34,875 DBG kickstart.kickstart.autopart: Run sanity check verify_swap.
>09:51:34,875 DBG kickstart.kickstart.autopart: Run sanity check verify_swap_uuid.
>09:51:34,875 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_linuxfs.
>09:51:34,875 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_root.
>09:51:34,875 DBG kickstart.kickstart.autopart: Run sanity check verify_luks_devices_have_key.
>09:51:34,876 DBG kickstart.kickstart.autopart: Run sanity check verify_mounted_partitions.
>09:51:34,876 DBG kickstart.kickstart.autopart: Storage check finished with success.
>09:51:34,876 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>09:51:34,884 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>09:51:34,886 DBG kickstart.kickstart.bootloader: Applying bootloader location: DEFAULT
>09:51:34,892 DBG kickstart.kickstart.bootloader: Applying drive order: []
>09:51:34,892 DBG bootloader: new disk order: []
>09:51:34,896 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>09:51:35,118 DBG storage_utils: vda matches ['vda'] for devicetree=existing 32 GiB disk vda (2) with non-existent msdos disklabel
>  non-existent 1024 MiB partition vda1 (183) with non-existent ext4 filesystem mounted at /boot
>  non-existent 31 GiB partition vda2 (176) with non-existent lvmpv
>    non-existent 31 GiB lvmvg fedora (189)
>      non-existent 27.79 GiB lvmlv fedora-root (195) with non-existent ext4 filesystem mounted at /
>      non-existent 3.2 GiB lvmlv fedora-swap (204) with non-existent swap
>existing 0 B file /tmp/curl_fetch_url1/install.img (deleted) (62)
>  existing 0 B loop loop0 (66)
>existing 0 B file /LiveOS/rootfs.img (76)
>  existing 0 B loop loop1 (80) with existing ext4 filesystem
>    existing 2 GiB dm live-rw (99) with existing ext4 filesystem
>    existing 2 GiB dm live-base (109) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (90)
>  existing 0 B loop loop2 (94)
> and disks_only=True
>09:51:35,125 DBG kickstart.kickstart.bootloader: Using a boot drive: vda
>09:51:35,140 DBG bootloader: stage1 device cannot be of type lvmvg
>09:51:35,141 DBG bootloader: stage1 device cannot be of type lvmlv
>09:51:35,142 DBG bootloader: stage1 device cannot be of type lvmlv
>09:51:35,143 DBG bootloader: _is_valid_disklabel(vda) returning True
>09:51:35,144 DBG bootloader: _is_valid_size(vda) returning True
>09:51:35,144 DBG bootloader: _is_valid_location(vda) returning True
>09:51:35,144 DBG bootloader: _is_valid_format(vda) returning True
>09:51:35,144 DBG bootloader: is_valid_stage1_device(vda) returning True
>09:51:35,145 INF threading: Running Thread: AnaCheckStorageThread (139635587921664)
>09:51:35,153 INF threading: Thread Done: AnaExecuteStorageThread (139635596314368)
>09:51:35,161 DBG bootloader: _is_valid_disklabel(vda) returning True
>09:51:35,163 DBG bootloader: _is_valid_size(vda) returning True
>09:51:35,163 DBG bootloader: _is_valid_location(vda) returning True
>09:51:35,164 DBG bootloader: _is_valid_format(vda) returning True
>09:51:35,164 DBG bootloader: is_valid_stage1_device(vda) returning True
>09:51:35,167 DBG bootloader: _is_valid_disklabel(vda1) returning True
>09:51:35,170 DBG bootloader: _is_valid_size(vda1) returning True
>09:51:35,171 DBG bootloader: _is_valid_partition(vda1) returning True
>09:51:35,173 DBG bootloader: _is_valid_format(vda1) returning True
>09:51:35,173 DBG bootloader: is_valid_stage2_device(vda1) returning True
>09:51:35,206 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': {'/usr/share', '/var', '/usr', '/', '/usr/lib', '/home', '/tmp'}, 'must_be_on_root': {'/bin', '/lib', '/root', '/dev', '/proc', '/sbin', 'lost+found', '/mnt', '/etc'}, 'swap_is_recommended': True}.
>09:51:35,206 DBG ui.helpers: Run sanity check verify_root.
>09:51:35,207 DBG ui.helpers: Run sanity check verify_s390_constraints.
>09:51:35,207 DBG ui.helpers: Run sanity check verify_partition_sizes.
>09:51:35,207 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>09:51:35,208 DBG ui.helpers: Run sanity check verify_bootloader.
>09:51:35,208 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>09:51:35,208 DBG ui.helpers: Run sanity check verify_swap.
>09:51:35,208 DBG ui.helpers: Run sanity check verify_swap_uuid.
>09:51:35,209 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>09:51:35,209 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>09:51:35,209 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>09:51:35,209 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>09:51:35,209 DBG ui.helpers: Storage check finished with success.
>09:51:35,210 INF threading: Thread Done: AnaCheckStorageThread (139635587921664)
>09:51:35,214 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke, SoftwareSelectionSpoke]
>09:51:35,214 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>09:51:35,214 DBG ui.gui.hubs: kickstart installation, spoke INSTALLATION DESTINATION is ready
>09:51:35,220 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>09:51:35,220 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>09:51:35,226 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>09:51:35,227 DBG ui.gui.hubs: kickstart installation, spoke INSTALLATION DESTINATION is ready
>09:51:36,331 DBG ui.gui.utils: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7eff74163518>> on <list object at 0x7eff7424f308>
>09:51:36,331 INF threading: Thread Done: AnaAddLayoutsInitThread (139635638757120)
>09:51:36,332 INF lifecycle: Module initialized: KeyboardSpoke
>09:51:36,332 INF threading: Thread Done: AnaKeyboardThread (139635663935232)
>09:51:36,439 DBG ui.gui.hubs: spoke is ready: KeyboardSpoke
>09:51:36,442 DBG ui.gui.hubs: kickstart installation, spoke KEYBOARD is ready
>09:51:36,442 DBG ui.gui.hubs: execute spoke from event loop KEYBOARD
>09:51:52,456 INF payload: Refreshing environmentAddons
>09:51:54,535 DBG payload: Updating payload thread state: 6
>09:51:54,535 INF ui.gui.spokes.software_selection: using environment from kickstart: None
>09:51:54,535 INF threading: Thread Done: AnaPayloadThread (139635647149824)
>09:51:54,536 DBG ui.gui.spokes.installation_source: Clearing checks in source spoke
>09:51:54,536 DBG ui.gui.spokes.installation_source: Setting up repos: []
>09:51:54,537 DBG ui.gui.spokes.software_selection: Environment is not set, skip user packages settings
>09:51:54,537 INF lifecycle: Module initialized: SoftwareSelectionSpoke
>09:51:54,538 INF threading: Thread Done: AnaSoftwareWatcher (139635655542528)
>09:51:54,540 INF lifecycle: Module initialized: SourceSpoke
>09:51:54,540 INF lifecycle: All modules have been initialized.
>09:51:54,540 INF threading: Thread Done: AnaSourceWatcher (139635604707072)
>09:51:54,568 DBG ui.gui.hubs: incomplete spokes: [SourceSpoke]
>09:51:54,569 DBG ui.gui.hubs: spoke is ready: SoftwareSelectionSpoke
>09:51:54,569 DBG ui.gui.hubs: kickstart installation, spoke SOFTWARE SELECTION is ready
>09:51:54,569 DBG ui.gui.hubs: execute spoke from event loop SOFTWARE SELECTION
>09:51:54,572 DBG ui.gui.hubs: incomplete spokes: []
>09:51:54,608 INF ui.lib.space: fs space: 23.62 GiB  needed: 2.79 GiB
>09:51:54,609 DBG ui.gui.hubs: spoke is ready: SourceSpoke
>09:51:54,610 DBG ui.gui.hubs: kickstart installation, spoke INSTALLATION SOURCE is ready
>09:51:54,640 INF ui.lib.space: fs space: 23.62 GiB  needed: 2.79 GiB
>09:51:54,641 DBG ui.gui.hubs: spoke is ready: SoftwareSelectionSpoke
>09:51:54,641 DBG ui.gui.hubs: kickstart installation, spoke SOFTWARE SELECTION is ready
>09:51:54,667 INF ui.lib.space: fs space: 23.62 GiB  needed: 2.79 GiB
>09:51:54,668 DBG ui.gui.hubs: spoke is ready: SourceSpoke
>09:51:54,668 DBG ui.gui.hubs: kickstart installation, spoke INSTALLATION SOURCE is ready
>09:51:54,669 DBG ui.gui.hubs: _autoContinue clicking continue button
>09:51:54,758 DBG ui.common: Left hub: SummaryHub
>09:51:54,776 INF lifecycle: Adding controller: ProgressHub
>09:51:54,795 INF lifecycle: Module initialized: PasswordSpoke
>09:51:54,819 INF lifecycle: Module initialized: UserSpoke
>09:51:54,824 INF lifecycle: Initialization of all modules (2) has been started.
>09:51:54,825 INF lifecycle: All modules have been initialized.
>09:51:54,826 DBG ui.gui.hubs: Disabling event loop for hub SummaryHub
>09:51:54,826 DBG ui.gui.hubs: Starting event loop for hub ProgressHub
>09:51:54,826 INF threading: Running Thread: AnaInstallThread (139635604707072)
>09:51:54,831 DBG installation: CAN INSTALL BOOTLOADER
>09:51:54,831 DBG installation: True
>09:51:54,832 DBG installation: ADDING BOOTLOADER TASK
>09:51:54,833 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
>09:51:54,834 INF installation: Task started: Save system time to HW clock (1/18)
>09:51:54,834 DBG ui.common: Entered hub: ProgressHub
>09:51:54,939 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>09:51:54,940 DBG ui.gui.hubs: kickstart installation, spoke ROOT PASSWORD is ready
>09:51:55,502 DBG installation: Task completed: Save system time to HW clock (1/18) (0.7 s)
>09:51:55,503 INF progress: Save system time to HW clock
>09:51:55,503 INF installation: Queue started: Installation environment setup (1/9)
>09:51:55,503 INF progress: Setting up the installation environment
>09:51:55,504 INF installation: Task started: Setup addons (2/18)
>09:51:55,504 DBG installation: Task completed: Setup addons (2/18) (0.0 s)
>09:51:55,504 INF progress: Setup addons
>09:51:55,505 INF installation: Queue started: Early storage configuration (2/9)
>09:51:55,505 INF progress: Configuring storage
>09:51:55,505 INF installation: Task started: Insert custom storage to ksdata (3/18)
>09:51:55,523 DBG installation: Task completed: Insert custom storage to ksdata (3/18) (0.0 s)
>09:51:55,523 INF progress: Insert custom storage to ksdata
>09:51:55,523 INF installation: Task started: Run pre-storage tasks (4/18)
>09:51:55,524 DBG installation: Task completed: Run pre-storage tasks (4/18) (0.0 s)
>09:51:55,524 INF progress: Run pre-storage tasks
>09:51:55,524 INF installation: Task started: Activate filesystems (5/18)
>09:51:57,166 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/BlockDev.py:521: Warning: g_variant_builder_add_value: assertion '!GVSB(builder)->expected_type || g_variant_is_of_type (value, GVSB(builder)->expected_type)' failed
>  return _lvm_lvremove(vg_name, lv_name, force, extra)
>
>09:51:58,343 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/BlockDev.py:521: Warning: g_variant_builder_add_value: assertion '!GVSB(builder)->expected_type || g_variant_is_of_type (value, GVSB(builder)->expected_type)' failed
>  return _lvm_lvremove(vg_name, lv_name, force, extra)
>
>09:51:59,318 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/BlockDev.py:444: Warning: g_variant_builder_add_value: assertion '!GVSB(builder)->expected_type || g_variant_is_of_type (value, GVSB(builder)->expected_type)' failed
>  return _lvm_pvremove(device, extra)
>
>09:52:00,629 INF progress: Creating disklabel on /dev/vda
>09:52:01,293 INF progress: Creating ext4 on /dev/vda1
>09:52:02,151 INF progress: Creating lvmpv on /dev/vda2
>09:52:03,208 INF progress: Creating swap on /dev/mapper/fedora-swap
>09:52:03,679 INF progress: Creating ext4 on /dev/mapper/fedora-root
>09:52:04,217 INF storage: setting boot flag on vda1
>09:52:08,635 DBG installation: Task completed: Activate filesystems (5/18) (13.1 s)
>09:52:08,635 INF progress: Activate filesystems
>09:52:08,635 INF installation: Task started: Write early storage (6/18)
>09:52:08,639 INF storage: not writing out mpath configuration
>09:52:08,640 DBG installation: Task completed: Write early storage (6/18) (0.0 s)
>09:52:08,640 INF progress: Write early storage
>09:52:08,640 INF installation: Queue started: Pre-install scripts (3/9)
>09:52:08,640 INF progress: Running pre-installation scripts
>09:52:08,641 INF installation: Task started: Run %pre-install scripts (7/18)
>09:52:08,641 DBG installation: Task completed: Run %pre-install scripts (7/18) (0.0 s)
>09:52:08,641 INF progress: Run %pre-install scripts
>09:52:08,641 INF installation: Queue started: Realm discover (4/9)
>09:52:08,642 INF progress: Discovering realm to join
>09:52:08,642 INF installation: Task started: Discover realm to join (8/18)
>09:52:08,647 DBG installation: Task completed: Discover realm to join (8/18) (0.0 s)
>09:52:08,647 INF progress: Discover realm to join
>09:52:08,648 INF installation: Queue started: Pre install tasks (5/9)
>09:52:08,648 INF progress: Running pre-installation tasks
>09:52:08,649 INF installation: Task started: Setup authselect (9/18)
>09:52:08,653 DBG installation: Task completed: Setup authselect (9/18) (0.0 s)
>09:52:08,653 INF progress: Setup authselect
>09:52:08,654 INF installation: Task started: Setup firewall (10/18)
>09:52:08,657 DBG installation: Task completed: Setup firewall (10/18) (0.0 s)
>09:52:08,657 INF progress: Setup firewall
>09:52:08,658 INF installation: Task started: Setup network (11/18)
>09:52:08,675 DBG installation: Task completed: Setup network (11/18) (0.0 s)
>09:52:08,675 INF progress: Setup network
>09:52:08,676 INF installation: Task started: Setup timezone (12/18)
>09:52:08,785 DBG installation: Task completed: Setup timezone (12/18) (0.1 s)
>09:52:08,786 INF progress: Setup timezone
>09:52:08,786 INF installation: Task started: Copy /resolv.conf to sysroot (13/18)
>09:52:08,787 DBG installation: Task completed: Copy /resolv.conf to sysroot (13/18) (0.0 s)
>09:52:08,788 INF progress: Copy /resolv.conf to sysroot
>09:52:08,788 INF installation: Task started: Find additional packages & run preInstall() (14/18)
>09:52:08,790 DBG payload: added package requirement 'e2fsprogs' for storage, strong=True
>09:52:08,790 DBG payload: added package requirement 'lvm2' for storage, strong=True
>09:52:08,790 DBG payload: no package requirement added for realm
>09:52:08,791 DBG payload: no package requirement added for authselect
>09:52:08,791 DBG payload: added package requirement 'firewalld' for firewall, strong=True
>09:52:08,791 DBG payload: no package requirement added for network
>09:52:08,791 DBG payload: no package requirement added for ntp
>09:52:08,792 DBG payload: added package requirement 'grub2' for bootloader, strong=True
>09:52:08,792 DBG payload: added package requirement 'grub2-tools' for bootloader, strong=True
>09:52:08,802 DBG payload: no group requirement added for language groups
>09:52:08,820 DBG payload: added package requirement 'langpacks-en' for langpacks, strong=False
>09:52:08,921 WRN payload: Platform group platform-kvm not available.
>09:52:08,922 DBG installation: Task completed: Find additional packages & run preInstall() (14/18) (0.1 s)
>09:52:08,923 INF progress: Find additional packages & run preInstall()
>09:52:08,923 INF installation: Queue started: Payload installation (6/9)
>09:52:08,924 INF progress: Installing.
>09:52:08,924 INF installation: Task started: Install the payload (15/18)
>09:52:08,925 INF progress: Starting package installation process
>09:52:08,997 DBG payload: apply with result True called on requirements [('package', 'e2fsprogs', PayloadRequirement(id=e2fsprogs, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'lvm2', PayloadRequirement(id=lvm2, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'firewalld', PayloadRequirement(id=firewalld, reasons=[PayloadRequirementReason(reason='firewall', 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)]))]
>09:52:09,022 INF core.util: Running kickstart %%onerror script(s)
>09:52:09,022 INF core.util: All kickstart %%onerror script(s) have been run
>09:52:09,022 DBG exception: running handleException
>09:52:09,024 CRT exception: Traceback (most recent call last):
>
>  File "/tmp/updates/pyanaconda/payload/dnfpayload.py", line 562, in _apply_selections
>    self._base.install_specs(install=include_list, exclude=exclude_list)
>
>  File "/tmp/updates/dnf/base.py", line 1857, in install_specs
>    self.install(spec, strict=self.conf.strict)
>
>  File "/tmp/updates/dnf/base.py", line 1913, in install
>    raise dnf.exceptions.MarkingError(_('no package matched'), pkg_spec)
>
>dnf.exceptions.MarkingError: no package matched
>
>
>During handling of the above exception, another exception occurred:
>
>
>Traceback (most recent call last):
>
>  File "/tmp/updates/pyanaconda/threading.py", line 291, in run
>    threading.Thread.run(self)
>
>  File "/usr/lib64/python3.6/threading.py", line 864, in run
>    self._target(*self._args, **self._kwargs)
>
>  File "/tmp/updates/pyanaconda/installation.py", line 376, in doInstall
>    installation_queue.start()
>
>  File "/tmp/updates/pyanaconda/installation_tasks.py", line 304, in start
>    item.start()
>
>  File "/tmp/updates/pyanaconda/installation_tasks.py", line 304, in start
>    item.start()
>
>  File "/tmp/updates/pyanaconda/installation_tasks.py", line 472, in start
>    self.run_task()
>
>  File "/tmp/updates/pyanaconda/installation_tasks.py", line 438, in run_task
>    self._task(*self._task_args, **self._task_kwargs)
>
>  File "/tmp/updates/pyanaconda/payload/dnfpayload.py", line 986, in install
>    self.checkSoftwareSelection()
>
>  File "/tmp/updates/pyanaconda/payload/dnfpayload.py", line 862, in checkSoftwareSelection
>    self._apply_selections()
>
>  File "/tmp/updates/pyanaconda/payload/dnfpayload.py", line 566, in _apply_selections
>    self._payload_setup_error(e)
>
>  File "/tmp/updates/pyanaconda/payload/dnfpayload.py", line 700, in _payload_setup_error
>    sys.exit(1)
>
>SystemExit: 1
>
>09:52:09,025 DBG exception: Gtk running, queuing exception handler to the main loop
>09:52:09,025 INF threading: Thread Done: AnaInstallThread (139635604707072)
>09:52:31,246 INF core.util: Running kickstart %%onerror script(s)
>09:52:31,247 INF core.util: All kickstart %%onerror script(s) have been run
>09:52:31,247 INF kickstart.script: Running kickstart %%traceback script(s)
>09:52:31,248 INF kickstart.script: All kickstart %%traceback script(s) have been run

Actions: View

Attachments on bug 1585231: 1447379 | 1447380