[ovirt-devel] Vdsm build failure

[Piotr Kliczewski]

One more build failure:

10:25:47 Traceback (most recent call last):
10:25:47   File
"/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/monkeypatch.py",
line 133, in wrapper
10:25:47     return f(*args, **kw)
10:25:47   File
"/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/storage_iscsi_test.py",
line 39, in testWait
10:25:47     iscsi.rescan()
10:25:47   File "/usr/lib64/python2.7/contextlib.py", line 24, in __exit__
10:25:47     self.gen.next()
10:25:47   File
"/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/storage_iscsi_test.py",
line 34, in assertMaxDuration
10:25:47     (elapsed, maxtime))
10:25:47 AssertionError: Operation was too slow 0.32s > 0.30s

http://jenkins.ovirt.org/job/vdsm_master_check-patch-fc24-x86_64/4456/console

On Mon, Nov 14, 2016 at 2:37 PM, Piotr Kliczewski
<piotr.kliczewski at gmail.com> wrote:
> All,
>
> I see a build failure [1] due to:
>
> 13:34:32 FAIL: test_from_invalid_to_valid_domain('selftest', <type
> 'exceptions.OSError'>)
> (storage_monitor_test.TestMonitorThreadMonitoring)
> 13:34:32 ----------------------------------------------------------------------
> 13:34:32 Traceback (most recent call last):
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/testlib.py",
> line 133, in wrapper
> 13:34:32     return f(self, *args)
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/storage_monitor_test.py",
> line 470, in test_from_invalid_to_valid_domain
> 13:34:32     self.assertTrue(status.valid)
> 13:34:32 AssertionError: False is not true
> 13:34:32 -------------------- >> begin captured logging << --------------------
> 13:34:32 2016-11-14 13:33:04,968 DEBUG (monitor/uuid)
> [storage.Monitor] Domain monitor for uuid started (monitor:304)
> 13:34:32 2016-11-14 13:33:04,968 DEBUG (monitor/uuid)
> [storage.Monitor] Producing domain uuid (monitor:366)
> 13:34:32 2016-11-14 13:33:04,969 INFO  (monitor/uuid) [test] Start
> checking '/path/to/metadata' (storage_monitor_test:73)
> 13:34:32 2016-11-14 13:33:04,969 DEBUG (monitor/uuid) [test] Checking
> if iso domain (storage_monitor_test:156)
> 13:34:32 2016-11-14 13:33:04,969 ERROR (monitor/uuid)
> [storage.Monitor] Error checking domain uuid (monitor:426)
> 13:34:32 Traceback (most recent call last):
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/vdsm/storage/monitor.py",
> line 407, in _checkDomainStatus
> 13:34:32     self.domain.selftest()
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/testlib.py",
> line 616, in wrapper
> 13:34:32     raise exception
> 13:34:32 OSError
> 13:34:32 2016-11-14 13:33:04,969 INFO  (monitor/uuid)
> [storage.Monitor] Domain uuid became INVALID (monitor:456)
> 13:34:32 2016-11-14 13:33:04,969 DEBUG (monitor/uuid) [test] Emitting
> event (args=('uuid', False), kwrags={}) (storage_monitor_test:57)
> 13:34:32 2016-11-14 13:33:05,170 ERROR (monitor/uuid)
> [storage.Monitor] Error checking domain uuid (monitor:426)
> 13:34:32 Traceback (most recent call last):
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/vdsm/storage/monitor.py",
> line 407, in _checkDomainStatus
> 13:34:32     self.domain.selftest()
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/testlib.py",
> line 616, in wrapper
> 13:34:32     raise exception
> 13:34:32 OSError
> 13:34:32 2016-11-14 13:33:05,371 ERROR (monitor/uuid)
> [storage.Monitor] Error checking domain uuid (monitor:426)
> 13:34:32 Traceback (most recent call last):
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/vdsm/storage/monitor.py",
> line 407, in _checkDomainStatus
> 13:34:32     self.domain.selftest()
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/testlib.py",
> line 616, in wrapper
> 13:34:32     raise exception
> 13:34:32 OSError
> 13:34:32 2016-11-14 13:33:05,461 DEBUG (monitor/uuid)
> [storage.Monitor] Domain monitor for uuid canceled (monitor:309)
> 13:34:32 2016-11-14 13:33:05,461 DEBUG (monitor/uuid)
> [storage.Monitor] Domain monitor for uuid stopped (shutdown=False)
> (monitor:312)
> 13:34:32 2016-11-14 13:33:05,461 INFO  (monitor/uuid) [test] Stop
> checking '/path/to/metadata' (storage_monitor_test:79)
> 13:34:32 2016-11-14 13:33:05,461 DEBUG (monitor/uuid) [test] Releasing
> host id (hostId=host_id, unused=True) (storage_monitor_test:143)
> 13:34:32 2016-11-14 13:33:05,461 ERROR (monitor/uuid)
> [storage.Monitor] Error releasing host id host_id for domain uuid
> (monitor:568)
> 13:34:32 Traceback (most recent call last):
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/vdsm/storage/monitor.py",
> line 565, in _releaseHostId
> 13:34:32     self.domain.releaseHostId(self.hostId, unused=True)
> 13:34:32   File
> "/home/jenkins/workspace/vdsm_master_check-patch-fc24-x86_64/vdsm/tests/storage_monitor_test.py",
> line 146, in releaseHostId
> 13:34:32     assert self.acquired, "Attempt to release unacquired host id"
> 13:34:32 AssertionError: Attempt to release unacquired host id
>
> Can someone please take a look?
>
> Thanks,
> Piotr
>
> [1] http://jenkins.ovirt.org/job/vdsm_master_check-patch-fc24-x86_64/4123/console