Attachment 1461480 Details for Bug 1603815 – File: anaconda.log

File: anaconda.log

anaconda.log (text/plain), 35.52 KB, created by Benjamin Hiebert on 2018-07-19 19:01:25 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Benjamin Hiebert

Created: 2018-07-19 19:01:25 UTC

Size: 35.52 KB

patch

obsolete

>14:40:53,086 INF main: /sbin/anaconda 28.22.10-1.fc28
>14:40:53,965 INF isys: 16566976 kB (16178 MB) are available
>14:40:54,277 INF startup_utils: check_memory(): total:16178, needed:320, graphical:410
>14:40:54,285 INF flags: Not doing 'early exception handler' in live installation
>14:40:54,285 INF flags: Not doing 'start audit daemon' in live installation
>14:40:54,285 INF main: anaconda called with cmdline = ['/sbin/anaconda', '--liveinst', '--method=livecd:///dev/mapper/live-base']
>14:40:54,286 INF main: Default encoding = utf-8 
>14:40:54,294 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-hODmIlA3Lq,guid=c4e848fd5d593e2fa92023355b50db36.
>14:40:54,675 INF startup_utils: Waiting 60 sec for modules to be started.
>14:40:55,716 INF startup_utils: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>14:40:56,072 WRN kickstart: Command firstboot will be parsed in DBus module.
>14:40:56,087 DBG localization: setting locale to: en_US.UTF-8
>14:40:56,102 DBG network: devices found ['eno1', 'wlp24s0']
>14:40:56,109 DBG network: ensure single initramfs connections
>14:40:56,193 DBG network: apply kickstart
>14:40:56,193 DBG network: create missing ifcfg files
>14:40:56,256 DBG network: ifcfg file for eno1 not found
>14:40:56,412 DBG network: dumping ifcfg file for eno1 from default autoconnection d3133c88-49a4-3f84-bbc0-b9a4d0055afa
>14:40:56,422 DBG network: missing ifcfgs created for devices ['eno1']
>14:40:56,430 DBG network: set real ONBOOT value
>14:40:56,433 INF threading: Running Thread: AnaWaitForConnectingNMThread (140153740982016)
>14:40:56,435 INF screen_access: parsing existing user interaction config file in /etc/sysconfig/anaconda
>14:40:56,435 DBG anaconda: setting display mode to GUI
>14:40:56,443 INF anaconda: Display mode is set to 'interactive graphical mode'.
>14:40:56,444 INF isys: 16566976 kB (16178 MB) are available
>14:40:56,452 INF startup_utils: check_memory(): total:16178, needed:320, graphical:410
>14:40:56,462 INF network: got 0 NTP servers from DHCP
>14:40:56,465 INF threading: Thread Done: AnaWaitForConnectingNMThread (140153740982016)
>14:40:57,319 DBG installclass: Searching /usr/lib64/python3.6/site-packages/pyanaconda/installclasses.
>14:40:57,328 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>14:40:57,328 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>14:40:57,329 DBG installclass: Found Fedora (DefaultInstallClass).
>14:40:57,329 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>14:40:57,329 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>14:40:57,329 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>14:40:57,329 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>14:40:57,329 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>14:40:57,329 INF installclass: Using a visible install class Fedora Workstation (FedoraWorkstationInstallClass).
>14:40:57,424 INF bootloader: bootloader EFIGRUB on EFI platform
>14:40:57,426 INF autopart: Detected 15.8 GiB of memory
>14:40:57,426 INF autopart: Suggested swap size (7.9 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>14:40:57,426 INF autopart: Swap attempt of 0.0
>14:40:57,427 INF bootloader: bootloader EFIGRUB on EFI platform
>14:40:57,475 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>14:40:57,476 INF threading: Running Thread: AnaStorageThread (140153740982016)
>14:40:57,479 INF threading: Running Thread: AnaTimeInitThread (140153453999872)
>14:40:57,485 DBG payload: Restarting payload thread
>14:40:57,486 INF threading: Running Thread: AnaPayloadRestartThread (140153372800768)
>14:40:57,486 INF geoloc: Geolocation is enabled.
>14:40:57,487 INF threading: Running Thread: AnaPayloadThread (140153364408064)
>14:40:57,487 DBG payload: Updating payload thread state: 0
>14:40:57,487 DBG payload: Updating payload thread state: 1
>14:40:57,487 INF threading: Thread Done: AnaPayloadRestartThread (140153372800768)
>14:40:57,487 INF threading: Running Thread: AnaGeolocationRefreshThread (140153356015360)14:40:57,488 INF flags: Not doing 'start chronyd' in live installation
>
>14:40:57,488 INF geoloc: Starting geolocation lookup
>14:40:57,488 INF geoloc: Geolocation provider: Fedora GeoIP
>14:40:58,879 DBG ui.gui: Window scale set to 1 by XSETTINGS, not scaling
>14:40:59,091 INF geoloc: Geolocation lookup finished in 1.6 seconds
>14:40:59,091 INF geoloc: got results from geolocation
>14:40:59,092 INF threading: Thread Done: AnaGeolocationRefreshThread (140153356015360)
>14:40:59,230 DBG localization: setting locale to: en_CA.UTF-8
>14:40:59,459 DBG localization: setting locale to: en_US.UTF-8
>14:40:59,468 DBG localization: setting locale to: en_CA.UTF-8
>14:40:59,640 DBG ui.common: Entered spoke: WelcomeLanguageSpoke
>14:40:59,775 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/Gdk.py:336: DeprecationWarning: Gdk.Cursor.new is deprecated
>  return cls.new(*args, **kwds)
>
>14:41:01,357 DBG storage: protected device spec /dev/disk/by-label/Fedora-WS-Live-28-1-1 resolved to sr0
>14:41:01,359 INF storage: resolved live device to sr0
>14:41:01,359 INF storage: marking live device sr0 protected
>14:41:01,654 INF threading: Thread Done: AnaStorageThread (140153740982016)
>14:41:01,654 DBG payload: Updating payload thread state: 2
>14:41:01,703 DBG payload: Updating payload thread state: 6
>14:41:01,703 INF threading: Thread Done: AnaPayloadThread (140153364408064)
>08:41:01,001 INF threading: Thread Done: AnaTimeInitThread (140153453999872)
>08:41:03,636 DBG localization: setting locale to: en_CA.UTF-8
>08:41:03,640 INF ui.gui.spokes.welcome: using timezone determined by geolocation
>08:41:03,672 INF flags: Not doing 'require network connection' in live installation
>08:41:03,673 DBG ui.gui.spokes.network: network standalone spoke (init): completed: True
>08:41:03,674 INF flags: Not doing 'require network connection' in live installation
>08:41:03,678 DBG ui.common: Left spoke: WelcomeLanguageSpoke
>08:41:03,685 INF ui.common: Spoke NetworkSpoke will not be displayed because it has already been visited before.
>08:41:03,686 INF lifecycle: Adding controller: SummaryHub
>08:41:03,695 INF flags: Not doing 'activate layouts' in live installation
>08:41:04,148 INF threading: Running Thread: AnaAddLayoutsInitThread (140153453999872)
>08:41:04,149 DBG ui.gui.utils: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f77fc112f60>> on <list object at 0x7f77fc17af88>
>08:41:04,149 INF threading: Running Thread: AnaGtkBatchPre1 (140153364408064)
>08:41:04,151 INF threading: Thread Done: AnaGtkBatchPre1 (140153364408064)
>08:41:04,183 INF threading: Running Thread: AnaKeyboardThread (140153364408064)
>08:41:04,428 INF flags: Not doing 'modify system time and date' in live installation
>08:41:04,436 INF threading: Running Thread: AnaNTPserver1 (140153740982016)
>08:41:04,437 INF threading: Running Thread: AnaDateTimeThread (140153372800768)
>08:41:04,644 INF ui.gui.spokes.software_selection: using environment from kickstart: None
>08:41:04,670 INF threading: Running Thread: AnaStorageWatcher (140153079023360)
>08:41:04,671 INF lifecycle: Module initialized: StorageSpoke
>08:41:04,671 INF threading: Thread Done: AnaStorageWatcher (140153079023360)
>08:41:04,675 DBG ui.gui.hubs: incomplete spokes: [StorageSpoke]
>08:41:04,685 INF threading: Thread Done: AnaNTPserver1 (140153740982016)
>08:41:04,698 INF threading: Running Thread: AnaCustomStorageInit (140153740982016)
>08:41:04,738 INF lifecycle: Module initialized: BlivetGuiSpoke
>08:41:04,763 INF lifecycle: Module initialized: FilterSpoke
>08:41:04,764 INF lifecycle: Initialization of all modules (6) has been started.
>08:41:04,765 DBG ui.gui.hubs: Starting event loop for hub SummaryHub
>08:41:05,091 DBG ui.common: Entered hub: SummaryHub
>08:41:05,097 DBG ui.gui.hubs: spoke is not ready: KeyboardSpoke
>08:41:05,098 DBG ui.gui.hubs: setting KeyboardSpoke status to: Getting list of layouts...
>08:41:05,098 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>08:41:05,098 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>08:41:05,330 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>08:41:05,531 INF lifecycle: Module initialized: CustomPartitioningSpoke
>08:41:05,531 INF threading: Thread Done: AnaCustomStorageInit (140153740982016)
>08:41:05,662 INF flags: Not doing 'save system time' in live installation
>08:41:05,662 INF flags: Not doing 'save system time' in live installation
>08:41:05,663 INF flags: Not doing 'save system time' in live installation
>06:41:05,664 INF lifecycle: Module initialized: DatetimeSpoke
>06:41:05,665 INF threading: Thread Done: AnaDateTimeThread (140153372800768)
>06:41:05,671 DBG ui.gui.hubs: spoke is ready: DatetimeSpoke
>06:41:06,946 DBG ui.gui.utils: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f77fc112f60>> on <list object at 0x7f77fc17af88>
>06:41:06,947 INF threading: Thread Done: AnaAddLayoutsInitThread (140153453999872)
>06:41:06,947 INF lifecycle: Module initialized: KeyboardSpoke
>06:41:06,948 INF lifecycle: All modules have been initialized.
>06:41:06,948 INF threading: Thread Done: AnaKeyboardThread (140153364408064)
>06:41:06,954 DBG ui.gui.hubs: spoke is ready: KeyboardSpoke
>06:41:07,982 DBG ui.common: Entered spoke: StorageSpoke
>06:41:15,891 DBG ui.common: Left spoke: StorageSpoke
>06:41:15,913 DBG ui.common: Entered spoke: FilterSpoke
>06:42:42,090 INF threading: Running Thread: AnaFCOEThread (140153364408064)
>06:43:44,549 INF threading: Thread Done: AnaFCOEThread (140153364408064)
>06:44:01,351 INF threading: Running Thread: AnaFCOEThread (140153364408064)
>06:44:13,240 INF threading: Thread Done: AnaFCOEThread (140153364408064)
>06:44:13,692 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x55cc1e07bbe0' has no handler with id '19124'
>  return func(*args, **kwargs)
>
>06:44:13,693 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x55cc1e07bbe0' has no handler with id '19125'
>  return func(*args, **kwargs)
>
>06:45:21,549 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x55cc1e1436e0' has no handler with id '30074'
>  return func(*args, **kwargs)
>
>06:45:21,550 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x55cc1e1436e0' has no handler with id '30075'
>  return func(*args, **kwargs)
>
>06:45:38,954 DBG ui.common: Left spoke: FilterSpoke
>06:45:38,978 DBG ui.common: Entered spoke: StorageSpoke
>06:46:10,897 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x55cc1e08df60' has no handler with id '39804'
>  return func(*args, **kwargs)
>
>06:46:10,898 WRN misc: /usr/lib64/python3.6/site-packages/gi/overrides/GObject.py:553: Warning: gsignal.c:2641: instance '0x55cc1e08df60' has no handler with id '39805'
>  return func(*args, **kwargs)
>
>06:46:23,299 INF autopart: Detected 15.8 GiB of memory
>06:46:23,300 INF autopart: Swap attempt of 7.9 GiB
>06:46:23,300 DBG ui.gui.spokes.storage: disk free: 2.27 TiB  fs free: 0 B  sw needs: 4.67 GiB  auto swap: 7.9 GiB
>06:46:23,301 INF autopart: Detected 15.8 GiB of memory
>06:46:23,302 INF autopart: Swap attempt of 7.9 GiB
>06:46:23,321 INF threading: Running Thread: AnaExecuteStorageThread (140153364408064)
>06:46:23,322 DBG ui.common: Left spoke: StorageSpoke
>06:46:23,344 DBG storage: clearpart: initializing sda
>06:46:23,360 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>06:46:23,361 DBG ui.gui.hubs: setting StorageSpoke status to: Saving storage configuration...
>06:46:23,380 DBG storage: clearpart: initializing sdb
>06:46:23,410 DBG bootloader: new disk order: []
>06:46:23,460 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1.67 GiB cdrom sr0 (2) with existing iso9660 filesystem
>existing 1.82 TiB disk sda (12) with non-existent gpt disklabel
>existing 465.76 GiB disk sdb (22) with non-existent gpt disklabel
>existing 1024 MiB cdrom sr1 (32)
>existing 0 B file /run/initramfs/live/LiveOS/squashfs.img (37)
>  existing 0 B loop loop0 (41)
>existing 0 B file /LiveOS/rootfs.img (51)
>  existing 0 B loop loop1 (55) with existing ext4 filesystem
>    existing 6.5 GiB dm live-rw (74) with existing ext4 filesystem
>    existing 6.5 GiB dm live-base (84) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (65)
>  existing 0 B loop loop2 (69)
> and disks_only=True
>06:46:23,464 INF autopart: Detected 15.8 GiB of memory
>06:46:23,464 INF autopart: Swap attempt of 7.9 GiB
>06:46:23,464 DBG autopart: do_autopart: True
>06:46:23,465 DBG autopart: encrypted_autopart: False
>06:46:23,465 DBG autopart: autopart_type: 2
>06:46:23,465 DBG autopart: clear_part_type: 0
>06:46:23,465 DBG autopart: clear_part_disks: ['sda', 'sdb']
>06:46:23,465 DBG autopart: autopart_requests:
>PartSpec instance (0x7f7806d10f98) -- 
>  mountpoint = /  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024 MiB  max_size = 50 GiB  grow = True
>PartSpec instance (0x7f7806d19080) -- 
>  mountpoint = /home  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500 MiB  max_size = None  grow = True
>PartSpec instance (0x7f7806d19128) -- 
>  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 (0x7f7806d19198) -- 
>  mountpoint = /boot  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = ext4  encrypted = False
>  size = 1024 MiB  max_size = None  grow = False
>PartSpec instance (0x7f7806d19518) -- 
>  mountpoint = None  lv = True  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 7.9 GiB  max_size = None  grow = False
>
>06:46:23,466 DBG autopart: storage.disks: ['sda', 'sdb']
>06:46:23,466 DBG autopart: storage.partitioned: ['sda', 'sdb']
>06:46:23,466 DBG autopart: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/initramfs/live/LiveOS/squashfs.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sdb', 'sr0', 'sr1']
>06:46:23,469 DBG autopart: boot disk: sda
>06:46:23,484 DBG autopart: candidate disks: [DiskDevice instance (0x7f7804041978) --
>  name = sda  status = True  id = 12
>  children = []
>  parents = []
>  uuid = None  size = 1.82 TiB
>  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/ata2/host1/target1:0:0/1:0:0:0/block/sda
>  target size = 1.82 TiB  path = /dev/sda
>  format args = []  original_format = disklabel  removable = False  wwn = 0x5000c500a2b50aeb, DiskDevice instance (0x7f77fc467550) --
>  name = sdb  status = True  id = 22
>  children = []
>  parents = []
>  uuid = None  size = 465.76 GiB
>  format = non-existent gpt disklabel
>  major = 8  minor = 16  exists = True  protected = False
>  sysfs path = /sys/devices/pci0000:00/0000:00:01.3/0000:03:00.1/ata3/host2/target2:0:0/2:0:0:0/block/sdb
>  target size = 465.76 GiB  path = /dev/sdb
>  format args = []  original_format = disklabel  removable = False  wwn = 0x5000c5003d93b7d6]
>06:46:23,486 DBG autopart: devs: [PartitionDevice instance (0x7f7815e464e0) --
>  name = req0  status = False  id = 205
>  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
>, PartitionDevice instance (0x7f7815e46da0) --
>  name = req1  status = False  id = 212
>  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/req1
>  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
>]
>06:46:23,488 DBG bootloader: stage1 device cannot be of type disk
>06:46:23,830 DBG bootloader: new disk order: []
>06:46:23,866 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1.67 GiB cdrom sr0 (2) with existing iso9660 filesystem
>existing 1.82 TiB disk sda (12) with non-existent gpt disklabel
>  non-existent 200 MiB partition sda1 (219) with non-existent efi filesystem mounted at /boot/efi
>  non-existent 1024 MiB partition sda2 (226) with non-existent ext4 filesystem mounted at /boot
>  non-existent 1.82 TiB partition sda3 (205) with non-existent lvmpv
>    non-existent 2.27 TiB lvmvg fedora_localhost-live (232)
>      non-existent 50 GiB lvmlv fedora_localhost-live-root (238) with non-existent ext4 filesystem mounted at /
>      non-existent 2.22 TiB lvmlv fedora_localhost-live-home (247) with non-existent ext4 filesystem mounted at /home
>      non-existent 7.9 GiB lvmlv fedora_localhost-live-swap (256) with non-existent swap
>existing 465.76 GiB disk sdb (22) with non-existent gpt disklabel
>  non-existent 465.76 GiB partition sdb1 (212) with non-existent lvmpv
>    non-existent 2.27 TiB lvmvg fedora_localhost-live (232)
>      ...
>existing 1024 MiB cdrom sr1 (32)
>existing 0 B file /run/initramfs/live/LiveOS/squashfs.img (37)
>  existing 0 B loop loop0 (41)
>existing 0 B file /LiveOS/rootfs.img (51)
>  existing 0 B loop loop1 (55) with existing ext4 filesystem
>    existing 6.5 GiB dm live-rw (74) with existing ext4 filesystem
>    existing 6.5 GiB dm live-base (84) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (65)
>  existing 0 B loop loop2 (69)
> and disks_only=True
>06:46:23,879 DBG bootloader: stage1 device cannot be of type lvmvg
>06:46:23,880 DBG bootloader: stage1 device cannot be of type lvmlv
>06:46:23,880 DBG bootloader: stage1 device cannot be of type lvmlv
>06:46:23,880 DBG bootloader: stage1 device cannot be of type lvmlv
>06:46:23,881 DBG bootloader: stage1 device cannot be of type disk
>06:46:23,881 DBG bootloader: _is_valid_disklabel(sda1) returning True
>06:46:23,882 DBG bootloader: _is_valid_size(sda1) returning True
>06:46:23,882 DBG bootloader: _is_valid_location(sda1) returning True
>06:46:23,882 WRN bootloader: sda1 not bootable
>06:46:23,882 DBG bootloader: _is_valid_format(sda1) returning True
>06:46:23,883 DBG bootloader: is_valid_stage1_device(sda1) returning True
>06:46:23,886 DBG bootloader: _is_valid_disklabel(sda1) returning True
>06:46:23,886 DBG bootloader: _is_valid_size(sda1) returning True
>06:46:23,887 DBG bootloader: _is_valid_location(sda1) returning True
>06:46:23,887 WRN bootloader: sda1 not bootable
>06:46:23,887 DBG bootloader: _is_valid_format(sda1) returning True
>06:46:23,887 DBG bootloader: is_valid_stage1_device(sda1) returning True
>06:46:23,887 DBG bootloader: _is_valid_disklabel(sda2) returning True
>06:46:23,888 DBG bootloader: _is_valid_size(sda2) returning True
>06:46:23,888 DBG bootloader: _is_valid_partition(sda2) returning True
>06:46:23,888 DBG bootloader: _is_valid_format(sda2) returning True
>06:46:23,888 DBG bootloader: is_valid_stage2_device(sda2) returning True
>06:46:23,908 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': {'/', '/tmp', '/usr/lib', '/home', '/usr/share', '/var', '/usr'}, 'must_be_on_root': {'/sbin', '/dev', '/root', '/proc', '/mnt', '/bin', '/lib', 'lost+found', '/etc'}, 'swap_is_recommended': True}.
>06:46:23,908 DBG kickstart.kickstart.autopart: Run sanity check verify_root.
>06:46:23,908 DBG kickstart.kickstart.autopart: Run sanity check verify_s390_constraints.
>06:46:23,908 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_sizes.
>06:46:23,908 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_format_sizes.
>06:46:23,908 DBG kickstart.kickstart.autopart: Run sanity check verify_bootloader.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_gpt_biosboot.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_swap.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_swap_uuid.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_linuxfs.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_root.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_luks_devices_have_key.
>06:46:23,909 DBG kickstart.kickstart.autopart: Run sanity check verify_mounted_partitions.
>06:46:23,909 DBG kickstart.kickstart.autopart: Storage check finished with success.
>06:46:23,910 DBG bootloader: new disk order: []
>06:46:23,943 DBG storage_utils: sda matches ['sda'] for devicetree=existing 1.67 GiB cdrom sr0 (2) with existing iso9660 filesystem
>existing 1.82 TiB disk sda (12) with non-existent gpt disklabel
>  non-existent 200 MiB partition sda1 (219) with non-existent efi filesystem mounted at /boot/efi
>  non-existent 1024 MiB partition sda2 (226) with non-existent ext4 filesystem mounted at /boot
>  non-existent 1.82 TiB partition sda3 (205) with non-existent lvmpv
>    non-existent 2.27 TiB lvmvg fedora_localhost-live (232)
>      non-existent 50 GiB lvmlv fedora_localhost-live-root (238) with non-existent ext4 filesystem mounted at /
>      non-existent 2.22 TiB lvmlv fedora_localhost-live-home (247) with non-existent ext4 filesystem mounted at /home
>      non-existent 7.9 GiB lvmlv fedora_localhost-live-swap (256) with non-existent swap
>existing 465.76 GiB disk sdb (22) with non-existent gpt disklabel
>  non-existent 465.76 GiB partition sdb1 (212) with non-existent lvmpv
>    non-existent 2.27 TiB lvmvg fedora_localhost-live (232)
>      ...
>existing 1024 MiB cdrom sr1 (32)
>existing 0 B file /run/initramfs/live/LiveOS/squashfs.img (37)
>  existing 0 B loop loop0 (41)
>existing 0 B file /LiveOS/rootfs.img (51)
>  existing 0 B loop loop1 (55) with existing ext4 filesystem
>    existing 6.5 GiB dm live-rw (74) with existing ext4 filesystem
>    existing 6.5 GiB dm live-base (84) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (65)
>  existing 0 B loop loop2 (69)
> and disks_only=True
>06:46:23,956 DBG bootloader: stage1 device cannot be of type lvmvg
>06:46:23,957 DBG bootloader: stage1 device cannot be of type lvmlv
>06:46:23,957 DBG bootloader: stage1 device cannot be of type lvmlv
>06:46:23,957 DBG bootloader: stage1 device cannot be of type lvmlv
>06:46:23,958 DBG bootloader: stage1 device cannot be of type disk
>06:46:23,959 DBG bootloader: _is_valid_disklabel(sda1) returning True
>06:46:23,959 DBG bootloader: _is_valid_size(sda1) returning True
>06:46:23,959 DBG bootloader: _is_valid_location(sda1) returning True
>06:46:23,959 WRN bootloader: sda1 not bootable
>06:46:23,959 DBG bootloader: _is_valid_format(sda1) returning True
>06:46:23,960 DBG bootloader: is_valid_stage1_device(sda1) returning True
>06:46:23,960 INF threading: Running Thread: AnaCheckStorageThread (140153356015360)
>06:46:23,966 INF threading: Thread Done: AnaExecuteStorageThread (140153364408064)
>06:46:23,973 DBG bootloader: _is_valid_disklabel(sda1) returning True
>06:46:23,974 DBG bootloader: _is_valid_size(sda1) returning True
>06:46:23,974 DBG bootloader: _is_valid_location(sda1) returning True
>06:46:23,974 WRN bootloader: sda1 not bootable
>06:46:23,975 DBG bootloader: _is_valid_format(sda1) returning True
>06:46:23,975 DBG bootloader: is_valid_stage1_device(sda1) returning True
>06:46:23,976 DBG bootloader: _is_valid_disklabel(sda2) returning True
>06:46:23,976 DBG bootloader: _is_valid_size(sda2) returning True
>06:46:23,976 DBG bootloader: _is_valid_partition(sda2) returning True
>06:46:23,977 DBG bootloader: _is_valid_format(sda2) returning True
>06:46:23,977 DBG bootloader: is_valid_stage2_device(sda2) returning True
>06:46:23,986 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>06:46:23,993 DBG ui.gui.hubs: spoke is not ready: StorageSpoke
>06:46:23,994 DBG ui.gui.hubs: setting StorageSpoke status to: Checking storage configuration...
>06:46:24,006 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', '/usr/lib', '/home', '/usr/share', '/var', '/usr'}, 'must_be_on_root': {'/sbin', '/dev', '/root', '/proc', '/mnt', '/bin', '/lib', 'lost+found', '/etc'}, 'swap_is_recommended': True}.
>06:46:24,006 DBG ui.helpers: Run sanity check verify_root.
>06:46:24,006 DBG ui.helpers: Run sanity check verify_s390_constraints.
>06:46:24,006 DBG ui.helpers: Run sanity check verify_partition_sizes.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_partition_format_sizes.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_bootloader.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_gpt_biosboot.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_swap.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_swap_uuid.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_mountpoints_on_linuxfs.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_mountpoints_on_root.
>06:46:24,007 DBG ui.helpers: Run sanity check verify_luks_devices_have_key.
>06:46:24,008 DBG ui.helpers: Run sanity check verify_mounted_partitions.
>06:46:24,008 DBG ui.helpers: Storage check finished with success.
>06:46:24,008 INF threading: Thread Done: AnaCheckStorageThread (140153356015360)
>06:46:24,082 DBG ui.gui.hubs: incomplete spokes: []
>06:46:25,543 INF ui.lib.space: fs space: 42.5 GiB  needed: 4.67 GiB
>06:46:25,543 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>06:46:29,819 DBG ui.common: Left hub: SummaryHub
>06:46:29,825 INF ui.common: Spoke PasswordSpoke will not be displayed because it has already been visited before.
>06:46:29,825 INF ui.common: Spoke UserSpoke will not be displayed because it has already been visited before.
>06:46:29,826 INF lifecycle: Adding controller: ProgressHub
>06:46:29,826 INF lifecycle: Initialization of all modules (0) has been started.
>06:46:29,826 INF lifecycle: All modules have been initialized.
>06:46:29,827 DBG ui.gui.hubs: Disabling event loop for hub SummaryHub
>06:46:29,827 DBG ui.gui.hubs: Starting event loop for hub ProgressHub
>06:46:29,827 INF threading: Running Thread: AnaInstallThread (140153356015360)
>06:46:29,828 INF flags: Not doing 'save system time to HW clock' in live installation
>06:46:29,830 INF flags: Not doing 'copy /etc/resolv.conf to sysroot' in live installation
>06:46:29,832 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
>06:46:29,833 INF progress: Setting up the installation environment
>06:46:29,833 INF installation: Queue started: Installation environment setup (1/9)
>06:46:29,833 INF installation: Task started: Setup addons (1/16)
>06:46:29,834 INF progress: Setup addons
>06:46:29,834 DBG installation: Task completed: Setup addons (1/16) (0.0 s)
>06:46:29,834 INF progress: Configuring storage
>06:46:29,834 INF installation: Queue started: Early storage configuration (2/9)
>06:46:29,834 INF installation: Task started: Insert custom storage to ksdata (2/16)
>06:46:29,841 DBG ui.common: Entered hub: ProgressHub
>06:46:29,848 INF storage: omitting ksdata: existing 465.76 GiB disk sdb (22) with non-existent gpt disklabel
>06:46:29,849 INF storage: omitting ksdata: existing 1.82 TiB disk sda (12) with non-existent gpt disklabel
>06:46:29,852 INF progress: Insert custom storage to ksdata
>06:46:29,852 DBG installation: Task completed: Insert custom storage to ksdata (2/16) (0.0 s)
>06:46:29,852 INF installation: Task started: Run pre-storage tasks (3/16)
>06:46:29,852 INF progress: Run pre-storage tasks
>06:46:29,853 DBG installation: Task completed: Run pre-storage tasks (3/16) (0.0 s)
>06:46:29,853 INF installation: Task started: Activate filesystems (4/16)
>06:46:30,707 INF progress: Creating disklabel on /dev/sdb
>06:46:31,657 INF progress: Creating lvmpv on /dev/sdb1
>06:46:31,906 INF progress: Creating disklabel on /dev/sda
>06:46:35,025 INF progress: Creating ext4 on /dev/sda2
>06:46:36,881 INF progress: Creating lvmpv on /dev/sda3
>06:46:37,540 INF progress: Creating swap on /dev/mapper/fedora_localhost--live-swap
>06:46:37,851 INF progress: Creating ext4 on /dev/mapper/fedora_localhost--live-home
>06:46:48,250 INF progress: Creating ext4 on /dev/mapper/fedora_localhost--live-root
>06:46:52,733 INF progress: Creating efi on /dev/sda1
>06:46:53,187 INF storage: setting boot flag on sda1
>06:46:53,188 INF storage: Setting label on existing 200 MiB partition sda1 (219) with existing efi filesystem mounted at /boot/efi to 'EFI System Partition'
>06:46:56,688 INF progress: Activate filesystems
>06:46:56,688 DBG installation: Task completed: Activate filesystems (4/16) (26.8 s)
>06:46:56,688 INF installation: Task started: Write early storage (5/16)
>06:46:56,689 INF progress: Write early storage
>06:46:56,689 DBG installation: Task completed: Write early storage (5/16) (0.0 s)
>06:46:56,689 INF progress: Running pre-installation scripts
>06:46:56,689 INF installation: Queue started: Pre-install scripts (3/9)
>06:46:56,690 INF installation: Task started: Run %pre-install scripts (6/16)
>06:46:56,690 INF progress: Run %pre-install scripts
>06:46:56,690 DBG installation: Task completed: Run %pre-install scripts (6/16) (0.0 s)
>06:46:56,690 INF progress: Discovering realm to join
>06:46:56,690 INF installation: Queue started: Realm discover (4/9)
>06:46:56,691 INF installation: Task started: Discover realm to join (7/16)
>06:46:56,695 INF progress: Discover realm to join
>06:46:56,695 DBG installation: Task completed: Discover realm to join (7/16) (0.0 s)
>06:46:56,695 INF progress: Running pre-installation tasks
>06:46:56,696 INF installation: Queue started: Pre install tasks (5/9)
>06:46:56,696 INF installation: Task started: Setup authselect (8/16)
>06:46:56,699 INF progress: Setup authselect
>06:46:56,700 DBG installation: Task completed: Setup authselect (8/16) (0.0 s)
>06:46:56,700 INF installation: Task started: Setup firewall (9/16)
>06:46:56,700 INF progress: Setup firewall
>06:46:56,700 DBG installation: Task completed: Setup firewall (9/16) (0.0 s)
>06:46:56,700 INF installation: Task started: Setup network (10/16)
>06:46:56,725 INF progress: Setup network
>06:46:56,725 DBG installation: Task completed: Setup network (10/16) (0.0 s)
>06:46:56,725 INF installation: Task started: Setup timezone (11/16)
>06:46:56,761 INF progress: Setup timezone
>06:46:56,761 DBG installation: Task completed: Setup timezone (11/16) (0.0 s)
>06:46:56,761 INF installation: Task started: Find additional packages & run preInstall() (12/16)
>06:46:56,762 DBG payload: added package requirement 'e2fsprogs' for storage, strong=True
>06:46:56,763 DBG payload: added package requirement 'dosfstools' for storage, strong=True
>06:46:56,763 DBG payload: added package requirement 'lvm2' for storage, strong=True
>06:46:56,763 DBG payload: no package requirement added for realm
>06:46:56,763 DBG payload: added package requirement 'authselect' for authselect, strong=True
>06:46:56,763 DBG payload: no package requirement added for firewall
>06:46:56,763 DBG payload: no package requirement added for network
>06:46:56,764 DBG payload: added package requirement 'chrony' for ntp, strong=False
>06:46:56,764 DBG payload: added package requirement 'grub2-efi-x64' for bootloader, strong=True
>06:46:56,764 DBG payload: added package requirement 'shim-x64' for bootloader, strong=True
>06:46:56,764 DBG payload: added package requirement 'efibootmgr' for bootloader, strong=True
>06:46:56,764 DBG payload: added package requirement 'grub2' for bootloader, strong=True
>06:46:56,764 DBG payload: added package requirement 'grub2-tools' for bootloader, strong=True
>06:46:56,765 DBG payload: no group requirement added for language groups
>06:46:56,765 DBG payload: no package requirement added for langpacks
>06:46:56,779 INF progress: Find additional packages & run preInstall()
>06:46:56,780 DBG installation: Task completed: Find additional packages & run preInstall() (12/16) (0.0 s)
>06:46:56,780 INF progress: Installing.
>06:46:56,781 INF installation: Queue started: Payload installation (6/9)
>06:46:56,781 INF installation: Task started: Install the payload (13/16)
>06:46:56,782 INF threading: Running Thread: AnaLiveProgressThread (140153364408064)
>06:54:48,018 INF threading: Thread Done: AnaLiveProgressThread (140153364408064)
>06:55:50,307 INF progress: Install the payload
>06:55:50,307 DBG installation: Task completed: Install the payload (13/16) (533.5 s)
>06:55:50,308 INF progress: Configuring storage
>06:55:50,308 INF installation: Queue started: Late storage configuration (7/9)
>06:55:50,308 INF installation: Task started: Write late storage (14/16)
>06:55:50,313 INF storage: not writing out mpath configuration
>06:55:50,313 DBG exception: running handleException
>06:55:50,318 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/payload/__init__.py", line 949, in writeStorageLate
>    self.storage.write()
>
>  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 1284, in write
>    fcoe.write(sysroot)
>
>  File "/usr/lib/python3.6/site-packages/blivet/fcoe.py", line 187, in write
>    shutil.copytree("/etc/fcoe", root + "/etc/fcoe")
>
>  File "/usr/lib64/python3.6/shutil.py", line 315, in copytree
>    os.makedirs(dst)
>
>  File "/usr/lib64/python3.6/os.py", line 220, in makedirs
>    mkdir(name, mode)
>
>FileExistsError: [Errno 17] File exists: '/mnt/sysimage/etc/fcoe'
>
>06:55:50,318 DBG exception: Gtk running, queuing exception handler to the main loop
>06:55:50,319 INF threading: Thread Done: AnaInstallThread (140153356015360)
>06:55:56,753 INF core.util: Running kickstart %%onerror script(s)
>06:55:56,753 INF core.util: All kickstart %%onerror script(s) have been run
>06:55:56,753 INF kickstart.script: Running kickstart %%traceback script(s)
>06:55:56,754 INF kickstart.script: All kickstart %%traceback script(s) have been run

Actions: View

Attachments on bug 1603815: 1461479 | 1461480 | 1461481 | 1461482 | 1461483 | 1461484 | 1461486 | 1461487 | 1461488 | 1461489 | 1461491 | 1461492 | 1461493