rhinstaller / kickstart-tests

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

vlan-httpks flake on rhel8 "org.fedoraproject.Anaconda.Modules.Storage:blivet.errors.PhysicalVolumeError: Failed to call the 'PvCreate' method on the '/com/redhat/lvmdbus1/Manager' object: Timeout was reached" #1188

Open rvykydal opened 1 month ago

rvykydal commented 1 month ago

05-17-2024

23:23:48,175 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:blivet:executing action: [66] create format lvmpv on partition vda3 (id 62)
23:23:48,178 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 1 ;
23:23:48,180 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 2 ;
23:23:48,181 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 3 ;
23:23:48,181 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 4 ;
23:23:48,182 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 5 ;
23:23:48,183 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 8 ;
23:23:48,184 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 9 ;
23:23:48,185 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 10 ;
23:23:48,186 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 11 ;
23:23:48,186 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 12 ;
23:23:48,187 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 13 ;
23:23:48,188 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:                PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 14 ;

23:23:48,188 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 15 ; 23:23:48,189 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 16 ; 23:23:48,190 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 17 ; 23:23:48,192 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 18 ; 23:23:48,193 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 19 ; 23:23:48,195 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 20 ; 23:23:48,196 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 21 ; 23:23:48,197 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.unset_flag: path: /dev/vda3 ; flag: 22 ; 23:23:48,199 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.set_flag: path: /dev/vda3 ; flag: 6 ; 23:23:48,202 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: DiskLabel.commit_to_disk: device: /dev/vda ; numparts: 3 ; 23:23:48,233 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:program:Running... udevadm settle --timeout=300 23:23:48,300 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:23:48,372 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:program:Return code: 0 23:23:48,375 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: PartitionDevice.setup: vda3 ; orig: False ; status: True ; controllable: True ; 23:23:48,375 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: LVMPhysicalVolume.create: device: /dev/vda3 ; type: lvmpv ; status: False ; 23:23:48,381 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet: LVMPhysicalVolume._create: device: /dev/vda3 ; type: lvmpv ; status: False ; 23:23:48,383 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lvm filter: device /dev/vda3 added to the list of allowed devices 23:23:48,385 WARNING org.fedoraproject.Anaconda.Modules.Storage:DEBUG:blivet:lvm filter: clearing the lvm devices list 23:23:55,517 WARNING kernel:clocksource: Long readout interval, skipping watchdog check: cs_nsec: 7159348941 wd_nsec: 7159348559 23:23:55,673 WARNING brltty:unsupported generic resource identifier: bluetooth: 23:23:55,674 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:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last): 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 1243, in wrapped 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: ret = orig_obj(*args, kwargs) 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^^^^^^^^ 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 746, in lvm_pvcreate 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: return _lvm_pvcreate(device, data_alignment, metadata_size, extra) 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 23:23:55,674 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:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage:During handling of the above exception, another exception occurred: 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last): 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/formats/lvmpv.py", line 191, in _create 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: blockdev.lvm.pvcreate(self.device, data_alignment=self.data_alignment, extra=[ea_yes]) 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/gi/overrides/BlockDev.py", line 1265, in wrapped 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: raise transform1 23:23:55,674 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:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage:During handling of the above exception, another exception occurred: 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last): 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 83, in run 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._turn_on_filesystems( 23:23:55,674 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:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: storage.do_it(callbacks) 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: return m(*args, *kwargs) 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^ 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/blivet.py", line 127, in do_it 23:23:55,674 WARNING org.fedoraproject.Anaconda.Modules.Storage: self.devicetree.actions.process(callbacks=callbacks, devices=self.devices, fstab=self.fstab) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/actionlist.py", line 46, in wrapped_func 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: return func(obj, args, kwargs) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^^^^^^^^^ 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/actionlist.py", line 303, in process 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: action.execute(callbacks) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: return m(*args, kwargs) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^ 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/deviceaction.py", line 668, in execute 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: self.device.format.create(device=self.device.path, 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: return m(args, kwargs) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^ 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/formats/init.py", line 517, in create 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._create(kwargs) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/threads.py", line 49, in run_with_lock 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: return m(args, kwargs) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^ 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/blivet/formats/lvmpv.py", line 193, in _create 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: raise PhysicalVolumeError(e) 23:23:55,676 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:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:anaconda.core.threads:Thread Failed: AnaTaskThread-CreateStorageLayoutTask-1 (140612892362432) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage:ERROR:anaconda.modules.common.task.task:Thread AnaTaskThread-CreateStorageLayoutTask-1 has failed: Traceback (most recent call last): 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 280, in run 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: threading.Thread.run(self) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/threading.py", line 1010, in run 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._target(*self._args, self._kwargs) 23:23:55,676 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:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._task_run_callback() 23:23:55,676 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:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._set_result(self.run()) 23:23:55,676 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^ 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 95, in run 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: raise StorageInstallationError(str(e)) from None 23:24:02,357 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:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage:INFO:anaconda.core.threads:Thread Done: AnaTaskThread-CreateStorageLayoutTask-1 (140612892362432) 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage:WARNING:dasbus.server.handler:The call org.fedoraproject.Anaconda.Task.Finish has failed with an exception: 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage:Traceback (most recent call last): 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/dasbus/server/handler.py", line 455, in _method_callback 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: result = self._handle_call( 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^ 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib/python3.12/site-packages/dasbus/server/handler.py", line 265, in _handle_call 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: return handler(*parameters, *additional_args) 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 23:24:02,357 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:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: self.implementation.finish() 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/common/task/task.py", line 173, in finish 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: thread_manager.raise_if_error(self._thread_name) 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 171, in raise_if_error 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: raise exc_info[1] 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/core/threads.py", line 280, in run 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: threading.Thread.run(self) 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/threading.py", line 1010, in run 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._target(self._args, self._kwargs) 23:24:02,357 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:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._task_run_callback() 23:24:02,357 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:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: self._set_result(self.run()) 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: ^^^^^^^^^^ 23:24:02,357 WARNING org.fedoraproject.Anaconda.Modules.Storage: File "/usr/lib64/python3.12/site-packages/pyanaconda/modules/storage/installation.py", line 95, in run 23:24:02,365 WARNING brltty:unsupported generic resource identifier: bluetooth: 23:24:02,365 WARNING org.fedoraproject.Anaconda.Modules.Storage: raise StorageInstallationError(str(e)) from None 23:24:02,365 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](https://github.com/rhinstaller/kickstart-tests/files/15374768/virt-install.log)