search

rhinstaller / kickstart-tests

Kickstart-driven tests for the Anaconda installer
53 stars 34 forks source link

stage2-from-ks failed on rhel10 with "Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached" #1202

Open rvykydal opened 1 month ago

rvykydal commented 1 month ago

05-27-2024

23:25:57,363 WARNING 55-scsi-sg3_id.rules:WARNING: SCSI device vda has no device ID, consider changing .SCSI_ID_SERIAL_SRC in 00-scsi-sg3_config.rules
23:25:57,430 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0
23:25:57,432 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.setup: vda3 ; orig: False ; status: True ; controllable: True ;
23:25:57,433 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                LVMPhysicalVolume.create: device: /dev/vda3 ; type: lvmpv ; status: False ;
23:25:57,435 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                  LVMPhysicalVolume._create: device: /dev/vda3 ; type: lvmpv ; status: False ;
23:25:57,435 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lvm filter: device /dev/vda3 added to the list of allowed devices
23:25:57,435 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lvm filter: clearing the lvm devices list
23:26:02,171 WARNING kernel:clocksource: Long readout interval, skipping watchdog check: cs_nsec: 4848600129 wd_nsec: 4848599758
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:ERROR:anaconda.modules.storage.installation:Failed to create storage layout: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 1243, in wrapped
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    ret = orig_obj(*args, **kwargs)
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:          ^^^^^^^^^^^^^^^^^^^^^^^^^
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 746, in lvm_pvcreate
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return _lvm_pvcreate(device, data_alignment, metadata_size, extra)
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:gi.repository.GLib.GError: g-io-error-quark: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached (24)
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:During handling of the above exception, another exception occurred:
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/formats/lvmpv.py", line 191, in _create
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    blockdev.lvm.pvcreate(self.device, data_alignment=self.data_alignment, extra=[ea_yes])
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 1265, in wrapped
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise transform[1](msg)
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:gi.overrides.BlockDev.LVMError: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:During handling of the above exception, another exception occurred:
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 83, in run
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._turn_on_filesystems(
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 163, in _turn_on_filesystems
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    storage.do_it(callbacks)
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/blivet.py", line 127, in do_it
23:26:05,529 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self.devicetree.actions.process(callbacks=callbacks, devices=self.devices, fstab=self.fstab)
23:26:05,532 WARNING brltty:unsupported generic resource identifier: bluetooth:
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/actionlist.py", line 46, in wrapped_func
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return func(obj, *args, **kwargs)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^^^^^^^^^
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/actionlist.py", line 303, in process
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    action.execute(callbacks)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/deviceaction.py", line 668, in execute
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self.device.format.create(device=self.device.path,
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/formats/__init__.py", line 517, in create
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._create(**kwargs)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/formats/lvmpv.py", line 193, in _create
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise PhysicalVolumeError(e)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:blivet.errors.PhysicalVolumeError: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:anaconda.core.threads:Thread Failed: AnaTaskThread-CreateStorageLayoutTask-1 (140650345400000)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:ERROR:anaconda.modules.common.task.task:Thread AnaTaskThread-CreateStorageLayoutTask-1 has failed: Traceback (most recent call last):
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 280, in run
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    threading.Thread.run(self)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/threading.py", line 1010, in run
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._target(*self._args, **self._kwargs)
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task.py", line 94, in _thread_run_callback
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._task_run_callback()
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task.py", line 107, in _task_run_callback
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._set_result(self.run())
23:26:05,532 WARNING org.fedoraproject.Anaconda.Modules.Storage:                     ^^^^^^^^^^
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 95, in run
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise StorageInstallationError(str(e)) from None
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:pyanaconda.modules.common.errors.installation.StorageInstallationError: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:anaconda.core.threads:Thread Done: AnaTaskThread-CreateStorageLayoutTask-1 (140650345400000)
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:WARNING:dasbus.server.handler:The call org.fedoraproject.Anaconda.Task.Finish has failed with an exception:
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/dasbus/server/handler.py", line 455, in _method_callback
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    result = self._handle_call(
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:             ^^^^^^^^^^^^^^^^^^
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/dasbus/server/handler.py", line 265, in _handle_call
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return handler(*parameters, **additional_args)
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task_interface.py", line 114, in Finish
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self.implementation.finish()
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task.py", line 173, in finish
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    thread_manager.raise_if_error(self._thread_name)
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 171, in raise_if_error
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise exc_info[1]
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 280, in run
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    threading.Thread.run(self)
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/threading.py", line 1010, in run
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._target(*self._args, **self._kwargs)
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task.py", line 94, in _thread_run_callback
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._task_run_callback()
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task.py", line 107, in _task_run_callback
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._set_result(self.run())
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:                     ^^^^^^^^^^
23:26:05,533 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 95, in run
23:26:05,534 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise StorageInstallationError(str(e)) from None
23:26:05,534 WARNING org.fedoraproject.Anaconda.Modules.Storage:pyanaconda.modules.common.errors.installation.StorageInstallationError: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached

virt-install.log

rvykydal commented 1 month ago

06-02-2024 virt-install.log classify script update: https://github.com/rhinstaller/kickstart-tests/pull/1216