Attachment 1446280 Details for Bug 1584681 – anaconda.log from the installation run

anaconda.log from the installation run

anaconda.log (text/plain), 37.53 KB, created by Martin Kolman on 2018-05-31 12:59:49 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Martin Kolman

Created: 2018-05-31 12:59:49 UTC

Size: 37.53 KB

patch

obsolete

>08:57:08,676 INF main: /sbin/anaconda 29.15-1.fc29
>08:57:08,677 INF main: Using updates in /tmp/updates/ from http://cobra02/ks/mk/kstest_updates.img
>08:57:08,921 INF isys: 2149348 kB (2098 MB) are available
>08:57:08,944 INF startup_utils: check_memory(): total:2098, needed:320, graphical:410
>08:57:08,945 INF startup_utils: Switching logging level to debug
>08:57:08,960 INF main: anaconda called with cmdline = ['/sbin/anaconda']
>08:57:08,962 INF main: Default encoding = utf-8 
>08:57:09,029 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-oXfkFMIQoQ,guid=a4dfabe4fca30b28c606585b5b0e6765.
>08:57:09,668 INF startup_utils: Waiting 600 sec for modules to be started.
>08:57:10,674 INF startup_utils: Waiting 599 sec for modules to be started.
>08:57:11,717 INF startup_utils: Waiting 598 sec for modules to be started.
>08:57:12,722 INF startup_utils: Waiting 597 sec for modules to be started.
>08:57:13,730 INF startup_utils: Waiting 596 sec for modules to be started.
>08:57:14,744 INF startup_utils: Waiting 595 sec for modules to be started.
>08:57:15,750 INF startup_utils: Waiting 594 sec for modules to be started.
>08:57:16,912 INF startup_utils: Parsing kickstart: /run/install/ks.cfg
>08:57:17,023 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'
>08:57:18,971 WRN misc: /tmp/updates/pykickstart/base.py:215: DeprecationWarning: Ignoring deprecated command on line 3:  The install command has been deprecated and no longer has any effect.  It may be removed from future releases, which will result in a fatal error from kickstart.  Please modify your kickstart file to remove this command.
>  warnings.warn(_("Ignoring deprecated command on line %(lineno)s:  The %(cmd)s command has been deprecated and no longer has any effect.  It may be removed from future releases, which will result in a fatal error from kickstart.  Please modify your kickstart file to remove this command.") % mapping, DeprecationWarning)
>
>08:57:18,973 INF kickstart.kickstart.network: setting "link" for missing --device specification in kickstart
>08:57:18,973 WRN kickstart: Command bootloader will be parsed in DBus module.
>08:57:18,988 INF bootloader: bootloader GRUB2 on X86 platform
>08:57:19,007 WRN kickstart: Command zerombr will be parsed in DBus module.
>08:57:19,009 WRN kickstart: Command clearpart will be parsed in DBus module.
>08:57:19,015 WRN kickstart: Command keyboard will be parsed in DBus module.
>08:57:19,019 WRN kickstart: Command lang will be parsed in DBus module.
>08:57:19,021 WRN kickstart: Command timezone will be parsed in DBus module.
>08:57:19,022 WRN kickstart: Command rootpw will be parsed in DBus module.
>08:57:19,558 DBG localization: setting locale to: en_US.UTF-8
>08:57:19,592 DBG network: devices found ['ens3']
>08:57:19,631 DBG network: ensure single initramfs connections
>08:57:19,787 DBG network: apply kickstart
>08:57:20,170 DBG network: pre kickstart - updating settings of device ens3
>08:57:20,621 DBG network: pre kickstart - activating connection e5141ddf-183e-48ff-bc6b-a9d2a6455441 for ens3
>08:57:20,694 DBG network: kickstart pre section applied for devices ['ens3']
>08:57:21,214 DBG network: create missing ifcfg files
>08:57:21,938 DBG network: set real ONBOOT value
>08:57:22,224 DBG network: setting ONBOOT value of ens3 to True
>08:57:22,965 DBG network: real kickstart ONBOOT value set for devices ['ens3']
>08:57:23,156 INF threading: Running Thread: AnaWaitForConnectingNMThread (139924418750208)
>08:57:23,206 DBG anaconda: setting display mode to TUI
>08:57:23,374 WRN stdout: Not asking for VNC because of an automated install
>08:57:23,394 INF anaconda: Display mode is set to 'interactive text mode'.
>08:57:23,470 INF isys: 2149348 kB (2098 MB) are available
>08:57:23,758 INF startup_utils: check_memory(): total:2098, needed:320, graphical:410
>08:57:23,818 INF network: got 0 NTP servers from DHCP
>08:57:23,901 INF threading: Thread Done: AnaWaitForConnectingNMThread (139924418750208)
>08:57:24,053 DBG installclass: Searching /tmp/updates/pyanaconda/installclasses.
>08:57:24,092 DBG installclass: Found Fedora (DefaultInstallClass).
>08:57:24,093 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>08:57:24,095 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>08:57:24,095 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>08:57:24,096 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>08:57:24,097 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>08:57:24,098 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>08:57:24,099 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>08:57:24,101 DBG installclass: Searching /usr/lib64/python3.6/site-packages/pyanaconda/installclasses.
>08:57:24,104 INF installclass: Using a visible install class Fedora (FedoraBaseInstallClass).
>08:57:24,818 DBG payload: getting release version from tree at None (rawhide)
>08:57:24,819 DBG payload: using default release version of rawhide
>08:57:24,822 INF bootloader: bootloader GRUB2 on X86 platform
>08:57:24,824 INF autopart: Detected 2.05 GiB of memory
>08:57:24,825 INF autopart: Suggested swap size (2.05 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>08:57:24,825 INF autopart: Swap attempt of 0.0
>08:57:24,826 INF bootloader: bootloader GRUB2 on X86 platform
>08:57:24,998 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>08:57:25,001 INF threading: Running Thread: AnaStorageThread (139924418750208)
>08:57:25,006 INF threading: Running Thread: AnaTimeInitThread (139924315121408)
>08:57:25,128 DBG payload: Restarting payload thread
>08:57:25,131 INF threading: Running Thread: AnaPayloadRestartThread (139924306728704)
>08:57:25,132 INF geoloc: Geolocation is disabled due to automated kickstart based installation.
>08:57:25,150 INF threading: Running Thread: AnaPayloadThread (139924298336000)
>08:57:25,152 INF threading: Thread Done: AnaPayloadRestartThread (139924306728704)
>08:57:25,156 DBG payload: Updating payload thread state: 0
>08:57:25,159 DBG payload: Updating payload thread state: 1
>08:57:25,386 DBG simpleline: GLib event loop is used!
>08:57:25,773 INF lifecycle: Adding controller: SummaryHub
>08:57:26,007 INF threading: Thread Done: AnaTimeInitThread (139924315121408)
>08:57:26,297 INF lifecycle: Module initialized: LangSpoke
>08:57:26,305 INF lifecycle: Module initialized: TimeSpoke
>08:57:26,309 INF threading: Running Thread: AnaSourceWatcher (139924315121408)
>08:57:26,312 INF threading: Running Thread: AnaSoftwareWatcher (139924306728704)
>08:57:26,510 INF lifecycle: Module initialized: NetworkSpoke
>08:57:26,523 INF threading: Running Thread: AnaStorageWatcher (139924289943296)
>08:57:26,530 INF lifecycle: Module initialized: PasswordSpoke
>08:57:26,536 WRN ui.tui.hubs: Spoke PasswordSpoke initialization failure!
>08:57:26,538 INF lifecycle: Module initialized: UserSpoke
>08:57:26,540 INF lifecycle: Initialization of all modules (8) has been started.
>08:57:29,626 DBG storage: onlyuse is now: sda
>08:57:29,626 INF threading: Thread Done: AnaStorageThread (139924418750208)
>08:57:29,627 DBG payload: Updating payload thread state: 2
>08:57:29,627 DBG payload: Updating payload thread state: 4
>08:57:29,630 INF lifecycle: Module initialized: StorageSpoke
>08:57:29,631 INF threading: Thread Done: AnaStorageWatcher (139924289943296)
>08:57:29,682 DBG payload: getting release version from tree at http://cobra02/trees/rawhide/ (rawhide)
>08:57:29,682 DBG payload: retrieving treeinfo from http://cobra02/trees/rawhide/ (proxy:  ; sslverify: True)
>08:57:29,683 INF payload: Trying to download '.treeinfo'
>08:57:29,709 DBG payload: Retrieved '.treeinfo' from http://cobra02/trees/rawhide/
>08:57:29,710 DBG payload: using treeinfo release version of rawhide
>08:57:32,378 DBG payload: Updating payload thread state: 5
>08:58:00,514 INF payload: Refreshing environmentAddons
>08:58:03,380 DBG payload: Updating payload thread state: 6
>08:58:03,380 DBG ui.tui.spokes.software_selection: Payload restarted, set new info and clear the old one.
>08:58:03,380 INF threading: Thread Done: AnaPayloadThread (139924298336000)
>08:58:03,381 INF lifecycle: Module initialized: SourceSpoke
>08:58:03,382 INF threading: Thread Done: AnaSourceWatcher (139924315121408)
>08:58:03,382 DBG ui.tui.spokes.software_selection: Apply called old env None, new env None and addons set()
>08:58:03,382 INF lifecycle: Module initialized: SoftwareSpoke
>08:58:03,383 INF lifecycle: All modules have been initialized.
>08:58:03,384 INF threading: Thread Done: AnaSoftwareWatcher (139924306728704)
>08:58:03,434 DBG storage: clearpart: initializing sda
>08:58:03,526 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run True.
>08:58:03,534 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>08:58:03,535 DBG kickstart.kickstart.bootloader: Applying bootloader location: MBR
>08:58:03,538 DBG kickstart.kickstart.bootloader: Applying bootloader timeout: 1
>08:58:03,539 DBG kickstart.kickstart.bootloader: Applying drive order: []
>08:58:03,540 DBG bootloader: new disk order: []
>08:58:03,542 DBG kickstart.kickstart.bootloader: The /boot partition doesn't exist.
>08:58:03,542 DBG kickstart.kickstart.bootloader: Use the first usable drive.
>08:58:03,542 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>08:58:03,548 INF autopart: Detected 2.05 GiB of memory
>08:58:03,549 INF autopart: Suggested swap size (2.05 GiB) exceeds 10 % of disk space, using 10 % of disk space (1024 MiB) instead.
>08:58:03,549 INF autopart: Swap attempt of 1024 MiB
>08:58:03,550 DBG autopart: do_autopart: True
>08:58:03,550 DBG autopart: encrypted_autopart: False
>08:58:03,550 DBG autopart: autopart_type: 2
>08:58:03,551 DBG autopart: clear_part_type: 1
>08:58:03,551 DBG autopart: clear_part_disks: []
>08:58:03,551 DBG autopart: autopart_requests:
>PartSpec instance (0x7f42acc444e0) -- 
>  mountpoint = /  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 1024 MiB  max_size = 50 GiB  grow = True
>PartSpec instance (0x7f42acc44128) -- 
>  mountpoint = /home  lv = True  thin = True  btrfs = True
>  weight = 0  fstype = ext4  encrypted = True
>  size = 500 MiB  max_size = None  grow = True
>PartSpec instance (0x7f42acc44320) -- 
>  mountpoint = None  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = biosboot  encrypted = False
>  size = 1024 KiB  max_size = None  grow = False
>PartSpec instance (0x7f42acc443c8) -- 
>  mountpoint = /boot  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = ext4  encrypted = False
>  size = 1024 MiB  max_size = None  grow = False
>PartSpec instance (0x7f42acc446d8) -- 
>  mountpoint = None  lv = True  thin = False  btrfs = False
>  weight = 0  fstype = swap  encrypted = True
>  size = 1024 MiB  max_size = None  grow = False
>
>08:58:03,552 DBG autopart: storage.disks: ['sda']
>08:58:03,552 DBG autopart: storage.partitioned: ['sda']
>08:58:03,553 DBG autopart: all names: ['/LiveOS/rootfs.img', '/overlay (deleted)', '/run/install/repo/images/install.img', 'live-base', 'live-rw', 'loop0', 'loop1', 'loop2', 'sda', 'sr0']
>08:58:03,553 DBG autopart: boot disk: sda
>08:58:03,568 DBG autopart: candidate disks: [DiskDevice instance (0x7f42acd722e8) --
>  name = sda  status = True  id = 2
>  children = []
>  parents = []
>  uuid = None  size = 10 GiB
>  format = non-existent msdos disklabel
>  major = 8  minor = 0  exists = True  protected = False
>  sysfs path = /sys/devices/pci0000:00/0000:00:01.1/ata1/host0/target0:0:0/0:0:0:0/block/sda
>  target size = 10 GiB  path = /dev/sda
>  format args = []  original_format = None  removable = False  wwn = None]
>08:58:03,570 DBG autopart: devs: [PartitionDevice instance (0x7f42accea908) --
>  name = req0  status = False  id = 81
>  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
>]
>08:58:03,573 DBG bootloader: _is_valid_disklabel(sda) returning True
>08:58:03,574 DBG bootloader: _is_valid_size(sda) returning True
>08:58:03,574 DBG bootloader: _is_valid_location(sda) returning True
>08:58:03,574 DBG bootloader: _is_valid_format(sda) returning True
>08:58:03,575 DBG bootloader: is_valid_stage1_device(sda) returning True
>08:58:03,575 INF autopart: skipping unneeded stage1 biosboot request
>08:58:03,575 DBG autopart: PartSpec instance (0x7f42acc44320) -- 
>  mountpoint = None  lv = False  thin = False  btrfs = False
>  weight = 0  fstype = biosboot  encrypted = False
>  size = 1024 KiB  max_size = None  grow = False
>
>08:58:03,576 DBG autopart: existing 10 GiB disk sda (2) with non-existent msdos disklabel
>08:58:03,919 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>08:58:03,926 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>08:58:03,927 DBG kickstart.kickstart.bootloader: Applying bootloader location: MBR
>08:58:03,929 DBG kickstart.kickstart.bootloader: Applying bootloader timeout: 1
>08:58:03,931 DBG kickstart.kickstart.bootloader: Applying drive order: []
>08:58:03,931 DBG bootloader: new disk order: []
>08:58:03,934 DBG kickstart.kickstart.bootloader: Found a boot drive: sda
>08:58:03,934 DBG kickstart.kickstart.bootloader: Use a usable drive with a /boot partition.
>08:58:03,935 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>08:58:03,945 DBG bootloader: stage1 device cannot be of type lvmvg
>08:58:03,946 DBG bootloader: stage1 device cannot be of type lvmlv
>08:58:03,947 DBG bootloader: stage1 device cannot be of type lvmlv
>08:58:03,949 DBG bootloader: _is_valid_disklabel(sda) returning True
>08:58:03,949 DBG bootloader: _is_valid_size(sda) returning True
>08:58:03,949 DBG bootloader: _is_valid_location(sda) returning True
>08:58:03,950 DBG bootloader: _is_valid_format(sda) returning True
>08:58:03,950 DBG bootloader: is_valid_stage1_device(sda) returning True
>08:58:03,954 DBG bootloader: _is_valid_disklabel(sda) returning True
>08:58:03,954 DBG bootloader: _is_valid_size(sda) returning True
>08:58:03,955 DBG bootloader: _is_valid_location(sda) returning True
>08:58:03,955 DBG bootloader: _is_valid_format(sda) returning True
>08:58:03,955 DBG bootloader: is_valid_stage1_device(sda) returning True
>08:58:03,956 DBG bootloader: _is_valid_disklabel(sda1) returning True
>08:58:03,957 DBG bootloader: _is_valid_size(sda1) returning True
>08:58:03,957 DBG bootloader: _is_valid_partition(sda1) returning True
>08:58:03,958 DBG bootloader: _is_valid_format(sda1) returning True
>08:58:03,958 DBG bootloader: is_valid_stage2_device(sda1) returning True
>08:58:03,972 DBG kickstart.kickstart.autopart: Storage check started with constraints {'min_ram': 320, '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', '/', '/var', '/usr/lib', '/home', '/usr/share'}, 'must_be_on_root': {'/root', '/mnt', '/lib', 'lost+found', '/bin', '/proc', '/sbin', '/etc', '/dev'}, 'swap_is_recommended': True}.
>08:58:03,972 DBG kickstart.kickstart.autopart: Run sanity check verify_root.
>08:58:03,973 DBG kickstart.kickstart.autopart: Run sanity check verify_s390_constraints.
>08:58:03,973 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_sizes.
>08:58:03,973 DBG kickstart.kickstart.autopart: Run sanity check verify_partition_format_sizes.
>08:58:03,974 DBG kickstart.kickstart.autopart: Run sanity check verify_bootloader.
>08:58:03,974 DBG kickstart.kickstart.autopart: Run sanity check verify_gpt_biosboot.
>08:58:03,974 DBG kickstart.kickstart.autopart: Run sanity check verify_swap.
>08:58:03,974 DBG kickstart.kickstart.autopart: Run sanity check verify_swap_uuid.
>08:58:03,975 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_linuxfs.
>08:58:03,975 DBG kickstart.kickstart.autopart: Run sanity check verify_mountpoints_on_root.
>08:58:03,975 DBG kickstart.kickstart.autopart: Run sanity check verify_luks_devices_have_key.
>08:58:03,975 DBG kickstart.kickstart.autopart: Run sanity check verify_mounted_partitions.
>08:58:03,976 DBG kickstart.kickstart.autopart: Storage check finished with success.
>08:58:03,976 DBG kickstart.kickstart.bootloader: Execute the bootloader with dry run False.
>08:58:03,981 DBG kickstart.kickstart.bootloader: Applying bootloader arguments: []
>08:58:03,982 DBG kickstart.kickstart.bootloader: Applying bootloader location: MBR
>08:58:03,984 DBG kickstart.kickstart.bootloader: Applying bootloader timeout: 1
>08:58:03,986 DBG kickstart.kickstart.bootloader: Applying drive order: []
>08:58:03,986 DBG bootloader: new disk order: []
>08:58:03,988 DBG kickstart.kickstart.bootloader: Use the requested boot drive.
>08:58:04,170 DBG storage_utils: sda matches ['sda'] for devicetree=existing 10 GiB disk sda (2) with non-existent msdos disklabel
>  non-existent 1024 MiB partition sda1 (88) with non-existent ext4 filesystem mounted at /boot
>  non-existent 9 GiB partition sda2 (81) with non-existent lvmpv
>    non-existent 9 GiB lvmvg fedora (94)
>      non-existent 8 GiB lvmlv fedora-root (100) with non-existent ext4 filesystem mounted at /
>      non-existent 1024 MiB lvmlv fedora-swap (109) with non-existent swap
>existing 588 MiB cdrom sr0 (7) with existing iso9660 filesystem
>existing 0 B file /run/install/repo/images/install.img (17)
>  existing 0 B loop loop0 (21)
>existing 0 B file /LiveOS/rootfs.img (31)
>  existing 0 B loop loop1 (35) with existing ext4 filesystem
>    existing 2 GiB dm live-rw (54) with existing ext4 filesystem
>    existing 2 GiB dm live-base (64) with existing ext4 filesystem
>existing 0 B file /overlay (deleted) (45)
>  existing 0 B loop loop2 (49)
> and disks_only=True
>08:58:04,174 DBG kickstart.kickstart.bootloader: Using a boot drive: sda
>08:58:04,183 DBG bootloader: stage1 device cannot be of type lvmvg
>08:58:04,184 DBG bootloader: stage1 device cannot be of type lvmlv
>08:58:04,184 DBG bootloader: stage1 device cannot be of type lvmlv
>08:58:04,186 DBG bootloader: _is_valid_disklabel(sda) returning True
>08:58:04,187 DBG bootloader: _is_valid_size(sda) returning True
>08:58:04,187 DBG bootloader: _is_valid_location(sda) returning True
>08:58:04,187 DBG bootloader: _is_valid_format(sda) returning True
>08:58:04,188 DBG bootloader: is_valid_stage1_device(sda) returning True
>08:58:04,192 DBG bootloader: _is_valid_disklabel(sda) returning True
>08:58:04,192 DBG bootloader: _is_valid_size(sda) returning True
>08:58:04,192 DBG bootloader: _is_valid_location(sda) returning True
>08:58:04,193 DBG bootloader: _is_valid_format(sda) returning True
>08:58:04,193 DBG bootloader: is_valid_stage1_device(sda) returning True
>08:58:04,194 DBG bootloader: _is_valid_disklabel(sda1) returning True
>08:58:04,194 DBG bootloader: _is_valid_size(sda1) returning True
>08:58:04,195 DBG bootloader: _is_valid_partition(sda1) returning True
>08:58:04,195 DBG bootloader: _is_valid_format(sda1) returning True
>08:58:04,196 DBG bootloader: is_valid_stage2_device(sda1) returning True
>08:58:04,210 DBG ui.tui.spokes.storage: Storage check started with constraints {'min_ram': 320, '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', '/', '/var', '/usr/lib', '/home', '/usr/share'}, 'must_be_on_root': {'/root', '/mnt', '/lib', 'lost+found', '/bin', '/proc', '/sbin', '/etc', '/dev'}, 'swap_is_recommended': True}.
>08:58:04,210 DBG ui.tui.spokes.storage: Run sanity check verify_root.
>08:58:04,211 DBG ui.tui.spokes.storage: Run sanity check verify_s390_constraints.
>08:58:04,211 DBG ui.tui.spokes.storage: Run sanity check verify_partition_sizes.
>08:58:04,211 DBG ui.tui.spokes.storage: Run sanity check verify_partition_format_sizes.
>08:58:04,211 DBG ui.tui.spokes.storage: Run sanity check verify_bootloader.
>08:58:04,212 DBG ui.tui.spokes.storage: Run sanity check verify_gpt_biosboot.
>08:58:04,212 DBG ui.tui.spokes.storage: Run sanity check verify_swap.
>08:58:04,212 DBG ui.tui.spokes.storage: Run sanity check verify_swap_uuid.
>08:58:04,213 DBG ui.tui.spokes.storage: Run sanity check verify_mountpoints_on_linuxfs.
>08:58:04,213 DBG ui.tui.spokes.storage: Run sanity check verify_mountpoints_on_root.
>08:58:04,213 DBG ui.tui.spokes.storage: Run sanity check verify_luks_devices_have_key.
>08:58:04,213 DBG ui.tui.spokes.storage: Run sanity check verify_mounted_partitions.
>08:58:04,214 DBG ui.tui.spokes.storage: Storage check finished with success.
>08:58:04,222 DBG simpleline: Scheduling screen SummaryHub
>08:58:04,225 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>08:58:04,226 DBG simpleline: Scheduling screen ProgressSpoke
>08:58:04,226 DBG simpleline: Starting main loop
>08:58:04,227 DBG simpleline: Processing screen ScreenData(SummaryHub,None,False)
>08:58:04,242 DBG payload: Source http://cobra02/trees/rawhide/ needs network for installation
>08:58:04,433 DBG simpleline: Input is required by ScreenData(SummaryHub,None,False) screen
>08:58:04,441 DBG payload: Source http://cobra02/trees/rawhide/ needs network for installation
>08:58:04,497 INF ui.lib.space: fs space: 6.8 GiB  needed: 2.79 GiB
>08:58:04,497 DBG simpleline: New signal CloseScreenSignal enqueued with source SummaryHub
>08:58:04,498 DBG simpleline: Closing screen ScreenData(SummaryHub,None,False) from SummaryHub
>08:58:04,499 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>08:58:04,499 DBG simpleline: Processing screen ScreenData(ProgressSpoke,None,False)
>08:58:04,513 INF threading: Running Thread: AnaInstallThread (139924298336000)
>08:58:04,517 DBG installation: CAN INSTALL BOOTLOADER
>08:58:04,518 DBG installation: True
>08:58:04,519 DBG installation: ADDING BOOTLOADER TASK
>08:58:04,521 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
>08:58:04,522 INF installation: Task started: Save system time to HW clock (1/18)
>08:58:05,510 INF progress: Save system time to HW clock
>08:58:05,515 DBG installation: Task completed: Save system time to HW clock (1/18) (1.0 s)
>08:58:05,516 INF progress: Setting up the installation environment
>08:58:05,517 INF installation: Queue started: Installation environment setup (1/9)
>08:58:05,517 INF installation: Task started: Setup addons (2/18)
>08:58:05,518 INF progress: Setup addons
>08:58:05,519 DBG installation: Task completed: Setup addons (2/18) (0.0 s)
>08:58:05,521 INF progress: Configuring storage
>08:58:05,522 INF installation: Queue started: Early storage configuration (2/9)
>08:58:05,522 INF installation: Task started: Insert custom storage to ksdata (3/18)
>08:58:05,554 INF storage: omitting ksdata: existing 10 GiB disk sda (2) with non-existent msdos disklabel
>08:58:05,559 INF progress: Insert custom storage to ksdata
>08:58:05,560 DBG installation: Task completed: Insert custom storage to ksdata (3/18) (0.0 s)
>08:58:05,561 INF installation: Task started: Run pre-storage tasks (4/18)
>08:58:05,561 INF progress: Run pre-storage tasks
>08:58:05,562 DBG installation: Task completed: Run pre-storage tasks (4/18) (0.0 s)
>08:58:05,562 INF installation: Task started: Activate filesystems (5/18)
>08:58:06,788 INF progress: Creating disklabel on /dev/sda
>08:58:08,045 INF progress: Creating ext4 on /dev/sda1
>08:58:09,451 INF progress: Creating lvmpv on /dev/sda2
>08:58:11,392 INF progress: Creating swap on /dev/mapper/fedora-swap
>08:58:11,877 INF progress: Creating ext4 on /dev/mapper/fedora-root
>08:58:12,660 INF storage: setting boot flag on sda1
>08:58:18,184 INF progress: Activate filesystems
>08:58:18,185 DBG installation: Task completed: Activate filesystems (5/18) (12.6 s)
>08:58:18,186 INF installation: Task started: Write early storage (6/18)
>08:58:18,191 INF storage: not writing out mpath configuration
>08:58:18,193 INF progress: Write early storage
>08:58:18,194 DBG installation: Task completed: Write early storage (6/18) (0.0 s)
>08:58:18,195 INF progress: Running pre-installation scripts
>08:58:18,196 INF installation: Queue started: Pre-install scripts (3/9)
>08:58:18,196 INF installation: Task started: Run %pre-install scripts (7/18)
>08:58:18,196 INF progress: Run %pre-install scripts
>08:58:18,197 DBG installation: Task completed: Run %pre-install scripts (7/18) (0.0 s)
>08:58:18,198 INF progress: Discovering realm to join
>08:58:18,198 INF installation: Queue started: Realm discover (4/9)
>08:58:18,199 INF installation: Task started: Discover realm to join (8/18)
>08:58:18,204 INF progress: Discover realm to join
>08:58:18,205 DBG installation: Task completed: Discover realm to join (8/18) (0.0 s)
>08:58:18,205 INF progress: Running pre-installation tasks
>08:58:18,206 INF installation: Queue started: Pre install tasks (5/9)
>08:58:18,206 INF installation: Task started: Setup authselect (9/18)
>08:58:18,210 INF progress: Setup authselect
>08:58:18,211 DBG installation: Task completed: Setup authselect (9/18) (0.0 s)
>08:58:18,211 INF installation: Task started: Setup firewall (10/18)
>08:58:18,215 INF progress: Setup firewall
>08:58:18,215 DBG installation: Task completed: Setup firewall (10/18) (0.0 s)
>08:58:18,216 INF installation: Task started: Setup network (11/18)
>08:58:18,239 INF progress: Setup network
>08:58:18,240 DBG installation: Task completed: Setup network (11/18) (0.0 s)
>08:58:18,241 INF installation: Task started: Setup timezone (12/18)
>08:58:18,341 INF progress: Setup timezone
>08:58:18,342 DBG installation: Task completed: Setup timezone (12/18) (0.1 s)
>08:58:18,342 INF installation: Task started: Copy /resolv.conf to sysroot (13/18)
>08:58:18,345 INF progress: Copy /resolv.conf to sysroot
>08:58:18,346 DBG installation: Task completed: Copy /resolv.conf to sysroot (13/18) (0.0 s)
>08:58:18,347 INF installation: Task started: Find additional packages & run preInstall() (14/18)
>08:58:18,349 DBG payload: added package requirement 'e2fsprogs' for storage, strong=True
>08:58:18,349 DBG payload: added package requirement 'lvm2' for storage, strong=True
>08:58:18,349 DBG payload: no package requirement added for realm
>08:58:18,350 DBG payload: no package requirement added for authselect
>08:58:18,350 DBG payload: no package requirement added for firewall
>08:58:18,350 DBG payload: no package requirement added for network
>08:58:18,351 DBG payload: added package requirement 'chrony' for ntp, strong=False
>08:58:18,351 DBG payload: added package requirement 'grub2' for bootloader, strong=True
>08:58:18,351 DBG payload: added package requirement 'grub2-tools' for bootloader, strong=True
>08:58:18,360 DBG payload: no group requirement added for language groups
>08:58:18,376 DBG payload: added package requirement 'langpacks-en' for langpacks, strong=False
>08:58:18,442 WRN payload: Platform group platform-kvm not available.
>08:58:18,443 INF progress: Find additional packages & run preInstall()
>08:58:18,443 DBG installation: Task completed: Find additional packages & run preInstall() (14/18) (0.1 s)
>08:58:18,444 INF progress: Installing.
>08:58:18,449 INF installation: Queue started: Payload installation (6/9)
>08:58:18,449 INF installation: Task started: Install the payload (15/18)
>08:58:18,450 INF progress: Starting package installation process
>08:58:18,497 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', 'chrony', PayloadRequirement(id=chrony, reasons=[PayloadRequirementReason(reason='ntp', strong=False)])), ('package', 'grub2', PayloadRequirement(id=grub2, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'grub2-tools', PayloadRequirement(id=grub2-tools, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'langpacks-en', PayloadRequirement(id=langpacks-en, reasons=[PayloadRequirementReason(reason='langpacks', strong=False)]))]
>08:59:46,419 INF progress: Preparing transaction from installation source
>09:11:51,875 INF progress: Install the payload
>09:11:51,877 DBG installation: Task completed: Install the payload (15/18) (813.4 s)
>09:11:51,878 INF progress: Configuring storage
>09:11:51,881 INF installation: Queue started: Late storage configuration (7/9)
>09:11:51,881 INF installation: Task started: Write late storage (16/18)
>09:11:51,882 INF progress: Write late storage
>09:11:51,882 DBG installation: Task completed: Write late storage (16/18) (0.0 s)
>09:11:51,883 INF progress: Installing boot loader
>09:11:51,886 INF installation: Queue started: Bootloader installation (8/9)
>09:11:51,887 INF installation: Task started: Install bootloader (17/18)
>09:11:51,889 DBG bootloader: WRITE BOOTLOADER METHOD
>09:11:51,891 DBG bootloader: WRITE BOOTLOADER - SKIP ?
>09:11:51,892 DBG bootloader: False
>09:11:51,894 INF bootloader: boot loader stage1 target device is sda
>09:11:51,896 INF bootloader: boot loader stage2 target device is sda1
>09:11:51,898 DBG payload: KERNEL VERSION LIST
>09:11:51,899 DBG payload: IMPORTED RPM
>09:11:51,942 DBG payload: KERNEL FILES
>09:11:51,943 DBG payload: ['4.17.0-0.rc6.git3.1.fc29.x86_64']
>09:11:51,949 DBG bootloader: new default image: <pyanaconda.bootloader.LinuxBootLoaderImage object at 0x7f42d434d208>
>09:11:51,969 DBG bootloader: ADDING IMAGE FOR KERNEL
>09:11:51,994 DBG bootloader: WRITE BOOTLOADER FINAL
>09:11:52,058 INF bootloader: bootloader.py: mbr will be updated for grub2
>09:11:55,869 INF bootloader: bootloader.py: used boot args: resume=/dev/mapper/fedora-swap rd.lvm.lv=fedora/root rd.lvm.lv=fedora/swap rhgb quiet 
>09:12:02,396 INF progress: Install bootloader
>09:12:02,401 DBG installation: Task completed: Install bootloader (17/18) (10.5 s)
>09:12:02,403 INF progress: Performing post-installation setup tasks
>09:12:02,412 INF installation: Queue started: Post-installation setup tasks (9/9)
>09:12:02,418 INF installation: Task started: Run post-installation setup tasks (18/18)
>09:12:02,718 DBG payload: The default target is already set.
>09:12:02,734 INF payload: Installation requirements: [('package', 'e2fsprogs', PayloadRequirement(id=e2fsprogs, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'lvm2', PayloadRequirement(id=lvm2, reasons=[PayloadRequirementReason(reason='storage', strong=True)])), ('package', 'chrony', PayloadRequirement(id=chrony, reasons=[PayloadRequirementReason(reason='ntp', strong=False)])), ('package', 'grub2', PayloadRequirement(id=grub2, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'grub2-tools', PayloadRequirement(id=grub2-tools, reasons=[PayloadRequirementReason(reason='bootloader', strong=True)])), ('package', 'langpacks-en', PayloadRequirement(id=langpacks-en, reasons=[PayloadRequirementReason(reason='langpacks', strong=False)]))]
>09:12:02,744 INF progress: Run post-installation setup tasks
>09:12:02,752 DBG installation: Task completed: Run post-installation setup tasks (18/18) (0.3 s)
>09:12:02,758 INF threading: Thread Done: AnaInstallThread (139924298336000)
>09:12:02,804 INF threading: Running Thread: AnaConfigurationThread (139924315121408)
>09:12:03,315 INF installation: Top-level task queue: Configuration queue
>Number of task queues: 7
>Number of tasks: 19
>Task & task group listing:
> Task queue: Installed system configuration
>  Task: Configure authselect
>  Task: Configure SELinux
>  Task: Configure first boot tasks
>  Task: Configure services
>  Task: Configure keyboard
>  Task: Configure timezone
>  Task: Configure language
>  Task: Configure firewall
>  Task: Configure X
> Task queue: Network configuration
>  Task: Network configuration
> Task queue: User creation
>  Task: Configure root
>  Task: Configure user groups
>  Task: Configure user
>  Task: Configure SSH key
> Task queue: Anaconda addon configuration
>  Task: Configure Anaconda addons
> Task queue: Initramfs generation
>  Task: Generate initramfs
> Task queue: Post installation scripts
>  Task: Run post installation scripts
> Task queue: Write configs and kickstarts
>  Task: Store kickstarts
>  Task: Store user interaction config
>09:12:03,326 INF progress: Configuring installed system
>09:12:03,339 INF installation: Queue started: Installed system configuration (1/7)
>09:12:03,352 INF installation: Task started: Configure authselect (1/19)
>09:12:03,421 INF progress: Configure authselect
>09:12:03,432 DBG installation: Task completed: Configure authselect (1/19) (0.1 s)
>09:12:03,436 INF installation: Task started: Configure SELinux (2/19)
>09:12:03,486 DBG kickstart.kickstart.selinux: Use SELinux default configuration.
>09:12:03,492 INF progress: Configure SELinux
>09:12:03,494 DBG installation: Task completed: Configure SELinux (2/19) (0.1 s)
>09:12:03,494 INF installation: Task started: Configure first boot tasks (3/19)
>09:12:03,499 DBG kickstart: The initial-setup.service service will be disabled.
>09:12:03,585 INF progress: Configure first boot tasks
>09:12:03,586 DBG installation: Task completed: Configure first boot tasks (3/19) (0.1 s)
>09:12:03,587 INF installation: Task started: Configure services (4/19)
>09:12:03,592 DBG kickstart: Enabling the service chronyd.
>09:12:03,669 INF progress: Configure services
>09:12:03,674 DBG installation: Task completed: Configure services (4/19) (0.1 s)
>09:12:03,679 INF installation: Task started: Configure keyboard (5/19)
>09:12:03,931 INF progress: Configure keyboard
>09:12:03,933 DBG installation: Task completed: Configure keyboard (5/19) (0.3 s)
>09:12:03,934 INF installation: Task started: Configure timezone (6/19)
>09:12:04,009 INF progress: Configure timezone
>09:12:04,010 DBG installation: Task completed: Configure timezone (6/19) (0.1 s)
>09:12:04,010 INF installation: Task started: Configure language (7/19)
>09:12:04,014 INF progress: Configure language
>09:12:04,015 DBG installation: Task completed: Configure language (7/19) (0.0 s)
>09:12:04,015 INF installation: Task started: Configure firewall (8/19)
>09:12:04,720 INF progress: Configure firewall
>09:12:04,721 DBG installation: Task completed: Configure firewall (8/19) (0.7 s)
>09:12:04,722 INF installation: Task started: Configure X (9/19)
>09:12:04,727 DBG kickstart: Using the default target multi-user.target.
>09:12:04,728 DBG desktop: Setting systemd default target to: multi-user.target
>09:12:04,729 INF progress: Configure X
>09:12:04,729 DBG installation: Task completed: Configure X (9/19) (0.0 s)
>09:12:04,730 INF progress: Writing network configuration
>09:12:04,733 INF installation: Queue started: Network configuration (2/7)
>09:12:04,733 INF installation: Task started: Network configuration (10/19)
>09:12:04,834 INF progress: Network configuration
>09:12:04,835 DBG installation: Task completed: Network configuration (10/19) (0.1 s)
>09:12:04,836 INF progress: Creating users
>09:12:04,844 INF installation: Queue started: User creation (3/7)
>09:12:04,846 INF installation: Task started: Configure root (11/19)
>09:12:05,007 INF progress: Configure root
>09:12:05,009 DBG installation: Task completed: Configure root (11/19) (0.2 s)
>09:12:05,009 INF installation: Task started: Configure user groups (12/19)
>09:12:05,009 INF progress: Configure user groups
>09:12:05,010 DBG installation: Task completed: Configure user groups (12/19) (0.0 s)
>09:12:05,010 INF installation: Task started: Configure user (13/19)
>09:12:05,011 INF progress: Configure user
>09:12:05,011 DBG installation: Task completed: Configure user (13/19) (0.0 s)
>09:12:05,012 INF installation: Task started: Configure SSH key (14/19)
>09:12:05,012 INF progress: Configure SSH key
>09:12:05,013 DBG installation: Task completed: Configure SSH key (14/19) (0.0 s)
>09:12:05,014 INF progress: Configuring addons
>09:12:05,016 INF installation: Queue started: Anaconda addon configuration (4/7)
>09:12:05,017 INF installation: Task started: Configure Anaconda addons (15/19)
>09:12:05,017 INF progress: Executing com_redhat_kdump addon
>09:12:05,020 INF progress: Configure Anaconda addons
>09:12:05,021 DBG installation: Task completed: Configure Anaconda addons (15/19) (0.0 s)
>09:12:05,021 INF progress: Generating initramfs
>09:12:05,024 INF installation: Queue started: Initramfs generation (5/7)
>09:12:05,024 INF installation: Task started: Generate initramfs (16/19)
>09:12:05,025 DBG payload: KERNEL VERSION LIST
>09:12:05,025 DBG payload: IMPORTED RPM
>09:12:05,048 DBG payload: KERNEL FILES
>09:12:05,049 DBG payload: ['4.17.0-0.rc6.git3.1.fc29.x86_64']
>09:12:05,051 INF payload: recreating initrd for 4.17.0-0.rc6.git3.1.fc29.x86_64
>09:13:46,847 INF progress: Generate initramfs
>09:13:46,849 DBG installation: Task completed: Generate initramfs (16/19) (101.8 s)
>09:13:46,849 INF progress: Running post-installation scripts
>09:13:46,853 INF installation: Queue started: Post installation scripts (6/7)
>09:13:46,853 INF installation: Task started: Run post installation scripts (17/19)
>09:13:46,854 INF kickstart.script: Running kickstart %%post script(s)
>09:13:48,115 ERR kickstart.script: Error code 1 running the kickstart script at line 35

Actions: View

Attachments on bug 1584681: 1446279 | 1446280 | 1446692