Attachment 1703208 Details for Bug 1862784 – anaconda.log

anaconda.log

bug1862784_anaconda.log (text/plain), 21.14 KB, created by Chris Murphy on 2020-08-02 16:26:07 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Chris Murphy

Created: 2020-08-02 16:26:07 UTC

Size: 21.14 KB

patch

obsolete

>15:58:35,452 INF core.configuration.product: Loading information about products from /etc/anaconda/product.d.
>15:58:35,454 INF core.configuration.product: Found Scientific Linux at /etc/anaconda/product.d/scientific-linux.conf.
>15:58:35,454 INF core.configuration.product: Found oVirt Node Next at /etc/anaconda/product.d/ovirt.conf.
>15:58:35,455 INF core.configuration.product: Found Fedora Server at /etc/anaconda/product.d/fedora-server.conf.
>15:58:35,455 INF core.configuration.product: Found Fedora Silverblue at /etc/anaconda/product.d/fedora-silverblue.conf.
>15:58:35,456 INF core.configuration.product: Found Fedora-IoT IoT at /etc/anaconda/product.d/fedora-iot.conf.
>15:58:35,457 INF core.configuration.product: Found Fedora Workstation Live at /etc/anaconda/product.d/fedora-workstation-live.conf.
>15:58:35,457 INF core.configuration.product: Found Fedora at /etc/anaconda/product.d/fedora.conf.
>15:58:35,458 INF core.configuration.product: Found Red Hat Enterprise Linux at /etc/anaconda/product.d/rhel.conf.
>15:58:35,459 INF core.configuration.product: Found Red Hat Virtualization at /etc/anaconda/product.d/rhev.conf.
>15:58:35,459 INF core.configuration.product: Found CentOS Linux at /etc/anaconda/product.d/centos.conf.
>15:58:35,460 INF core.configuration.product: Found Fedora Workstation at /etc/anaconda/product.d/fedora-workstation.conf.
>15:58:35,460 INF core.configuration.product: The product Fedora Silverblue is supported.
>15:58:35,467 INF main: /sbin/anaconda 33.23-1.fc33
>15:58:35,492 WRN misc: /usr/lib64/python3.9/site-packages/dbus/connection.py:337: DeprecationWarning: invalid escape sequence \ 
>  """Arrange for the given function to be called when a signal matching
>
>15:58:35,497 WRN misc: /usr/lib64/python3.9/site-packages/dbus/proxies.py:307: DeprecationWarning: invalid escape sequence \ 
>  """Arrange for the given function to be called when the given signal
>
>15:58:36,962 INF isys: 3119304 kB (3046 MB) are available
>15:58:36,963 WRN misc: /usr/lib64/python3.9/subprocess.py:937: RuntimeWarning: line buffering (buffering=1) isn't supported in binary mode, the default buffer size will be used
>  self.stdout = io.open(c2pread, 'rb', bufsize)
>
>15:58:36,977 INF startup_utils: check_memory(): total:3046, needed:320, graphical:410
>15:58:36,978 INF startup_utils: Switching logging level to debug
>15:58:36,995 INF main: anaconda called with cmdline = ['/sbin/anaconda']
>15:58:36,995 INF main: Default encoding = utf-8 
>15:58:36,996 INF misc: Writing a temporary configuration loaded from: ['/etc/anaconda/anaconda.conf', '/etc/anaconda/product.d/fedora.conf', '/etc/anaconda/product.d/fedora-workstation.conf', '/etc/anaconda/product.d/fedora-workstation-live.conf', '/etc/anaconda/product.d/fedora-silverblue.conf', '/etc/anaconda/conf.d/00-do-nothing.conf', '/etc/anaconda/conf.d/01-still-do-nothing.conf']
>15:58:37,020 INF core.dbus: Connecting to the Anaconda bus at unix:abstract=/tmp/dbus-IdstuV8uAW,guid=fb9eb7747a1242bc3eba1de75f26e2ad.
>15:58:40,295 INF main: Found a kickstart file: /usr/share/anaconda/interactive-defaults.ks
>15:58:40,364 DBG addons: Loading ks section into module path for addon com_redhat_kdump
>15:58:40,364 DBG addons: Loading spokes into module path for addon com_redhat_kdump
>15:58:40,397 INF startup_utils: Parsing kickstart: /usr/share/anaconda/interactive-defaults.ks
>15:58:40,570 WRN kickstart: Command firstboot will be parsed in DBus module.
>15:58:40,572 WRN kickstart: Command firewall will be parsed in DBus module.
>15:58:40,600 DBG payload.flatpak: Configure flatpak for path /var/tmp/anaconda-flatpak-temp
>15:58:40,622 DBG localization: setting locale to: en_US.UTF-8
>15:58:40,642 DBG network: Initialization started.
>15:58:40,653 DBG network: Devices found: ['enp1s0']
>15:58:40,659 DBG network: Running task Consolidate initramfs connections
>15:58:40,665 DBG network: Consolidate initramfs connections result: []
>15:58:40,669 DBG network: Running task Apply kickstart
>15:58:40,675 DBG network: Apply kickstart result: []
>15:58:40,684 DBG network: Running task Dump missing ifcfg files
>15:58:41,695 DBG network: Dump missing ifcfg files result: ['enp1s0']
>15:58:41,700 DBG network: Running task Set real ONBOOT values from kickstart
>15:58:41,706 DBG network: Set real ONBOOT values from kickstart result: []
>15:58:41,707 DBG network: Creating network configurations.
>15:58:41,711 DBG network: Initialization finished.
>15:58:41,712 INF threading: Running Thread: AnaWaitForConnectingNMThread (140168127084096)
>15:58:41,713 DBG anaconda: setting display mode to GUI
>15:58:41,726 INF anaconda: Display mode is set to 'interactive graphical mode'.
>15:58:41,729 INF isys: 3119304 kB (3046 MB) are available
>15:58:41,730 WRN misc: /usr/lib64/python3.9/subprocess.py:937: RuntimeWarning: line buffering (buffering=1) isn't supported in binary mode, the default buffer size will be used
>  self.stdout = io.open(c2pread, 'rb', bufsize)
>
>15:58:41,737 INF network: got 0 NTP servers from DHCP
>15:58:41,737 INF startup_utils: check_memory(): total:3046, needed:320, graphical:410
>15:58:41,738 DBG core.util: Setting timeout 60 seconds for starting X.
>15:58:41,748 INF threading: Thread Done: AnaWaitForConnectingNMThread (140168127084096)
>15:58:44,175 DBG core.util: X server has signalled a successful start.
>15:58:44,785 INF display: Started spice-vdagent.
>15:58:45,466 DBG addons: Loading ks section into module path for addon com_redhat_kdump
>15:58:45,467 DBG addons: Loading spokes into module path for addon com_redhat_kdump
>15:58:45,612 DBG core.storage: LABEL=OEMDRV matches [] for devicetree=None and disks_only=True
>15:58:45,631 INF threading: Running Thread: AnaStorageThread (140168127084096)
>15:58:45,632 INF threading: Running Thread: AnaTimeInitThread (140168073344576)
>15:58:45,665 DBG payload.manager: Restarting payload thread
>15:58:45,666 INF threading: Running Thread: AnaPayloadRestartThread (140168064689728)
>15:58:45,666 INF geoloc: Geolocation is enabled.
>15:58:45,667 INF threading: Running Thread: AnaPayloadThread (140168056297024)
>15:58:45,667 DBG payload.manager: Updating payload thread state: STARTED
>15:58:45,667 DBG payload.manager: Updating payload thread state: WAITING_STORAGE
>15:58:45,667 INF threading: Thread Done: AnaPayloadRestartThread (140168064689728)
>15:58:45,668 INF threading: Running Thread: AnaGeolocationRefreshThread (140168047904320)
>15:58:45,668 INF geoloc: Starting geolocation lookup
>15:58:45,668 INF geoloc: Geolocation provider: Fedora GeoIP
>15:58:46,281 INF geoloc: Geolocation lookup finished in 0.6 seconds
>15:58:46,282 INF geoloc: got results from geolocation
>15:58:46,282 INF threading: Thread Done: AnaGeolocationRefreshThread (140168047904320)
>15:58:46,438 DBG ui.gui: Detected primary monitor: 1024x768 95dpix 96dpiy
>15:58:46,658 INF threading: Thread Done: AnaStorageThread (140168127084096)
>15:58:46,659 DBG payload.manager: Updating payload thread state: WAITING_NETWORK
>15:58:46,659 DBG payload.manager: Updating payload thread state: FINISHED
>15:58:46,659 INF threading: Thread Done: AnaPayloadThread (140168056297024)
>15:58:47,001 INF threading: Thread Done: AnaTimeInitThread (140168073344576)
>15:58:47,152 DBG localization: setting locale to: en_US.UTF-8
>15:58:47,177 DBG localization: setting locale to: en_US.UTF-8
>15:58:47,243 DBG ui.common: Entered spoke: WelcomeLanguageSpoke
>15:58:47,245 WRN misc: /usr/lib64/python3.9/site-packages/gi/overrides/Gdk.py:331: DeprecationWarning: Gdk.Cursor.new is deprecated
>  return cls.new(*args, **kwds)
>
>16:00:40,111 DBG core.util: This system doesn't support TAINT_HARDWARE_UNSUPPORTED.
>16:00:40,112 DBG core.util: This system doesn't support TAINT_SUPPORT_REMOVED.
>16:00:40,115 DBG localization: setting locale to: en_US.UTF-8
>16:00:40,134 INF ui.gui.spokes.welcome: using timezone determined by geolocation
>16:00:40,230 DBG ui.gui.spokes.network: network standalone spoke (init): completed: ['enp1s0']
>16:00:40,245 DBG ui.common: Left spoke: WelcomeLanguageSpoke
>16:00:40,255 INF ui.common: Spoke NetworkSpoke will not be displayed because it is hidden by the Anaconda configuration file.
>16:00:40,257 INF ui.common: Spoke PasswordSpoke will not be displayed because it is hidden by the Anaconda configuration file.
>16:00:40,257 INF ui.common: Spoke UserSpoke will not be displayed because it is hidden by the Anaconda configuration file.
>16:00:40,258 INF lifecycle: Adding controller: SummaryHub
>16:00:41,103 INF threading: Running Thread: AnaAddLayoutsInitThread (140168113796672)
>16:00:41,104 DBG ui.gui.utils: Starting applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f7b6a20c580>> on <list object at 0x7f7b69ff80c0>
>16:00:41,105 INF threading: Running Thread: AnaGtkBatchPre1 (140168073344576)
>16:00:41,108 INF threading: Thread Done: AnaGtkBatchPre1 (140168073344576)
>16:00:41,158 INF threading: Running Thread: AnaKeyboardThread (140168073344576)
>16:00:41,263 INF lifecycle: Module initialized: LangsupportSpoke
>16:00:41,808 INF threading: Running Thread: AnaDateTimeThread (140168056297024)
>16:00:41,890 INF ui.gui.spokes.software_selection: using environment from kickstart: None
>16:00:41,951 INF threading: Running Thread: AnaStorageWatcher (140168127084096)
>16:00:41,952 DBG ui.gui.hubs: incomplete spokes: [StorageSpoke]
>16:00:41,974 DBG ui.lib.storage: Selecting one or less disks by default: vda
>16:00:41,974 INF lifecycle: Module initialized: StorageSpoke
>16:00:41,975 INF threading: Thread Done: AnaStorageWatcher (140168127084096)
>16:00:41,986 INF lifecycle: Module initialized: CustomPartitioningSpoke
>16:00:42,021 INF lifecycle: Module initialized: BlivetGuiSpoke
>16:00:42,065 INF lifecycle: Module initialized: FilterSpoke
>16:00:42,066 INF lifecycle: Initialization of all modules (7) has been started.
>16:00:42,068 DBG ui.gui.hubs: Starting event loop for hub SummaryHub
>16:00:42,079 DBG ui.common: Entered hub: SummaryHub
>10:00:42,000 INF isys: System time set to Sun Aug  2 16:00:42 2020 UTC
>10:00:42,000 INF isys: System time set to Sun Aug  2 16:00:42 2020 UTC
>10:00:42,000 INF isys: System time set to Sun Aug  2 16:00:42 2020 UTC
>10:00:42,000 INF lifecycle: Module initialized: DatetimeSpoke
>10:00:42,001 INF threading: Thread Done: AnaDateTimeThread (140168056297024)
>10:00:42,009 DBG ui.gui.hubs: spoke is not ready: KeyboardSpoke
>10:00:42,009 DBG ui.gui.hubs: setting KeyboardSpoke status to: Getting list of layouts...
>10:00:42,009 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>10:00:42,010 DBG ui.gui.hubs: setting StorageSpoke status to: Probing storage...
>10:00:42,025 DBG ui.gui.hubs: spoke is ready: StorageSpoke
>10:00:42,034 DBG ui.gui.hubs: spoke is ready: DatetimeSpoke
>10:00:43,590 DBG ui.gui.utils: Finished applying <bound method AddLayoutDialog._addLayout of <pyanaconda.ui.gui.spokes.keyboard.AddLayoutDialog object at 0x7f7b6a20c580>> on <list object at 0x7f7b69ff80c0>
>10:00:43,591 INF threading: Thread Done: AnaAddLayoutsInitThread (140168113796672)
>10:00:43,592 INF lifecycle: Module initialized: KeyboardSpoke
>10:00:43,592 INF lifecycle: All modules have been initialized.
>10:00:43,592 INF threading: Thread Done: AnaKeyboardThread (140168073344576)
>10:00:43,615 DBG ui.gui.hubs: spoke is ready: KeyboardSpoke
>10:01:43,587 DBG ui.common: Entered spoke: StorageSpoke
>10:01:50,550 INF ui.gui.spokes.storage: Partitioning method has changed from AUTOMATIC to BLIVET.
>10:01:50,551 INF ui.gui.spokes.storage: Rolling back planed storage configuration changes.
>10:01:50,584 DBG ui.gui.spokes.storage: Skipping the execute method for the BLIVET partitioning method.
>10:01:50,585 DBG ui.common: Left spoke: StorageSpoke
>10:01:52,639 DBG ui.common: Entered spoke: BlivetGuiSpoke
>10:03:38,902 DBG ui.gui.spokes.blivet_gui: Generating updated storage configuration
>10:03:39,922 DBG ui.gui.spokes.blivet_gui: Checking storage configuration...
>10:03:40,940 DBG ui.gui.spokes.blivet_gui: Validation has been completed: ValidationReport(error_messages=[], warning_messages=[])
>10:03:46,978 WRN misc: /usr/lib64/python3.9/site-packages/gi/overrides/GObject.py:502: Warning: ../gobject/gsignal.c:2731: instance '0x55825f9bf3e0' has no handler with id '34653'
>  return func(*args, **kwargs)
>
>10:03:46,979 WRN misc: /usr/lib64/python3.9/site-packages/gi/overrides/GObject.py:502: Warning: ../gobject/gsignal.c:2731: instance '0x55825f9bf3e0' has no handler with id '34654'
>  return func(*args, **kwargs)
>
>10:03:46,979 DBG ui.common: Left spoke: BlivetGuiSpoke
>10:03:47,014 DBG ui.gui.hubs: incomplete spokes: []
>10:03:47,053 INF ui.lib.space: fs space: 84.5 GiB  needed: 2.46 GiB
>10:03:47,054 INF core.util: Skipping detection of SMT.
>10:03:49,258 DBG ui.common: Left hub: SummaryHub
>10:03:49,266 INF threading: Running Thread: AnaInstallThread (140168073344576)
>10:03:49,267 DBG ui.gui.spokes.installation_progress: The installation has started.
>10:03:49,272 DBG ui.common: Entered spoke: ProgressSpoke
>10:03:49,444 INF installation: Top-level task queue: Complete installation queue
>Number of task queues: 17
>Number of tasks: 41
>Task & task group listing:
> Task queue: Installation queue
>  Task: Save system time to HW clock
>  Task queue: Installation environment setup
>   Task: Setup addons
>   Task: Configure the runtime system
>  Task queue: Early storage configuration
>   Task: Activate filesystems
>   Task: Mount filesystems
>  Task queue: Pre-install scripts
>   Task: Run %pre-install scripts
>  Task queue: Pre install tasks
>   Task: Configure NTP service enablement
>   Task: Copy resolv.conf to sysroot
>   Task: Discover information about a realm
>   Task: Find additional packages & run pre_install()
>  Task queue: Payload installation
>   Task: Install the payload
>  Task queue: Late storage configuration
>   Task: Write the storage configuration
>  Task queue: Bootloader installation
>   Task: Install the bootloader
>  Task queue: Post-installation setup tasks
>   Task: Run post-installation setup tasks
> Task queue: Configuration queue
>  Task queue: Installed system configuration
>   Task: Configure SELinux
>   Task: Configure fingerprint authentication
>   Task: Authselect configuration
>   Task: Authconfig configuration
>   Task: Configure Initial Setup
>   Task: Configure post-installation tools
>   Task: Configure services
>   Task: Configure systemd default target
>   Task: Configure default desktop
>   Task: Configure time zone
>   Task: Configure NTP
>   Task: Configure language
>   Task: Configure keyboard
>   Task: Configure firewall
>   Task: Create groups
>   Task: Create users
>   Task: Configure root password
>   Task: Set SSH keys
>   Task: Configure optional root password SSH login
>  Task queue: Network configuration
>   Task: Network configuration
>  Task queue: User creation
>  Task queue: Anaconda addon configuration
>   Task: Configure Anaconda addons
>   Task: Install the system
>  Task queue: Initramfs generation
>   Task: Generate initramfs
>   Task: Rerun zipl
>  Task: Join a realm
>  Task queue: Post installation scripts
>   Task: Run post installation scripts
>  Task queue: Write configs and kickstarts
>   Task: Store kickstarts
>10:03:49,445 INF installation: Queue started: Installation queue (1/17)
>10:03:49,445 INF installation: Task started: Save system time to HW clock (1/41)
>10:03:49,502 INF progress: Save system time to HW clock
>10:03:49,502 DBG installation: Task completed: Save system time to HW clock (1/41) (0.1 s)
>10:03:49,503 INF progress: Setting up the installation environment
>10:03:49,503 INF installation: Queue started: Installation environment setup (2/17)
>10:03:49,503 INF installation: Task started: Setup addons (2/41)
>10:03:49,503 INF progress: Setting up com_redhat_kdump addon
>10:03:49,504 INF progress: Setup addons
>10:03:49,504 DBG installation: Task completed: Setup addons (2/41) (0.0 s)
>10:03:49,504 INF installation: Task started: Configure the runtime system (3/41)
>10:03:49,508 INF progress: Configure the runtime system
>10:03:49,509 DBG installation: Task completed: Configure the runtime system (3/41) (0.0 s)
>10:03:49,511 INF progress: Configuring storage
>10:03:49,512 INF installation: Queue started: Early storage configuration (3/17)
>10:03:49,512 INF installation: Task started: Activate filesystems (4/41)
>10:03:49,720 INF progress: Creating disklabel on /dev/vda
>10:03:50,224 INF progress: Creating ext4 on /dev/vda2
>10:03:50,361 INF progress: Creating efi on /dev/vda1
>10:03:51,529 INF progress: Activate filesystems
>10:03:51,530 DBG installation: Task completed: Activate filesystems (4/41) (2.0 s)
>10:03:51,530 INF installation: Task started: Mount filesystems (5/41)
>10:03:53,546 INF progress: Mount filesystems
>10:03:53,547 DBG installation: Task completed: Mount filesystems (5/41) (2.0 s)
>10:03:53,548 INF progress: Running pre-installation scripts
>10:03:53,548 INF installation: Queue started: Pre-install scripts (4/17)
>10:03:53,549 INF installation: Task started: Run %pre-install scripts (6/41)
>10:03:53,549 INF progress: Run %pre-install scripts
>10:03:53,549 DBG installation: Task completed: Run %pre-install scripts (6/41) (0.0 s)
>10:03:53,549 INF progress: Running pre-installation tasks
>10:03:53,550 INF installation: Queue started: Pre install tasks (5/17)
>10:03:53,550 INF installation: Task started: Configure NTP service enablement (7/41)
>10:03:54,563 INF progress: Configure NTP service enablement
>10:03:54,563 DBG installation: Task completed: Configure NTP service enablement (7/41) (1.0 s)
>10:03:54,564 INF installation: Task started: Copy resolv.conf to sysroot (8/41)
>10:03:54,566 INF progress: Copy resolv.conf to sysroot
>10:03:54,566 DBG installation: Task completed: Copy resolv.conf to sysroot (8/41) (0.0 s)
>10:03:54,566 INF installation: Task started: Discover information about a realm (9/41)
>10:03:54,571 INF progress: Discover information about a realm
>10:03:54,571 DBG installation: Task completed: Discover information about a realm (9/41) (0.0 s)
>10:03:54,571 INF installation: Task started: Find additional packages & run pre_install() (10/41)
>10:03:54,571 DBG payload.requirement: no group requirement added for language groups
>10:03:54,572 DBG payload.requirement: no package requirement added for langpacks
>10:03:54,578 DBG installation: Adding requirements for module org.fedoraproject.Anaconda.Modules.Security : [Requirement(name='authselect', reason='Needed by authselect kickstart command & for fingerprint authentication support.', type='package')]
>10:03:54,578 DBG payload.requirement: added package requirement 'authselect' for Needed by authselect kickstart command & for fingerprint authentication support., strong=True
>10:03:54,586 DBG installation: Adding requirements for module org.fedoraproject.Anaconda.Modules.Network : [Requirement(name='firewalld', reason='Requested by the firewall kickstart command.', type='package')]
>10:03:54,586 DBG payload.requirement: added package requirement 'firewalld' for Requested by the firewall kickstart command., strong=True
>10:03:54,595 DBG installation: Adding requirements for module org.fedoraproject.Anaconda.Modules.Timezone : [Requirement(name='chrony', reason='Needed to run NTP service.', type='package')]
>10:03:54,595 DBG payload.requirement: added package requirement 'chrony' for Needed to run NTP service., strong=True
>10:03:54,608 DBG installation: Adding requirements for module org.fedoraproject.Anaconda.Modules.Storage : [Requirement(name='e2fsprogs', reason='Required to manage storage devices.', type='package'), Requirement(name='dosfstools', reason='Required to manage storage devices.', type='package'), Requirement(name='grub2-efi-x64', reason='Necessary for the bootloader configuration.', type='package'), Requirement(name='shim-x64', reason='Necessary for the bootloader configuration.', type='package'), Requirement(name='efibootmgr', reason='Necessary for the bootloader configuration.', type='package'), Requirement(name='grub2-tools', reason='Necessary for the bootloader configuration.', type='package')]
>10:03:54,608 DBG payload.requirement: added package requirement 'e2fsprogs' for Required to manage storage devices., strong=True
>10:03:54,608 DBG payload.requirement: added package requirement 'dosfstools' for Required to manage storage devices., strong=True
>10:03:54,609 DBG payload.requirement: added package requirement 'grub2-efi-x64' for Necessary for the bootloader configuration., strong=True
>10:03:54,609 DBG payload.requirement: added package requirement 'shim-x64' for Necessary for the bootloader configuration., strong=True
>10:03:54,609 DBG payload.requirement: added package requirement 'efibootmgr' for Necessary for the bootloader configuration., strong=True
>10:03:54,609 DBG payload.requirement: added package requirement 'grub2-tools' for Necessary for the bootloader configuration., strong=True
>10:03:54,618 INF progress: Find additional packages & run pre_install()
>10:03:54,618 DBG installation: Task completed: Find additional packages & run pre_install() (10/41) (0.0 s)
>10:03:54,618 INF progress: Installing.
>10:03:54,618 INF installation: Queue started: Payload installation (6/17)
>10:03:54,619 INF installation: Task started: Install the payload (11/41)
>10:03:54,620 INF payload.rpmostreepayload: executing ostreesetup=<pykickstart.commands.ostreesetup.F21_OSTreeSetup object at 0x7f7b6fbdfb20>
>10:10:18,294 INF payload.rpmostreepayload: ostree pull: 11951 metadata, 113376 content objects imported; 0 bytes content written
>10:10:19,530 INF payload.rpmostreepayload: ostree admin deploy starting
>10:10:37,591 INF payload.rpmostreepayload: ostree admin deploy complete
>10:10:37,789 INF payload.rpmostreepayload: Copying bootloader data: efi
>10:10:37,837 INF payload.rpmostreepayload: Copying bootloader data: grub2

Actions: View

Attachments on bug 1862784: 1703208 | 1703209 | 1703210 | 1703211 | 1888173