Attachment 902043 Details for Bug 1104558 – File: anaconda.log

File: anaconda.log

anaconda.log (text/plain), 17.50 KB, created by Petr Schindler on 2014-06-04 08:31:31 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Petr Schindler

Created: 2014-06-04 08:31:31 UTC

Size: 17.50 KB

patch

obsolete

>10:12:50,659 ERR anaconda.stdout: anaconda must be run as root.
>10:13:19,430 INFO anaconda: /sbin/anaconda 21.39-1
>10:13:19,606 INFO anaconda: 8126464 kB (7936 MB) are available
>10:13:19,607 INFO anaconda: check_memory(): total:7936, needed:512, graphical:512
>10:13:19,607 INFO anaconda: Not doing 'start audit daemon' in image installation
>10:13:19,608 INFO anaconda: anaconda called with cmdline = ['/sbin/anaconda', '--image=test.img']
>10:13:19,609 INFO anaconda: Default encoding = ascii 
>10:13:19,685 INFO anaconda: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>10:13:21,099 INFO anaconda: Display mode = g
>10:13:21,101 INFO anaconda: 8126464 kB (7936 MB) are available
>10:13:21,102 INFO anaconda: check_memory(): total:7936, needed:512, graphical:512
>10:13:21,447 WARN anaconda: module import of __init__ failed: <type 'exceptions.AttributeError'>
>10:13:21,450 WARN anaconda: module import of __init__ failed: <type 'exceptions.AttributeError'>
>10:13:21,450 INFO anaconda: using only installclass _Fedora
>10:13:21,563 INFO anaconda: bootloader GRUB2 on X86 platform
>10:13:21,597 INFO anaconda: bootloader GRUB2 on X86 platform
>10:13:21,598 INFO anaconda: naming disk image '/root/test.img' 'test'
>10:13:22,065 DEBUG anaconda: network: devices found ['em1', 'wlp3s0', 'virbr0']
>10:13:22,417 DEBUG anaconda: updating hostname dhcp-2-172.brq.redhat.com
>10:13:22,457 INFO anaconda: Running Thread: AnaStorageThread (140073094997760)
>10:13:22,459 INFO anaconda: Running Thread: AnaTimeInitThread (140073086605056)
>10:13:22,462 INFO anaconda: Running Thread: AnaWaitForConnectingNMThread (140073078212352)
>10:13:22,465 INFO anaconda: Running Thread: AnaPayloadThread (140073069819648)
>10:13:22,466 INFO anaconda: Not doing 'start chronyd' in image installation
>10:13:23,226 INFO anaconda: got 2 NTP servers from DHCP
>10:13:23,253 INFO anaconda: Not doing 'activate layouts' in image installation
>10:13:23,339 INFO anaconda: Thread Done: AnaWaitForConnectingNMThread (140073078212352)
>10:13:25,113 DEBUG anaconda: Entered spoke: WelcomeLanguageSpoke
>10:13:30,888 INFO anaconda: Not doing 'replace runtime X layouts' in image installation
>10:13:31,071 INFO anaconda: Not doing 'require network connection' in image installation
>10:13:31,072 DEBUG anaconda: network standalone spoke (init): completed: True
>10:13:31,073 INFO anaconda: Not doing 'require network connection' in image installation
>10:13:31,082 DEBUG anaconda: Left spoke: WelcomeLanguageSpoke
>10:13:31,083 DEBUG anaconda: Entered hub: SummaryHub
>10:13:31,602 INFO anaconda: Not doing 'modify system time and date' in image installation
>10:13:31,648 INFO anaconda: Running Thread: AnaNTPserver1 (140073078212352)
>10:13:31,660 INFO anaconda: Running Thread: AnaNTPserver2 (140072593794816)
>10:13:31,663 INFO anaconda: Running Thread: AnaDateTimeThread (140072585402112)
>10:13:31,706 INFO anaconda: fs space: 0 B  needed: 2861.02 MiB
>10:13:32,184 INFO anaconda: Thread Done: AnaNTPserver2 (140072593794816)
>10:13:32,255 INFO anaconda: Running Thread: AnaAddLayoutsInitThread (140072593794816)
>10:13:32,255 INFO anaconda: Not doing 'hide runtime keyboard configuration warning' in image installation
>10:13:32,261 DEBUG anaconda: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f6548125710>> on <dictionary-keyiterator object at 0x7f6548147940>
>10:13:32,262 INFO anaconda: Not doing 'add runtime X layout' in image installation
>10:13:32,267 INFO anaconda: Running Thread: AnaGtkBatchPre1 (140072506619648)
>10:13:32,307 INFO anaconda: Thread Done: AnaGtkBatchPre1 (140072506619648)
>10:13:32,502 INFO anaconda: Not doing 'test X layouts' in image installation
>10:13:32,513 INFO anaconda: Running Thread: AnaKeyboardThread (140072506619648)
>10:13:32,530 INFO anaconda: fs space: 0 B  needed: 2861.02 MiB
>10:13:32,953 INFO anaconda: fs space: 0 B  needed: 2861.02 MiB
>10:13:33,293 INFO anaconda: Running Thread: AnaSourceWatcher (140072498226944)
>10:13:33,367 INFO anaconda: Running Thread: AnaSoftwareWatcher (140072489834240)
>10:13:33,472 INFO anaconda: Running Thread: AnaStorageWatcher (140072481441536)
>10:13:33,558 INFO anaconda: Running Thread: AnaCustomStorageInit (140072473048832)
>10:13:33,780 INFO anaconda: Not doing 'register anaconda secret agent' in image installation
>10:13:34,121 DEBUG anaconda: network: GUI, device configuration added: connection None device wlp3s0
>10:13:34,391 DEBUG anaconda: network: GUI, device configuration added: connection 06144322-aa8a-497b-84a1-9bf1558e5340 device em1
>10:13:34,418 DEBUG anaconda: network: GUI, connection 06144322-aa8a-497b-84a1-9bf1558e5340 found
>10:13:34,424 DEBUG anaconda: network: GUI, connection 90b71599-8837-4fe1-b11e-4b7c92424f1b found
>10:13:34,561 INFO anaconda: Not doing 'hide hint to use network configuration in DE' in image installation
>10:13:34,750 DEBUG anaconda: updating hostname dhcp-2-172.brq.redhat.com
>10:13:35,130 INFO anaconda: Not doing 'require network connection' in image installation
>10:13:35,249 INFO anaconda: setting <pyanaconda.ui.gui.spokes.datetime_spoke.DatetimeSpoke object at 0x7f6548125050> status to: Restoring hardware time...
>10:13:35,266 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.keyboard.KeyboardSpoke object at 0x7f6548125150>
>10:13:35,266 INFO anaconda: setting <pyanaconda.ui.gui.spokes.keyboard.KeyboardSpoke object at 0x7f6548125150> status to: Getting list of layouts...
>10:13:35,267 INFO anaconda: setting <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90> status to: Probing storage...
>10:13:35,269 INFO anaconda: setting <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0> status to: Downloading package metadata...
>10:13:35,270 INFO anaconda: setting <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50> status to: Probing storage...
>04:13:37,159 INFO anaconda: Thread Done: AnaNTPserver1 (140073078212352)
>04:13:38,370 INFO anaconda: Thread Done: AnaCustomStorageInit (140072473048832)
>04:13:38,954 INFO anaconda: Thread Done: AnaStorageThread (140073094997760)
>04:13:39,019 INFO anaconda: Thread Done: AnaStorageWatcher (140072481441536)
>04:13:39,276 INFO anaconda: setting <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90> status to: Downloading package metadata...
>04:13:39,288 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50>
>04:13:40,005 INFO anaconda: Thread Done: AnaTimeInitThread (140073086605056)
>04:13:40,006 INFO anaconda: Thread Done: AnaDateTimeThread (140072585402112)
>04:13:40,052 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.datetime_spoke.DatetimeSpoke object at 0x7f6548125050>
>04:13:41,046 DEBUG anaconda: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f6548125710>> on <dictionary-keyiterator object at 0x7f6548147940>
>04:13:41,047 INFO anaconda: Thread Done: AnaAddLayoutsInitThread (140072593794816)
>04:13:41,049 INFO anaconda: Thread Done: AnaKeyboardThread (140072506619648)
>04:13:41,339 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.keyboard.KeyboardSpoke object at 0x7f6548125150>
>04:13:41,561 INFO anaconda: setting <pyanaconda.ui.gui.spokes.network.NetworkSpoke object at 0x7f651400f2d0> status to: Wired (em1) connected
>04:13:55,588 DEBUG anaconda: Entered spoke: StorageSpoke
>04:13:56,427 INFO anaconda: Thread Done: AnaPayloadThread (140073069819648)
>04:13:56,702 INFO anaconda: setting <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0> status to: Downloading group metadata...
>04:13:56,710 INFO anaconda: Running Thread: AnaCheckSoftwareThread (140073069819648)
>04:13:56,710 INFO anaconda: Thread Done: AnaSoftwareWatcher (140072489834240)
>04:13:56,766 DEBUG anaconda: Setting up repos: []
>04:13:56,810 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0>
>04:13:56,818 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0>
>04:13:56,824 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90>
>04:13:56,825 INFO anaconda: setting <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0> status to: Checking software dependencies...
>04:14:00,965 DEBUG anaconda: disk free: 10 GiB  fs free: 0 B  sw needs: 2861.02 MiB  auto swap: 0 B
>04:14:01,275 INFO anaconda: Running Thread: AnaExecuteStorageThread (140072489834240)
>04:14:01,275 DEBUG anaconda: Left spoke: StorageSpoke
>04:14:01,297 DEBUG anaconda: new disk order: []
>04:14:01,854 INFO anaconda: Not doing 'require network connection' in image installation
>04:14:02,012 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50>
>04:14:02,015 INFO anaconda: setting <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50> status to: Saving storage configuration...
>04:14:02,277 DEBUG anaconda: _is_valid_disklabel(test) returning True
>04:14:02,277 DEBUG anaconda: _is_valid_size(test) returning True
>04:14:02,278 DEBUG anaconda: _is_valid_location(test) returning True
>04:14:02,278 DEBUG anaconda: _is_valid_format(test) returning True
>04:14:02,279 DEBUG anaconda: is_valid_stage1_device(test) returning True
>04:14:07,909 DEBUG anaconda: new disk order: []
>04:14:08,216 DEBUG anaconda: stage1 device cannot be of type lvmvg
>04:14:08,219 DEBUG anaconda: stage1 device cannot be of type lvmlv
>04:14:08,229 DEBUG anaconda: stage1 device cannot be of type lvmlv
>04:14:08,240 DEBUG anaconda: _is_valid_disklabel(test) returning True
>04:14:08,242 DEBUG anaconda: _is_valid_size(test) returning True
>04:14:08,243 DEBUG anaconda: _is_valid_location(test) returning True
>04:14:08,267 DEBUG anaconda: _is_valid_format(test) returning True
>04:14:08,268 DEBUG anaconda: is_valid_stage1_device(test) returning True
>04:14:08,278 DEBUG anaconda: stage1 device cannot be of type loop
>04:14:08,280 DEBUG anaconda: _is_valid_disklabel(test1) returning True
>04:14:08,283 DEBUG anaconda: _is_valid_size(test1) returning True
>04:14:08,288 DEBUG anaconda: _is_valid_location(test1) returning True
>04:14:08,289 DEBUG anaconda: _is_valid_partition(test1) returning True
>04:14:08,297 DEBUG anaconda: _is_valid_format(test1) returning True
>04:14:08,308 DEBUG anaconda: is_valid_stage2_device(test1) returning True
>04:14:08,363 DEBUG anaconda: new disk order: []
>04:14:08,682 DEBUG anaconda: stage1 device cannot be of type lvmvg
>04:14:08,709 DEBUG anaconda: stage1 device cannot be of type lvmlv
>04:14:08,711 DEBUG anaconda: stage1 device cannot be of type lvmlv
>04:14:08,715 DEBUG anaconda: _is_valid_disklabel(test) returning True
>04:14:08,716 DEBUG anaconda: _is_valid_size(test) returning True
>04:14:08,716 DEBUG anaconda: _is_valid_location(test) returning True
>04:14:08,716 DEBUG anaconda: _is_valid_format(test) returning True
>04:14:08,717 DEBUG anaconda: is_valid_stage1_device(test) returning True
>04:14:08,717 INFO anaconda: Running Thread: AnaCheckStorageThread (140072506619648)
>04:14:08,717 INFO anaconda: Thread Done: AnaExecuteStorageThread (140072489834240)
>04:14:08,799 DEBUG anaconda: stage1 device cannot be of type loop
>04:14:08,802 DEBUG anaconda: _is_valid_disklabel(test1) returning True
>04:14:08,807 DEBUG anaconda: _is_valid_size(test1) returning True
>04:14:08,811 DEBUG anaconda: _is_valid_location(test1) returning True
>04:14:08,812 DEBUG anaconda: _is_valid_partition(test1) returning True
>04:14:08,817 DEBUG anaconda: _is_valid_format(test1) returning True
>04:14:08,818 DEBUG anaconda: is_valid_stage2_device(test1) returning True
>04:14:08,824 INFO anaconda: Thread Done: AnaCheckStorageThread (140072506619648)
>04:14:08,843 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50>
>04:14:08,872 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50>
>04:14:08,874 INFO anaconda: setting <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50> status to: Checking storage configuration...
>04:14:08,896 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.storage.StorageSpoke object at 0x7f654814fb50>
>04:14:10,829 INFO anaconda: Thread Done: AnaCheckSoftwareThread (140073069819648)
>04:14:10,941 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0>
>04:14:10,949 INFO anaconda: fs space: 8672 MiB  needed: 4135.1 MiB
>04:14:10,998 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90>
>04:14:11,792 INFO anaconda: Thread Done: AnaSourceWatcher (140072498226944)
>04:14:11,824 INFO anaconda: fs space: 8672 MiB  needed: 4135.1 MiB
>04:14:11,898 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90>
>04:14:13,654 DEBUG anaconda: Entered spoke: SoftwareSelectionSpoke
>04:14:17,193 INFO anaconda: Running Thread: AnaCheckSoftwareThread (140072498226944)
>04:14:17,193 DEBUG anaconda: Left spoke: SoftwareSelectionSpoke
>04:14:17,443 INFO anaconda: Not doing 'require network connection' in image installation
>04:14:17,467 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0>
>04:14:17,475 INFO anaconda: spoke is not ready: <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90>
>04:14:17,475 INFO anaconda: setting <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0> status to: Checking software dependencies...
>04:14:20,868 INFO anaconda: Thread Done: AnaCheckSoftwareThread (140072498226944)
>04:14:20,903 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.software.SoftwareSelectionSpoke object at 0x7f654814f9d0>
>04:14:20,909 INFO anaconda: fs space: 8672 MiB  needed: 671.61 MiB
>04:14:20,946 INFO anaconda: spoke is ready: <pyanaconda.ui.gui.spokes.source.SourceSpoke object at 0x5500a90>
>04:14:28,930 DEBUG anaconda: Left hub: SummaryHub
>04:14:28,931 DEBUG anaconda: Entered hub: ProgressHub
>04:14:29,121 INFO anaconda: Running Thread: AnaInstallThread (140072498226944)
>04:14:29,121 INFO anaconda: Not doing 'save system time to HW clock' in image installation
>04:14:29,122 INFO anaconda: Setting up the installation environment
>04:14:29,716 INFO anaconda: Creating disklabel on /dev/mapper/test
>04:14:30,711 INFO anaconda: Creating ext4 on /dev/mapper/test1
>04:14:32,034 INFO anaconda: Creating lvmpv on /dev/mapper/test2
>04:14:32,257 DEBUG anaconda: Entered spoke: PasswordSpoke
>04:14:33,814 INFO anaconda: Creating swap on /dev/mapper/anaconda_dhcp--2--172_image-swap
>04:14:34,766 INFO anaconda: Creating ext4 on /dev/mapper/anaconda_dhcp--2--172_image-root
>04:14:41,733 DEBUG anaconda: Left spoke: PasswordSpoke
>04:14:42,804 DEBUG anaconda: Entered spoke: UserSpoke
>04:14:56,930 DEBUG anaconda: Left spoke: UserSpoke
>04:24:19,920 INFO anaconda: Installing bootloader
>04:24:19,920 INFO anaconda: bootloader stage1 target device is loop0
>04:24:19,920 INFO anaconda: bootloader stage2 target device is test1
>04:24:19,923 DEBUG anaconda: new default image: <pyanaconda.bootloader.LinuxBootLoaderImage object at 0x7f65081bb910>
>04:24:52,717 INFO anaconda: bootloader.py: used boot args:  rd.lvm.lv=anaconda_dhcp-2-172_image/swap rd.lvm.lv=anaconda_dhcp-2-172_image/root rhgb quiet 
>04:24:58,961 INFO anaconda: Performing post-installation setup tasks
>04:24:59,032 INFO anaconda: Thread Done: AnaInstallThread (140072498226944)
>04:24:59,215 INFO anaconda: Running Thread: AnaConfigurationThread (140072498226944)
>04:24:59,217 INFO anaconda: Configuring installed system
>04:25:02,278 INFO anaconda: Creating users
>04:25:02,279 INFO anaconda: created new libuser.conf at /tmp/libuser.IgQrzS with instPath="/mnt/sysimage"
>04:25:04,485 INFO anaconda: Configuring addons
>04:25:04,486 INFO anaconda: Generating initramfs
>04:27:06,900 INFO anaconda: Running post-installation scripts
>04:27:06,900 INFO anaconda: Running kickstart %%post script(s)
>04:27:08,408 INFO anaconda: All kickstart %%post script(s) have been run
>04:27:08,417 INFO anaconda: Thread Done: AnaConfigurationThread (140072498226944)
>04:27:22,166 DEBUG anaconda: running handleException
>04:27:22,168 DEBUG anaconda: Traceback (most recent call last):
>
>  File "/usr/lib64/python2.7/atexit.py", line 24, in _run_exitfuncs
>    func(*targs, **kargs)
>
>  File "/sbin/anaconda", line 79, in exitHandler
>    dev.deactivate(recursive=True)
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 2108, in deactivate
>    StorageDevice.teardown(self, recursive=recursive)
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 870, in teardown
>    self._postTeardown(recursive=recursive)
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 875, in _postTeardown
>    self.teardownParents(recursive=recursive)
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 365, in teardownParents
>    parent.teardown(recursive=recursive)
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 870, in teardown
>    self._postTeardown(recursive=recursive)
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 4253, in _postTeardown
>    self.name = "tmploop%d" % self.id
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 406, in <lambda>
>    lambda s, v: s._setName(v),
>
>  File "/usr/lib/python2.7/site-packages/blivet/devices.py", line 686, in _setName
>    raise errors.DeviceError("Cannot rename existing device.")
>
>DeviceError: Cannot rename existing device.
>
>04:27:22,169 DEBUG anaconda: Gtk not running, starting Gtk and running exception handler in it
>04:27:31,711 INFO anaconda: Running kickstart %%traceback script(s)
>04:27:31,712 INFO anaconda: All kickstart %%traceback script(s) have been run

Actions: View

Attachments on bug 1104558: 902042 | 902043 | 902044 | 902045 | 902046 | 902047 | 902048 | 902049 | 902050 | 902051 | 902052