search

rhinstaller / kickstart-tests

Kickstart-driven tests for the Anaconda installer
55 stars 35 forks source link

lvm-thinp-1 flake on rhel10 - timeout with "org.fedoraproject.Anaconda.Modules.Storage:blivet.errors.LVMError: Failed to call the 'LvCreate' method on the '/com/redhat/lvmdbus1/ThinPool/0' object: Timeout was reached" #1284

Open rvykydal opened 3 weeks ago

rvykydal commented 3 weeks ago 
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:ERROR:anaconda.modules.storage.installation:Failed to create storage layout: Failed to call the 'LvCreate' method on the '/com/redhat/lvmdbus1/ThinPool/0' object: Timeout was reached
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 1243, in wrapped
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    ret = orig_obj(*args, **kwargs)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:          ^^^^^^^^^^^^^^^^^^^^^^^^^
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:gi.repository.GLib.GError: g-io-error-quark: Failed to call the 'LvCreate' method on the '/com/redhat/lvmdbus1/ThinPool/0' object: Timeout was reached (24)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:During handling of the above exception, another exception occurred:
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/devices/lvm.py", line 1936, in _create
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    blockdev.lvm.thlvcreate(self.vg.name, self.pool.lvname, self.lvname,
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 1265, in wrapped
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise transform[1](msg)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:gi.overrides.BlockDev.LVMError: Failed to call the 'LvCreate' method on the '/com/redhat/lvmdbus1/ThinPool/0' object: Timeout was reached
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:During handling of the above exception, another exception occurred:
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last):
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 83, in run
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._turn_on_filesystems(
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 163, in _turn_on_filesystems
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    storage.do_it(callbacks)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/blivet.py", line 127, in do_it
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self.devicetree.actions.process(callbacks=callbacks, devices=self.devices, fstab=self.fstab)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/actionlist.py", line 46, in wrapped_func
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return func(obj, *args, **kwargs)
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^^^^^^^^^
01:06:00,518 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/actionlist.py", line 303, in process
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    action.execute(callbacks)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/deviceaction.py", line 330, in execute
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self.device.create()
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/devices/storage.py", line 524, in create
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._create()
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/devices/lvm.py", line 2594, in decorated
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    found, ret = self._try_specific_call(meth.__name__, *args, **kwargs)  # pylint: disable=no-member
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    return m(*args, **kwargs)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:           ^^^^^^^^^^^^^^^^^^
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/devices/lvm.py", line 2579, in _try_specific_call
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    ret = getattr(cls, name)(self, *args, **kwargs)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:          ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib/python3.12/site-packages/blivet/devices/lvm.py", line 1939, in _create
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise errors.LVMError(err)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:blivet.errors.LVMError: Failed to call the 'LvCreate' method on the '/com/redhat/lvmdbus1/ThinPool/0' object: Timeout was reached
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:anaconda.core.threads:Thread Failed: AnaTaskThread-CreateStorageLayoutTask-1 (139827653641920)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:ERROR:anaconda.modules.common.task.task:Thread AnaTaskThread-CreateStorageLayoutTask-1 has failed: Traceback (most recent call last):
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 280, in run
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    threading.Thread.run(self)
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/threading.py", line 1010, in run
01:06:00,526 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._target(*self._args, **self._kwargs)
01:06:00,527 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
01:06:00,527 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._task_run_callback()
01:06:00,527 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
01:06:00,527 WARNING org.fedoraproject.Anaconda.Modules.Storage:    self._set_result(self.run())
01:06:00,527 WARNING org.fedoraproject.Anaconda.Modules.Storage:                     ^^^^^^^^^^
01:06:00,527 WARNING org.fedoraproject.Anaconda.Modules.Storage:  File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 95, in run
01:06:00,527 WARNING org.fedoraproject.Anaconda.Modules.Storage:    raise StorageInstallationError(str(e)) from None
01:06:00,527 WARNING org.fedoraproject.Anaconda.Modules.Storage:pyanaconda.modules.common.errors.installation.StorageInstallationError: Failed to call the 'LvCreate' method on the '/com/redhat/lvmdbus1/ThinPool/0' object: Timeout was reached

kstest.log virt-install.log

rvykydal commented 3 weeks ago

Seems to be related to https://github.com/rhinstaller/kickstart-tests/issues/1257