Attachment 1440768 Details for Bug 1581891 – File: anaconda.log

File: anaconda.log

anaconda.log (text/plain), 20.29 KB, created by revlin on 2018-05-23 20:43:10 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: revlin

Created: 2018-05-23 20:43:10 UTC

Size: 20.29 KB

patch

obsolete

>20:41:09,708 INF main: /sbin/anaconda 28.22.10-1.fc28
>20:41:09,815 INF isys: 32983500 kB (32210 MB) are available
>20:41:09,820 INF startup_utils: check_memory(): total:32210, needed:320, graphical:410
>20:41:09,824 INF main: anaconda called with cmdline = ['/sbin/anaconda']
>20:41:09,824 INF main: Default encoding = utf-8 
>20:41:09,860 INF dbus.connection: Connecting to a default bus at unix:abstract=/tmp/dbus-TJElfkkOSV,guid=a1ac033b395764b23e1cee1d5b05d1e5.
>20:41:10,100 INF startup_utils: Waiting 60 sec for modules to be started.
>20:41:11,148 INF startup_utils: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>20:41:11,183 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'
>20:41:13,080 WRN kickstart: Command firstboot will be parsed in DBus module.
>20:41:13,089 DBG localization: setting locale to: en_US.UTF-8
>20:41:13,102 DBG network: devices found ['enp0s31f6', 'enp5s0', 'wlp6s0']
>20:41:13,109 DBG network: ensure single initramfs connections
>20:41:13,195 DBG network: apply kickstart
>20:41:13,195 DBG network: create missing ifcfg files
>20:41:13,238 DBG network: ifcfg file for enp0s31f6 not found
>20:41:13,352 DBG network: dumping ifcfg file for enp0s31f6 from default autoconnection d96871bc-45e1-3363-963d-0953a8e3ea6a
>20:41:13,388 DBG network: ifcfg file for enp5s0 not found
>20:41:13,496 DBG network: dumping ifcfg file for enp5s0 from default autoconnection 57aa7d96-e6f0-3ce4-a8c0-e311db3da451
>20:41:13,502 DBG network: missing ifcfgs created for devices ['enp0s31f6', 'enp5s0']
>20:41:13,513 DBG network: set real ONBOOT value
>20:41:13,514 INF threading: Running Thread: AnaWaitForConnectingNMThread (140256462800640)
>20:41:13,516 DBG anaconda: setting display mode to GUI
>20:41:13,518 DBG network: waiting for connecting NM (dhcp in progress?), timeout=45
>20:41:13,518 INF anaconda: Display mode is set to 'interactive graphical mode'.
>20:41:13,519 INF isys: 32983500 kB (32210 MB) are available
>20:41:13,523 INF startup_utils: check_memory(): total:32210, needed:320, graphical:410
>20:41:13,523 DBG core.util: Setting timeout 60 seconds for starting X.
>20:41:13,818 WRN display: X startup failed: Xorg exited with status 1
>20:41:13,819 WRN stdout: X startup failed, falling back to text mode
>20:41:13,820 DBG anaconda: changing display mode from GUI to TUI
>20:41:15,832 DBG simpleline: Scheduling screen AskVNCSpoke
>20:41:15,833 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:15,833 DBG simpleline: Starting main loop
>20:41:15,833 DBG simpleline: Processing signal RenderScreenSignal
>20:41:15,833 DBG simpleline: Processing screen ScreenData(AskVNCSpoke,None,False)
>20:41:15,834 DBG simpleline: Input is required by ScreenData(AskVNCSpoke,None,False) screen
>20:41:16,812 DBG network: NM connected, waited 3 seconds
>20:41:16,827 INF network: got 0 NTP servers from DHCP
>20:41:16,829 INF threading: Thread Done: AnaWaitForConnectingNMThread (140256462800640)
>20:41:18,970 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:41:18,970 DBG simpleline: Processing signal InputReceivedSignal
>20:41:18,970 DBG simpleline: New signal InputReadySignal enqueued with source AskVNCSpoke
>20:41:18,971 DBG simpleline: Processing signal InputReadySignal
>20:41:18,971 DBG simpleline: New signal CloseScreenSignal enqueued with source AskVNCSpoke
>20:41:18,971 DBG simpleline: Processing signal CloseScreenSignal
>20:41:18,971 DBG simpleline: Closing screen ScreenData(AskVNCSpoke,None,False) from AskVNCSpoke
>20:41:18,971 DBG simpleline: Main loop ended. Running callback if set.
>20:41:19,005 DBG installclass: Searching /usr/lib64/python3.6/site-packages/pyanaconda/installclasses.
>20:41:19,010 DBG installclass: Found Fedora (FedoraBaseInstallClass).
>20:41:19,010 DBG installclass: Found Atomic Host (AtomicHostInstallClass).
>20:41:19,010 DBG installclass: Found Red Hat Enterprise Linux (RHELBaseInstallClass).
>20:41:19,010 DBG installclass: Found Fedora (DefaultInstallClass).
>20:41:19,011 DBG installclass: Found Fedora Server (FedoraServerInstallClass).
>20:41:19,011 DBG installclass: Found Scientific Linux (ScientificBaseInstallClass).
>20:41:19,011 DBG installclass: Found Fedora Workstation (FedoraWorkstationInstallClass).
>20:41:19,011 DBG installclass: Found CentOS Linux (CentOSBaseInstallClass).
>20:41:19,011 INF installclass: Using a visible install class Fedora Server (FedoraServerInstallClass).
>20:41:19,364 DBG payload: getting release version from tree at None (28)
>20:41:19,364 DBG payload: using default release version of 28
>20:41:19,365 INF bootloader: bootloader EFIGRUB on EFI platform
>20:41:19,366 INF autopart: Detected 31.46 GiB of memory
>20:41:19,366 INF autopart: Suggested swap size (15.73 GiB) exceeds 10 % of disk space, using 10 % of disk space (0.0) instead.
>20:41:19,366 INF autopart: Swap attempt of 0.0
>20:41:19,367 INF bootloader: bootloader EFIGRUB on EFI platform
>20:41:19,367 WRN main: reinitializing locale due to failed attempt to start the GUI
>20:41:19,368 DBG localization: scripts found for locale en_US.UTF-8: ['Latn']
>20:41:19,368 DBG localization: console fonts found for locale en_US.UTF-8: ['eurlatgr']
>20:41:19,368 DBG localization: setting console font to eurlatgr
>20:41:19,374 DBG localization: console font set successfully to eurlatgr
>20:41:19,375 DBG localization: setting locale to: en_US.UTF-8
>20:41:19,501 DBG storage_utils: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>20:41:19,503 INF threading: Running Thread: AnaStorageThread (140256454407936)
>20:41:19,505 INF threading: Running Thread: AnaTimeInitThread (140256462800640)
>20:41:19,537 DBG payload: Restarting payload thread
>20:41:19,537 INF threading: Running Thread: AnaPayloadRestartThread (140256351393536)
>20:41:19,537 INF geoloc: Geolocation is enabled.
>20:41:19,537 INF threading: Running Thread: AnaPayloadThread (140256343000832)
>20:41:19,538 DBG payload: Updating payload thread state: 0
>20:41:19,538 INF threading: Thread Done: AnaPayloadRestartThread (140256351393536)
>20:41:19,538 DBG payload: Updating payload thread state: 1
>20:41:19,539 INF threading: Running Thread: AnaGeolocationRefreshThread (140256334608128)
>20:41:19,539 INF geoloc: Starting geolocation lookup
>20:41:19,539 INF geoloc: Geolocation provider: Fedora GeoIP
>20:41:19,650 DBG simpleline: GLib event loop is used!
>20:41:19,704 INF lifecycle: Adding controller: SummaryHub
>20:41:19,707 INF lifecycle: Module initialized: TimeSpoke
>20:41:19,794 INF lifecycle: Module initialized: LangSpoke
>20:41:19,795 INF threading: Running Thread: AnaSoftwareWatcher (140256351393536)
>20:41:19,796 INF threading: Running Thread: AnaSourceWatcher (140256324093696)
>20:41:19,799 INF threading: Running Thread: AnaStorageWatcher (140256315700992)
>20:41:20,191 INF geoloc: Geolocation lookup finished in 0.7 seconds
>20:41:20,192 INF geoloc: got results from geolocation
>20:41:20,193 INF threading: Thread Done: AnaGeolocationRefreshThread (140256334608128)
>20:41:20,212 DBG network: updating host name localhost.localdomain
>20:41:20,236 INF lifecycle: Module initialized: NetworkSpoke
>20:41:20,238 INF lifecycle: Module initialized: PasswordSpoke
>20:41:20,241 INF lifecycle: Module initialized: UserSpoke
>20:41:20,241 INF lifecycle: Initialization of all modules (8) has been started.
>20:41:20,241 DBG simpleline: Scheduling screen SummaryHub
>20:41:20,242 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:20,242 DBG simpleline: Scheduling screen ProgressSpoke
>20:41:20,243 DBG simpleline: Starting main loop
>20:41:20,245 DBG simpleline: Processing screen ScreenData(SummaryHub,None,False)
>20:41:23,847 DBG storage: protected device spec LABEL=Fedora-S-dvd-x86_64-28 resolved to sda
>20:41:24,573 DBG storage: blkid.tab devs: []
>20:41:24,573 DBG storage: parsing /mnt/sysimage/etc/crypttab
>20:41:24,573 DBG storage: crypttab maps: []
>20:41:24,573 DBG storage: parsing /mnt/sysimage/etc/fstab
>20:41:25,973 INF threading: Thread Done: AnaStorageThread (140256454407936)
>20:41:25,974 DBG payload: Updating payload thread state: 2
>20:41:25,975 DBG payload: Updating payload thread state: 4
>20:41:25,976 INF lifecycle: Module initialized: StorageSpoke
>20:41:25,976 INF threading: Thread Done: AnaStorageWatcher (140256315700992)
>20:41:26,017 DBG simpleline: Input is required by ScreenData(SummaryHub,None,False) screen
>20:41:26,033 INF threading: Thread Done: AnaTimeInitThread (140256462800640)
>20:41:26,987 DBG payload: getting release version from tree at file:///run/install/source (28)
>20:41:26,987 DBG payload: retrieving treeinfo from file:///run/install/source (proxy: None ; sslverify: True)
>20:41:26,987 INF payload: Trying to download '.treeinfo'
>20:41:27,066 DBG payload: Retrieved '.treeinfo' from file:///run/install/source
>20:41:27,068 DBG payload: using treeinfo release version of 28
>20:41:28,317 DBG payload: Updating payload thread state: 5
>20:41:29,054 INF payload: Refreshing environmentAddons
>20:41:29,058 DBG payload: Updating payload thread state: 6
>20:41:29,058 DBG ui.tui.spokes.software_selection: Payload restarted, set new info and clear the old one.
>20:41:29,058 INF threading: Thread Done: AnaPayloadThread (140256343000832)
>20:41:29,058 DBG ui.tui.spokes.software_selection: Apply called old env None, new env server-product-environment and addons set()
>20:41:29,059 DBG ui.tui.spokes.software_selection: Setting new software selection old env None, new env server-product-environment and addons set()
>20:41:29,059 INF threading: Running Thread: AnaCheckSoftwareThread (140256343000832)
>20:41:29,059 INF lifecycle: Module initialized: SourceSpoke
>20:41:29,070 DBG payload: apply with result True called on requirements []
>20:41:29,077 INF threading: Thread Done: AnaSourceWatcher (140256324093696)
>20:41:29,152 INF threading: Thread Done: AnaCheckSoftwareThread (140256343000832)
>20:41:29,152 INF lifecycle: Module initialized: SoftwareSpoke
>20:41:29,153 INF lifecycle: All modules have been initialized.
>20:41:29,153 INF threading: Thread Done: AnaSoftwareWatcher (140256351393536)
>20:41:31,763 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:41:31,764 DBG simpleline: New signal InputReadySignal enqueued with source SummaryHub
>20:41:31,766 DBG simpleline: Pushing screen SourceSpoke to stack
>20:41:31,766 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:31,767 DBG simpleline: Processing screen ScreenData(SourceSpoke,None,False)
>20:41:31,770 DBG simpleline: Input is required by ScreenData(SourceSpoke,None,False) screen
>20:41:34,566 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:41:34,568 DBG simpleline: New signal InputReadySignal enqueued with source SourceSpoke
>20:41:34,569 DBG payload: Restarting payload thread
>20:41:34,570 INF threading: Running Thread: AnaPayloadRestartThread (140256462800640)
>20:41:34,570 DBG simpleline: New signal CloseScreenSignal enqueued with source SourceSpoke
>20:41:34,572 INF threading: Running Thread: AnaPayloadThread (140256351393536)
>20:41:34,572 DBG payload: Updating payload thread state: 0
>20:41:34,573 DBG payload: Updating payload thread state: 1
>20:41:34,573 INF threading: Thread Done: AnaPayloadRestartThread (140256462800640)
>20:41:34,574 DBG payload: Updating payload thread state: 2
>20:41:34,575 DBG payload: Updating payload thread state: 4
>20:41:34,576 DBG simpleline: Closing screen ScreenData(SourceSpoke,None,False) from SourceSpoke
>20:41:34,577 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:34,578 DBG simpleline: Processing screen ScreenData(SummaryHub,None,False)
>20:41:35,183 DBG payload: Source doesn't require network for installation
>20:41:35,228 DBG simpleline: Input is required by ScreenData(SummaryHub,None,False) screen
>20:41:35,535 DBG payload: Source doesn't require network for installation
>20:41:36,250 DBG payload: getting release version from tree at file:///run/install/source (28)
>20:41:36,250 DBG payload: retrieving treeinfo from file:///run/install/source (proxy: None ; sslverify: True)
>20:41:36,250 INF payload: Trying to download '.treeinfo'
>20:41:36,332 DBG payload: Retrieved '.treeinfo' from file:///run/install/source
>20:41:36,334 DBG payload: using treeinfo release version of 28
>20:41:37,609 DBG payload: Updating payload thread state: 5
>20:41:38,286 INF payload: Refreshing environmentAddons
>20:41:38,290 DBG payload: Updating payload thread state: 6
>20:41:38,290 DBG ui.tui.spokes.software_selection: Payload restarted, set new info and clear the old one.
>20:41:38,290 INF threading: Thread Done: AnaPayloadThread (140256351393536)
>20:41:40,029 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:41:40,030 DBG simpleline: New signal InputReadySignal enqueued with source SummaryHub
>20:41:40,031 DBG simpleline: Pushing screen SourceSpoke to stack
>20:41:40,032 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:40,032 DBG simpleline: Processing screen ScreenData(SourceSpoke,None,False)
>20:41:40,036 DBG simpleline: Input is required by ScreenData(SourceSpoke,None,False) screen
>20:41:46,578 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:41:46,580 DBG simpleline: New signal InputReadySignal enqueued with source SourceSpoke
>20:41:46,581 DBG simpleline: Replacing screen SourceSpoke
>20:41:46,581 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:46,582 DBG simpleline: Processing screen ScreenData(SourceSpoke,network_install,False)
>20:41:46,585 DBG simpleline: Input is required by ScreenData(SourceSpoke,network_install,False) screen
>20:41:50,460 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:41:50,462 DBG simpleline: New signal InputReadySignal enqueued with source SourceSpoke
>20:41:50,463 DBG payload: Restarting payload thread
>20:41:50,464 INF threading: Running Thread: AnaPayloadRestartThread (140256462800640)
>20:41:50,465 DBG simpleline: New signal CloseScreenSignal enqueued with source SourceSpoke
>20:41:50,466 INF threading: Running Thread: AnaPayloadThread (140256351393536)
>20:41:50,466 DBG payload: Updating payload thread state: 0
>20:41:50,467 DBG payload: Updating payload thread state: 1
>20:41:50,467 INF threading: Thread Done: AnaPayloadRestartThread (140256462800640)
>20:41:50,468 DBG payload: Updating payload thread state: 2
>20:41:50,469 DBG payload: Updating payload thread state: 4
>20:41:50,470 DBG simpleline: Closing screen ScreenData(SourceSpoke,network_install,False) from SourceSpoke
>20:41:50,471 DBG simpleline: New signal RenderScreenSignal enqueued with source ScreenScheduler
>20:41:50,473 DBG simpleline: Processing screen ScreenData(SummaryHub,None,False)
>20:41:50,937 DBG exception: running handleException
>20:41:50,939 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/payload/__init__.py", line 1658, in _runThread
>    payload.updateBaseRepo(fallback=fallback, checkmount=checkmount)
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/dnfpayload.py", line 1029, in updateBaseRepo
>    self.reset()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/dnfpayload.py", line 1019, in reset
>    super().reset()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/__init__.py", line 1092, in reset
>    self.reset_install_device()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/__init__.py", line 1103, in reset_install_device
>    self.install_device.teardown(recursive=True)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/devices/storage.py", line 426, in teardown
>    if not self._pre_teardown(recursive=recursive):
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/devices/storage.py", line 412, in _pre_teardown
>    self.original_format.teardown()
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/formats/__init__.py", line 649, in teardown
>    self._teardown(**kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/formats/fs.py", line 611, in _teardown
>    raise FSError("umount of %s failed (%d)" % (mountpoint, rc))
>
>blivet.errors.FSError: umount of /run/install/source failed (32)
>
>20:41:51,138 DBG exception: Gtk cannot be initialized
>20:41:51,138 DBG exception: In a non-main thread, sending a message with exception data
>20:41:51,138 DBG simpleline: New signal ExceptionSignal enqueued with source ScreenScheduler
>20:41:51,138 INF threading: Thread Done: AnaPayloadThread (140256351393536)
>20:41:51,171 DBG simpleline: Input is required by ScreenData(SummaryHub,None,False) screen
>20:41:51,183 DBG simpleline: Executing inner loop
>20:41:51,184 DBG simpleline: New signal ExceptionSignal enqueued with source ScreenScheduler
>20:41:51,184 ERR ui.tui: 
>======= Screen stack =======
>----------- TOP ------------
>ScreenData(SummaryHub,None,False)
>ScreenData(ProgressSpoke,None,False)
>============================
>
>20:41:51,184 DBG exception: running handleException
>20:41:51,185 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/payload/__init__.py", line 1658, in _runThread
>    payload.updateBaseRepo(fallback=fallback, checkmount=checkmount)
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/dnfpayload.py", line 1029, in updateBaseRepo
>    self.reset()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/dnfpayload.py", line 1019, in reset
>    super().reset()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/__init__.py", line 1092, in reset
>    self.reset_install_device()
>
>  File "/usr/lib64/python3.6/site-packages/pyanaconda/payload/__init__.py", line 1103, in reset_install_device
>    self.install_device.teardown(recursive=True)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/devices/storage.py", line 426, in teardown
>    if not self._pre_teardown(recursive=recursive):
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/devices/storage.py", line 412, in _pre_teardown
>    self.original_format.teardown()
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/formats/__init__.py", line 649, in teardown
>    self._teardown(**kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/threads.py", line 53, in run_with_lock
>    return m(*args, **kwargs)
>
>  File "/usr/lib/python3.6/site-packages/blivet/formats/fs.py", line 611, in _teardown
>    raise FSError("umount of %s failed (%d)" % (mountpoint, rc))
>
>blivet.errors.FSError: umount of /run/install/source failed (32)
>
>20:41:51,185 DBG exception: Gtk cannot be initialized
>20:41:51,185 DBG exception: In the main thread, running exception handler
>20:41:52,727 INF core.util: Running kickstart %%onerror script(s)
>20:41:52,727 INF core.util: All kickstart %%onerror script(s) have been run
>20:41:52,727 INF kickstart.script: Running kickstart %%traceback script(s)
>20:41:52,727 INF kickstart.script: All kickstart %%traceback script(s) have been run
>20:41:52,733 WRN simpleline: Asking for multiple inputs with concurrent check bypassed, last who asked wins! Others are dropped.
>20:42:07,368 DBG simpleline: New signal InputReceivedSignal enqueued with source InputHandlerRequest
>20:42:07,369 DBG simpleline: New signal InputReadySignal enqueued with source TextIntf
>20:42:07,369 DBG simpleline: New signal InputReadySignal enqueued with source SummaryHub

Actions: View

Attachments on bug 1581891: 1440767 | 1440768 | 1440769 | 1440770 | 1440771 | 1440772 | 1440773 | 1440774 | 1440775 | 1440776 | 1440777 | 1440778 | 1440779 | 1440780 | 1440781 | 1440782