Attachment 1451635 Details for Bug 1591505 – File: anaconda.log

File: anaconda.log

anaconda.log (text/plain), 31.39 KB, created by Piers on 2018-06-14 22:23:50 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Piers

Created: 2018-06-14 22:23:50 UTC

Size: 31.39 KB

patch

obsolete

>18:10:41,897 INF main: /sbin/anaconda 28.22.10-1.fc28
>18:10:42,247 INF isys: 3670688 kB (3584 MB) are available
>18:10:42,365 INF startup_utils: check_memory(): total:3584, needed:320, graphical:410
>18:10:42,401 INF flags: Not doing 'early exception handler' in live installation
>18:10:42,403 INF flags: Not doing 'start audit daemon' in live installation
>18:10:42,404 INF main: anaconda called with cmdline = ['/sbin/anaconda', '--liveinst', '--method=livecd:///dev/mapper/live-base']
>18:10:42,407 INF main: Default encoding = utf-8 
>18:10:42,480 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-gOyDNxX2et,guid=1bea4ab750f5d9efae5e07b35b22e7e2.
>18:10:43,909 INF startup_utils: Waiting 60 sec for modules to be started.
>18:10:44,918 INF startup_utils: Waiting 59 sec for modules to be started.
>18:10:45,924 INF startup_utils: Waiting 58 sec for modules to be started.
>18:10:46,928 INF startup_utils: Waiting 57 sec for modules to be started.
>18:10:47,933 INF startup_utils: Waiting 56 sec for modules to be started.
>18:10:48,937 INF startup_utils: Waiting 55 sec for modules to be started.
>18:10:49,944 INF startup_utils: Waiting 54 sec for modules to be started.
>18:10:50,947 INF startup_utils: Waiting 53 sec for modules to be started.
>18:10:51,952 INF startup_utils: Waiting 52 sec for modules to be started.
>18:10:52,957 INF startup_utils: Waiting 51 sec for modules to be started.
>18:10:53,964 INF startup_utils: Waiting 50 sec for modules to be started.
>18:10:54,968 INF startup_utils: Waiting 49 sec for modules to be started.
>18:10:55,973 INF startup_utils: Waiting 48 sec for modules to be started.
>18:10:57,293 INF startup_utils: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>18:11:00,487 WRN kickstart: Command firstboot will be parsed in DBus module.
>18:11:00,678 DBG localization: setting locale to: en_US.UTF-8
>18:11:00,793 DBG network: devices found ['eth0']
>18:11:00,840 DBG network: ensure single initramfs connections
>18:11:01,072 DBG network: apply kickstart
>18:11:01,072 DBG network: create missing ifcfg files
>18:11:01,421 DBG network: ifcfg file for eth0 not found
>18:11:02,298 DBG network: dumping ifcfg file for eth0 from default autoconnection 77497294-b25b-374c-b9d1-f2a597c8bc27
>18:11:02,300 DBG network: missing ifcfgs created for devices ['eth0']
>18:11:02,370 DBG network: set real ONBOOT value
>18:11:02,375 INF threading: Running Thread: AnaWaitForConnectingNMThread (140257202919168)
>18:11:02,377 DBG anaconda: setting display mode to GUI
>18:11:02,401 INF anaconda: Display mode is set to 'interactive graphical mode'.
>18:11:02,404 INF isys: 4057760 kB (3962 MB) are available
>18:11:02,455 INF startup_utils: check_memory(): total:3962, needed:320, graphical:410
>18:11:02,656 INF network: got 0 NTP servers from DHCP
>18:11:02,678 INF threading: Thread Done: AnaWaitForConnectingNMThread (140257202919168)
>18:11:03,436 DBG installclass: Searching /usr/lib64/python3.6/site-packages/pyanaconda/installclasses.
>18:11:03,448 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>18:11:03,450 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>18:11:03,452 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>18:11:03,452 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>18:11:03,452 DBG installclass: Found Fedora (DefaultInstallClass).
>18:11:03,453 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>18:11:03,453 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>18:11:03,453 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>18:11:03,454 INF installclass: Using a visible install class Fedora (FedoraBaseInstallClass).
>18:11:05,006 INF bootloader: bootloader EFIGRUB on EFI platform
>18:11:05,083 INF autopart: Detected 3.87 GiB of memory
>18:11:05,086 INF autopart: Suggested swap size (3.87 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>18:11:05,087 INF autopart: Swap attempt of 0.0
>18:11:05,115 INF bootloader: bootloader EFIGRUB on EFI platform
>18:11:05,716 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>18:11:05,727 INF threading: Running Thread: AnaStorageThread (140257202919168)
>18:11:05,731 INF threading: Running Thread: AnaTimeInitThread (140256940214016)
>18:11:05,781 DBG payload: Restarting payload thread
>18:11:05,794 INF threading: Running Thread: AnaPayloadRestartThread (140256931559168)
>18:11:05,795 INF geoloc: Geolocation is enabled.
>18:11:05,808 INF threading: Running Thread: AnaPayloadThread (140256854669056)
>18:11:05,808 INF threading: Thread Done: AnaPayloadRestartThread (140256931559168)
>18:11:05,809 DBG payload: Updating payload thread state: 0
>18:11:05,810 DBG payload: Updating payload thread state: 1
>18:11:05,813 INF threading: Running Thread: AnaGeolocationRefreshThread (140256846276352)
>18:11:05,814 INF flags: Not doing 'start chronyd' in live installation
>18:11:05,826 INF geoloc: Starting geolocation lookup
>18:11:05,830 INF geoloc: Geolocation provider: Fedora GeoIP
>18:11:08,889 INF geoloc: Geolocation lookup finished in 3.1 seconds
>18:11:08,898 INF geoloc: got results from geolocation
>18:11:08,904 INF threading: Thread Done: AnaGeolocationRefreshThread (140256846276352)
>18:11:10,720 DBG ui.gui: Detected primary monitor: 1152x864 95dpix 95dpiy
>18:11:13,429 DBG localization: setting locale to: en_GB.UTF-8
>18:11:13,902 DBG localization: setting locale to: en_US.UTF-8
>18:11:13,917 DBG localization: setting locale to: en_GB.UTF-8
>18:11:14,627 DBG ui.common: Entered spoke: WelcomeLanguageSpoke
>18:11:14,724 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/Gdk.py:336: DeprecationWarning: Gdk.Cursor.new is deprecated
>  return cls.new(*args, **kwds)
>
>18:11:26,594 DBG localization: setting locale to: en_GB.UTF-8
>18:11:26,633 INF ui.gui.spokes.welcome: using timezone determined by geolocation
>18:11:27,263 INF flags: Not doing 'require network connection' in live installation
>18:11:27,266 DBG ui.gui.spokes.network: network standalone spoke (init): completed: True
>18:11:27,269 INF flags: Not doing 'require network connection' in live installation
>18:11:27,283 DBG ui.common: Left spoke: WelcomeLanguageSpoke
>18:11:27,353 INF lifecycle: Adding controller: SummaryHub
>18:11:27,395 INF flags: Not doing 'activate layouts' in live installation
>18:11:31,160 INF threading: Running Thread: AnaAddLayoutsInitThread (140256846276352)
>18:11:31,162 DBG ui.gui.utils: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f9014287f60>> on <list object at 0x7f9014298448>
>18:11:31,186 INF threading: Running Thread: AnaGtkBatchPre1 (140256931559168)
>18:11:31,242 INF threading: Thread Done: AnaGtkBatchPre1 (140256931559168)
>18:11:31,844 INF threading: Running Thread: AnaKeyboardThread (140256931559168)
>18:11:32,836 INF flags: Not doing 'modify system time and date' in live installation
>18:11:32,915 INF threading: Running Thread: AnaNTPserver1 (140256636565248)
>18:11:32,929 INF threading: Running Thread: AnaDateTimeThread (140256628172544)
>18:11:33,881 INF threading: Thread Done: AnaNTPserver1 (140256636565248)
>18:11:34,064 INF threading: Running Thread: AnaStorageWatcher (140256636565248)
>18:11:51,901 DBG storage: protected device spec /dev/disk/by-label/Fedora-KDE-Live-28-1-1 resolved to sr0
>18:11:51,904 INF storage: resolved live device to sr0
>18:11:51,904 INF storage: marking live device sr0 protected
>18:11:59,934 DBG storage: blkid.tab devs: []
>18:11:59,946 DBG storage: parsing /mnt/sysimage/etc/crypttab
>18:11:59,947 DBG storage: crypttab maps: []
>18:11:59,948 DBG storage: parsing /mnt/sysimage/etc/fstab
>18:12:16,535 INF threading: Thread Done: AnaStorageThread (140257202919168)
>18:12:16,549 DBG payload: Updating payload thread state: 2
>18:12:16,616 DBG ui.gui.hubs: incomplete spokes: [StorageSpoke]
>18:12:16,688 INF lifecycle: Module initialized: StorageSpoke
>18:12:16,713 INF threading: Thread Done: AnaStorageWatcher (140256636565248)
>18:12:16,770 DBG payload: Updating payload thread state: 6
>18:12:16,772 INF ui.gui.spokes.software_selection: using environment from kickstart: None
>18:12:16,784 INF threading: Thread Done: AnaPayloadThread (140256854669056)
>18:12:16,867 INF threading: Running Thread: AnaCustomStorageInit (140256854669056)
>18:12:17,413 INF lifecycle: Module initialized: BlivetGuiSpoke
>18:12:17,531 INF lifecycle: Module initialized: FilterSpoke
>18:12:17,064 INF flags: Not doing 'register anaconda secret agent' in live installation
>18:12:17,089 DBG ui.gui.spokes.network: can't get remote connection of active connection of device eth0
>18:12:17,093 DBG ui.gui.spokes.network: device configuration added: connection 77497294-b25b-374c-b9d1-f2a597c8bc27 device eth0
>18:12:17,102 DBG ui.gui.spokes.network: not adding connection 77497294-b25b-374c-b9d1-f2a597c8bc27, already in list
>18:12:17,113 INF flags: Not doing 'hide hint to use network configuration in DE' in live installation
>18:12:17,419 INF threading: Thread Done: AnaTimeInitThread (140256940214016)
>18:12:17,519 DBG network: updating host name localhost.localdomain
>18:12:17,724 INF lifecycle: Module initialized: NetworkSpoke
>18:12:17,889 INF flags: Not doing 'require network connection' in live installation
>18:12:17,891 DBG payload: Source doesn't require network for installation
>18:12:17,892 INF lifecycle: Initialization of all modules (7) has been started.
>18:12:17,906 DBG ui.gui.hubs: Starting event loop for hub SummaryHub
>18:12:18,411 DBG ui.common: Entered hub: SummaryHub
>18:12:18,432 DBG ui.gui.hubs: spoke is not ready: KeyboardSpoke
>18:12:18,433 DBG ui.gui.hubs: setting KeyboardSpoke status to: Getting list of layouts...
>18:12:18,434 INF lifecycle: Module initialized: CustomPartitioningSpoke
>18:12:18,436 INF threading: Thread Done: AnaCustomStorageInit (140256854669056)
>18:12:18,435 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>18:12:18,437 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>18:12:18,448 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>18:12:18,474 DBG localization: setting locale to: en_US.UTF-8
>18:12:18,493 DBG localization: setting locale to: en_GB.UTF-8
>18:12:19,401 INF flags: Not doing 'save system time' in live installation
>18:12:19,403 INF flags: Not doing 'save system time' in live installation
>18:12:19,405 INF flags: Not doing 'save system time' in live installation
>00:12:19,500 INF flags: Not doing 'save system time' in live installation
>23:12:19,502 INF lifecycle: Module initialized: DatetimeSpoke
>23:12:19,503 INF threading: Thread Done: AnaDateTimeThread (140256628172544)
>23:12:19,515 DBG ui.gui.hubs: spoke is ready: DatetimeSpoke
>23:12:23,504 DBG ui.common: Entered spoke: StorageSpoke
>23:12:27,890 DBG ui.gui.utils: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f9014287f60>> on <list object at 0x7f9014298448>
>23:12:27,891 INF threading: Thread Done: AnaAddLayoutsInitThread (140256846276352)
>23:12:27,891 INF lifecycle: Module initialized: KeyboardSpoke
>23:12:27,892 INF lifecycle: All modules have been initialized.
>23:12:27,892 INF threading: Thread Done: AnaKeyboardThread (140256931559168)
>23:12:27,909 DBG ui.gui.hubs: spoke is ready: KeyboardSpoke
>23:12:58,535 INF autopart: Detected 4.09 GiB of memory
>23:12:58,538 INF autopart: Swap attempt of 4.09 GiB
>23:12:58,540 DBG ui.gui.spokes.storage: disk free: 1.97 MiB  fs free: 834 MiB  sw needs: 4.88 GiB  auto swap: 4.09 GiB
>23:13:23,352 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x561c66d079d0' has no handler with id '15859'
>  return func(*args, **kwargs)
>
>23:13:23,353 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x561c66d079d0' has no handler with id '15860'
>  return func(*args, **kwargs)
>
>23:14:29,392 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x561c667da560' has no handler with id '16369'
>  return func(*args, **kwargs)
>
>23:14:29,393 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x561c667da560' has no handler with id '16370'
>  return func(*args, **kwargs)
>
>23:14:29,414 INF autopart: Detected 4.28 GiB of memory
>23:14:29,415 INF autopart: Swap attempt of 4.28 GiB
>23:14:29,495 INF threading: Running Thread: AnaExecuteStorageThread (140256931559168)
>23:14:29,495 DBG ui.common: Left spoke: StorageSpoke
>23:14:29,701 DBG storage: clearpart: initializing sda
>23:14:29,943 DBG bootloader: new disk order: []
>23:14:29,983 DBG kickstart.kickstart.bootloader: Bootloader: /boot partition is not present, dry run True
>23:14:29,984 DBG kickstart.kickstart.bootloader: Bootloader: fallback use first disk return from Blivet 'sda' as boot drive, dry run True
>23:14:30,024 INF autopart: Detected 4.28 GiB of memory
>23:14:30,026 INF autopart: Swap attempt of 4.28 GiB
>23:14:30,026 DBG autopart: do_autopart: True
>23:14:30,027 DBG autopart: encrypted_autopart: False
>23:14:30,028 DBG autopart: autopart_type: 2
>23:14:30,028 DBG autopart: clear_part_type: 0
>23:14:30,029 DBG autopart: clear_part_disks: ['sda']
>23:14:30,029 DBG autopart: autopart_requests:
>PartSpec instance (0x7f901d9a9d30) -- 
>  mountpoint = /  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024 MiB  max_size = 50 GiB  grow = True
>PartSpec instance (0x7f901d9a9dd8) -- 
>  mountpoint = /home  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500 MiB  max_size = None  grow = True
>PartSpec instance (0x7f901d9a9c18) -- 
>  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 (0x7f901d9a9b38) -- 
>  mountpoint = /boot  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = ext4  encrypted = False
>  size = 1024 MiB  max_size = None  grow = False
>PartSpec instance (0x7f901d9a9f98) -- 
>  mountpoint = None  lv = True  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 4.28 GiB  max_size = None  grow = False
>
>23:14:30,030 DBG autopart: storage.disks: ['sda']
>23:14:30,031 DBG autopart: storage.partitioned: ['sda']
>23:14:30,085 DBG autopart: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/initramfs/live/LiveOS/squashfs.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sr0']
>23:14:30,217 DBG autopart: boot disk: sda
>23:14:30,411 DBG autopart: candidate disks: [DiskDevice instance (0x7f901c02d518) --
>  name = sda  status = True  id = 2
>  children = []
>  parents = []
>  uuid = None  size = 127 GiB
>  format = non-existent gpt disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /sys/devices/LNXSYSTM:00/LNXSYBUS:00/ACPI0004:00/VMBUS:00/a2544b1a-50c4-453a-abc3-5f162bd26ecf/host0/target0:0:0/0:0:0:0/block/sda
>  target size = 127 GiB  path = /dev/sda
>  format args = []  original_format = disklabel  removable = False  wwn = 0x60022480d96195ca]
>23:14:30,425 DBG autopart: devs: [PartitionDevice instance (0x7f902cb8b940) --
>  name = req0  status = False  id = 271
>  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
>]
>23:14:30,455 DBG bootloader: stage1 device cannot be of type disk
>23:14:30,732 INF flags: Not doing 'require network connection' in live installation
>23:14:30,735 DBG payload: Source doesn't require network for installation
>23:14:30,762 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>23:14:30,763 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>23:14:33,152 DBG bootloader: new disk order: []
>23:14:33,153 DBG kickstart.kickstart.bootloader: Bootloader: use /boot partition's disk 'sda' as boot drive, dry run False
>23:14:33,221 DBG bootloader: stage1 device cannot be of type lvmvg
>23:14:33,223 DBG bootloader: stage1 device cannot be of type lvmlv
>23:14:33,224 DBG bootloader: stage1 device cannot be of type lvmlv
>23:14:33,226 DBG bootloader: stage1 device cannot be of type lvmlv
>23:14:33,228 DBG bootloader: stage1 device cannot be of type disk
>23:14:33,230 DBG bootloader: _is_valid_disklabel(sda1) returning True
>23:14:33,232 DBG bootloader: _is_valid_size(sda1) returning True
>23:14:33,233 DBG bootloader: _is_valid_location(sda1) returning True
>23:14:33,233 WRN bootloader: sda1 not bootable
>23:14:33,237 DBG bootloader: _is_valid_format(sda1) returning True
>23:14:33,240 DBG bootloader: is_valid_stage1_device(sda1) returning True
>23:14:33,250 DBG bootloader: _is_valid_disklabel(sda1) returning True
>23:14:33,252 DBG bootloader: _is_valid_size(sda1) returning True
>23:14:33,253 DBG bootloader: _is_valid_location(sda1) returning True
>23:14:33,253 WRN bootloader: sda1 not bootable
>23:14:33,254 DBG bootloader: _is_valid_format(sda1) returning True
>23:14:33,254 DBG bootloader: is_valid_stage1_device(sda1) returning True
>23:14:33,255 DBG bootloader: _is_valid_disklabel(sda2) returning True
>23:14:33,257 DBG bootloader: _is_valid_size(sda2) returning True
>23:14:33,257 DBG bootloader: _is_valid_partition(sda2) returning True
>23:14:33,259 DBG bootloader: _is_valid_format(sda2) returning True
>23:14:33,259 DBG bootloader: is_valid_stage2_device(sda2) returning True
>23:14:33,383 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', '/tmp', '/var', '/home', '/usr/lib', '/usr'}, 'must_be_on_root': {'/bin', '/proc', 'lost+found', '/lib', '/mnt', '/etc', '/root', '/dev', '/sbin'}, 'swap_is_recommended': True}.
>23:14:33,384 DBG kickstart.kickstart.autopart: Run sanity check verify_root.
>23:14:33,385 DBG kickstart.kickstart.autopart: Run sanity check verify_s390_constraints.
>23:14:33,386 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_sizes.
>23:14:33,393 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_format_sizes.
>23:14:33,395 DBG kickstart.kickstart.autopart: Run sanity check verify_bootloader.
>23:14:33,396 DBG kickstart.kickstart.autopart: Run sanity check verify_gpt_biosboot.
>23:14:33,397 DBG kickstart.kickstart.autopart: Run sanity check verify_swap.
>23:14:33,397 DBG kickstart.kickstart.autopart: Run sanity check verify_swap_uuid.
>23:14:33,398 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_linuxfs.
>23:14:33,398 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_root.
>23:14:33,399 DBG kickstart.kickstart.autopart: Run sanity check verify_luks_devices_have_key.
>23:14:33,399 DBG kickstart.kickstart.autopart: Run sanity check verify_mounted_partitions.
>23:14:33,400 DBG kickstart.kickstart.autopart: Storage check finished with success.
>23:14:33,401 DBG bootloader: new disk order: []
>23:14:33,525 DBG storage_utils: sda matches ['sda'] for devicetree=existing 127 GiB disk sda (2) with non-existent gpt disklabel
>  non-existent 200 MiB partition sda1 (278) with non-existent efi filesystem mounted at /boot/efi
>  non-existent 1024 MiB partition sda2 (285) with non-existent ext4 filesystem mounted at /boot
>  non-existent 125.8 GiB partition sda3 (271) with non-existent lvmpv
>    non-existent 125.8 GiB lvmvg fedora_localhost-live (291)
>      non-existent 50 GiB lvmlv fedora_localhost-live-root (297) with non-existent ext4 filesystem mounted at /
>      non-existent 71.52 GiB lvmlv fedora_localhost-live-home (306) with non-existent ext4 filesystem mounted at /home
>      non-existent 4.28 GiB lvmlv fedora_localhost-live-swap (315) with non-existent swap
>existing 1.79 GiB cdrom sr0 (83) with existing iso9660 filesystem
>existing 0 B file /run/initramfs/live/LiveOS/squashfs.img (93)
>  existing 0 B loop loop0 (97)
>existing 0 B file /LiveOS/rootfs.img (107)
>  existing 0 B loop loop1 (111) with existing ext4 filesystem
>    existing 6.06 GiB dm live-rw (135) with existing ext4 filesystem
>    existing 6.06 GiB dm live-base (145) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (121)
>  existing 0 B loop loop2 (125)
> and disks_only=True
>23:14:33,562 DBG bootloader: stage1 device cannot be of type lvmvg
>23:14:33,563 DBG bootloader: stage1 device cannot be of type lvmlv
>23:14:33,566 DBG bootloader: stage1 device cannot be of type lvmlv
>23:14:33,568 DBG bootloader: stage1 device cannot be of type lvmlv
>23:14:33,569 DBG bootloader: stage1 device cannot be of type disk
>23:14:33,572 DBG bootloader: _is_valid_disklabel(sda1) returning True
>23:14:33,573 DBG bootloader: _is_valid_size(sda1) returning True
>23:14:33,574 DBG bootloader: _is_valid_location(sda1) returning True
>23:14:33,574 WRN bootloader: sda1 not bootable
>23:14:33,575 DBG bootloader: _is_valid_format(sda1) returning True
>23:14:33,575 DBG bootloader: is_valid_stage1_device(sda1) returning True
>23:14:33,576 INF threading: Running Thread: AnaCheckStorageThread (140256846276352)
>23:14:33,594 INF threading: Thread Done: AnaExecuteStorageThread (140256931559168)
>23:14:33,608 DBG bootloader: _is_valid_disklabel(sda1) returning True
>23:14:33,609 DBG bootloader: _is_valid_size(sda1) returning True
>23:14:33,610 DBG bootloader: _is_valid_location(sda1) returning True
>23:14:33,610 WRN bootloader: sda1 not bootable
>23:14:33,611 DBG bootloader: _is_valid_format(sda1) returning True
>23:14:33,615 DBG bootloader: is_valid_stage1_device(sda1) returning True
>23:14:33,616 DBG bootloader: _is_valid_disklabel(sda2) returning True
>23:14:33,617 DBG bootloader: _is_valid_size(sda2) returning True
>23:14:33,617 DBG bootloader: _is_valid_partition(sda2) returning True
>23:14:33,618 DBG bootloader: _is_valid_format(sda2) returning True
>23:14:33,619 DBG bootloader: is_valid_stage2_device(sda2) returning True
>23:14:33,687 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>23:14:33,705 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>23:14:33,706 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>23:14:33,760 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', '/tmp', '/var', '/home', '/usr/lib', '/usr'}, 'must_be_on_root': {'/bin', '/proc', 'lost+found', '/lib', '/mnt', '/etc', '/root', '/dev', '/sbin'}, 'swap_is_recommended': True}.
>23:14:33,771 DBG ui.helpers: Run sanity check verify_root.
>23:14:33,773 DBG ui.helpers: Run sanity check verify_s390_constraints.
>23:14:33,773 DBG ui.helpers: Run sanity check verify_partition_sizes.
>23:14:33,775 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>23:14:33,786 DBG ui.helpers: Run sanity check verify_bootloader.
>23:14:33,787 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>23:14:33,787 DBG ui.helpers: Run sanity check verify_swap.
>23:14:33,789 DBG ui.helpers: Run sanity check verify_swap_uuid.
>23:14:33,789 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>23:14:33,790 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>23:14:33,790 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>23:14:33,791 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>23:14:33,791 DBG ui.helpers: Storage check finished with success.
>23:14:33,776 DBG ui.gui.hubs: incomplete spokes: []
>23:14:33,791 INF threading: Thread Done: AnaCheckStorageThread (140256846276352)
>23:14:41,614 INF ui.lib.space: fs space: 42.5 GiB  needed: 4.88 GiB
>23:14:41,617 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>23:14:41,645 DBG ui.common: Entered spoke: NetworkSpoke
>23:15:00,460 INF network: setting installation environment host name to spc-fedora-desktop.chipperfields.lan
>23:15:03,370 DBG network: updating host name spc-fedora-desktop.chipperfields.lan
>23:15:03,531 DBG ui.gui.spokes.network: apply ksdata # Network information
>network  --bootproto=dhcp --device=eth0 --ipv6=auto --activate
>network  --hostname=spc-fedora-desktop.chipperfields.lan
>
>23:15:03,533 DBG ui.common: Left spoke: NetworkSpoke
>23:15:03,788 INF flags: Not doing 'require network connection' in live installation
>23:15:03,789 DBG payload: Source doesn't require network for installation
>23:15:11,071 INF ui.lib.space: fs space: 42.5 GiB  needed: 4.88 GiB
>23:15:18,984 DBG ui.common: Left hub: SummaryHub
>23:15:18,998 INF lifecycle: Adding controller: ProgressHub
>23:15:19,023 INF lifecycle: Module initialized: PasswordSpoke
>23:15:19,051 DBG ui.gui.hubs: incomplete spokes: [PasswordSpoke]
>23:15:19,090 INF lifecycle: Module initialized: UserSpoke
>23:15:19,103 DBG ui.gui.hubs: incomplete spokes: [PasswordSpoke, UserSpoke]
>23:15:19,110 INF lifecycle: Initialization of all modules (2) has been started.
>23:15:19,114 INF lifecycle: All modules have been initialized.
>23:15:19,118 DBG ui.gui.hubs: Disabling event loop for hub SummaryHub
>23:15:19,119 DBG ui.gui.hubs: Starting event loop for hub ProgressHub
>23:15:19,120 INF threading: Running Thread: AnaInstallThread (140256846276352)
>23:15:19,129 INF flags: Not doing 'save system time to HW clock' in live installation
>23:15:19,126 DBG ui.common: Entered hub: ProgressHub
>23:15:19,136 INF flags: Not doing 'copy /etc/resolv.conf to sysroot' in live installation
>23:15:19,153 INF installation: Top-level task queue: Installation queue
>Number of task queues: 9
>Number of tasks: 16
>Task & task group listing:
> 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: 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
>23:15:19,155 INF progress: Setting up the installation environment
>23:15:19,155 INF installation: Queue started: Installation environment setup (1/9)
>23:15:19,156 INF installation: Task started: Setup addons (1/16)
>23:15:19,157 INF progress: Setup addons
>23:15:19,161 DBG installation: Task completed: Setup addons (1/16) (0.0 s)
>23:15:19,163 INF progress: Configuring storage
>23:15:19,169 INF installation: Queue started: Early storage configuration (2/9)
>23:15:19,170 INF installation: Task started: Insert custom storage to ksdata (2/16)
>23:15:19,220 INF storage: omitting ksdata: existing 127 GiB disk sda (2) with non-existent gpt disklabel
>23:15:19,279 INF progress: Insert custom storage to ksdata
>23:15:19,288 DBG installation: Task completed: Insert custom storage to ksdata (2/16) (0.1 s)
>23:15:19,290 INF installation: Task started: Run pre-storage tasks (3/16)
>23:15:19,290 INF progress: Run pre-storage tasks
>23:15:19,291 DBG installation: Task completed: Run pre-storage tasks (3/16) (0.0 s)
>23:15:19,294 INF installation: Task started: Activate filesystems (4/16)
>23:15:19,306 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>23:15:23,117 DBG ui.common: Entered spoke: PasswordSpoke
>23:15:47,246 DBG ui.common: Left spoke: PasswordSpoke
>23:15:47,315 DBG ui.gui.hubs: incomplete spokes: [UserSpoke]
>23:15:47,334 DBG ui.gui.hubs: incomplete spokes: []
>23:15:47,371 DBG ui.gui.hubs: spoke is ready: PasswordSpoke
>23:15:48,577 DBG ui.common: Entered spoke: UserSpoke
>23:16:02,925 DBG ui.common: Left spoke: UserSpoke
>23:16:24,367 DBG exception: running handleException
>23:16:24,374 CRT exception: Traceback (most recent call last):
>
>  File "/usr/lib64/python3.6/site-packages/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 "/usr/lib64/python3.6/site-packages/pyanaconda/installation.py", line 361, in doInstall
>    installation_queue.start()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation_tasks.py", line 304, in start
>    item.start()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation_tasks.py", line 304, in start
>    item.start()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation_tasks.py", line 472, in start
>    self.run_task()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/installation_tasks.py", line 438, in run_task
>    self._task(*self._task_args, **self._task_kwargs)
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/storage/osinstall.py", line 2131, in turn_on_filesystems
>    storage.do_it(callbacks)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/storage/osinstall.py", line 1219, in do_it
>    super().do_it(callbacks=callbacks)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/blivet.py", line 135, in do_it
>    self.devicetree.actions.process(callbacks=callbacks, devices=self.devices)
>
>  File "/usr/lib/python3.6/site-packages/blivet/actionlist.py", line 48, in wrapped_func
>    return func(obj, *args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/actionlist.py", line 327, in process
>    action.execute(callbacks)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/deviceaction.py", line 383, in execute
>    self.device.destroy()
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/devices/storage.py", line 493, in destroy
>    self._destroy()
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/devices/partition.py", line 767, in _destroy
>    self.disk.original_format.commit()
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/formats/disklabel.py", line 343, in commit
>    self.parted_disk.commit()
>
>  File "/usr/lib64/python3.6/site-packages/parted/decorators.py", line 42, in new
>    ret = fn(*args, **kwds)
>
>  File "/usr/lib64/python3.6/site-packages/parted/disk.py", line 212, in commit
>    return self.__disk.commit()
>
>_ped.IOException: Partition(s) 3 on /dev/sda have been written, but we have been unable to inform the kernel of the change, probably because it/they are in use.  As a result, the old partition(s) will remain in use.  You should reboot now before making further changes.
>
>23:16:24,380 DBG exception: Gtk running, queuing exception handler to the main loop
>23:16:24,415 INF threading: Thread Done: AnaInstallThread (140256846276352)
>23:16:41,563 INF core.util: Running kickstart %%onerror script(s)
>23:16:41,566 INF core.util: All kickstart %%onerror script(s) have been run
>23:16:41,567 INF kickstart.script: Running kickstart %%traceback script(s)
>23:16:41,571 INF kickstart.script: All kickstart %%traceback script(s) have been run

Actions: View

Attachments on bug 1591505: 1451634 | 1451635 | 1451636 | 1451637 | 1451638 | 1451639 | 1451640 | 1451641 | 1451642 | 1451643 | 1451644 | 1451645