Project: http://jenkins.ovirt.org/job/ovirt-system-tests_he-node-ng-suite-4.2/ Build: http://jenkins.ovirt.org/job/ovirt-system-tests_he-node-ng-suite-4.2/384/ Build Number: 384 Build Status: Still Failing Triggered By: Started by timer ------------------------------------- Changes Since Last Success: ------------------------------------- Changes for Build #354 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #355 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #356 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #357 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #358 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #359 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #360 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #361 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #362 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" [Sandro Bonazzola] ovirt-setup-lib: drop 3.6 [Sandro Bonazzola] ovirt-host: drop 3.6 and 4.1 Changes for Build #363 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #364 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #365 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" [Sandro Bonazzola] ovirt-reports: drop 3.6 jobs [Sandro Bonazzola] ovirt-host-deploy: drop 3.6 jobs Changes for Build #366 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #367 [Miguel Duarte Barroso] Revert "Repos: add python2-ovsdbapp to the reposync config" Changes for Build #368 [Gal Ben Haim] Remove stale url to the internal repo [Greg Sheremeta] add ovirt-web-ui to stdci v2 Changes for Build #369 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #370 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #371 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #372 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #373 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #374 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #375 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #376 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #377 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #378 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #379 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #380 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #381 [Gal Ben Haim] Remove stale url to the internal repo Changes for Build #382 [Eitan Raviv] networking: retrieve ipv6 of lago engine VM Changes for Build #383 [Eitan Raviv] networking: retrieve ipv6 of lago engine VM Changes for Build #384 [Eitan Raviv] networking: retrieve ipv6 of lago engine VM ----------------- Failed Tests: ----------------- 1 tests failed. FAILED: 010_local_maintenance_cli.local_maintenance Error Message: 143 -------------------- >> begin captured logging << -------------------- root: INFO: * Waiting For System Stability... lago.ssh: DEBUG: start task:3c73e9c4-b309-40fb-b1fa-ed36da927d07:Get ssh client for lago-he-node-ng-suite-4-2-host-1: lago.ssh: DEBUG: end task:3c73e9c4-b309-40fb-b1fa-ed36da927d07:Get ssh client for lago-he-node-ng-suite-4-2-host-1: lago.ssh: DEBUG: Running 24a15502 on lago-he-node-ng-suite-4-2-host-1: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 24a15502 on lago-he-node-ng-suite-4-2-host-1 returned with 0 lago.ssh: DEBUG: Command 24a15502 on lago-he-node-ng-suite-4-2-host-1 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4217 (Tue Oct 9 01:39:06 2018)\nhost-id=1\nscore=3400\nvm_conf_refresh_time=4217 (Tue Oct 9 01:39:06 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineUp\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Up"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "43ec0e80", "local_conf_timestamp": 4217, "host-ts": 4217}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4225 (Tue Oct 9 01:39:13 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4225 (Tue Oct 9 01:39:14 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "117d4e09", "local_conf_timestamp": 4225, "host-ts": 4225}, "global_maintenance": false} lago.ssh: DEBUG: start task:1fcdbfe0-01de-40ae-bf85-7a17775da330:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:1fcdbfe0-01de-40ae-bf85-7a17775da330:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 25aded20 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --set-maintenance --mode=local lago.ssh: DEBUG: Command 25aded20 on lago-he-node-ng-suite-4-2-host-0 returned with 0 root: INFO: * Waiting for engine to migrate... lago.ssh: DEBUG: start task:f3a614d4-1caf-4671-8ebc-2dfde68a8388:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:f3a614d4-1caf-4671-8ebc-2dfde68a8388:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 26c47904 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 26c47904 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 26c47904 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4227 (Tue Oct 9 01:39:16 2018)\nhost-id=1\nscore=3400\nvm_conf_refresh_time=4227 (Tue Oct 9 01:39:16 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineUp\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Up"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "fc34c880", "local_conf_timestamp": 4227, "host-ts": 4227}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4225 (Tue Oct 9 01:39:13 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4225 (Tue Oct 9 01:39:14 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "117d4e09", "local_conf_timestamp": 4225, "host-ts": 4225}, "global_maintenance": false} lago.ssh: DEBUG: start task:9fcf021e-6d26-468f-b607-a3670ee1eaaf:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:9fcf021e-6d26-468f-b607-a3670ee1eaaf:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 2e05fc88 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 2e05fc88 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 2e05fc88 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4247 (Tue Oct 9 01:39:36 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4248 (Tue Oct 9 01:39:36 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "67b39f04", "local_conf_timestamp": 4248, "host-ts": 4247}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4245 (Tue Oct 9 01:39:34 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4245 (Tue Oct 9 01:39:34 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7fd6798f", "local_conf_timestamp": 4245, "host-ts": 4245}, "global_maintenance": false} lago.ssh: DEBUG: start task:f01bca9b-8543-4d58-939b-b3e24fff320b:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:f01bca9b-8543-4d58-939b-b3e24fff320b:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 30f91402 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 30f91402 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 30f91402 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4247 (Tue Oct 9 01:39:36 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4248 (Tue Oct 9 01:39:36 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "67b39f04", "local_conf_timestamp": 4248, "host-ts": 4247}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4245 (Tue Oct 9 01:39:34 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4245 (Tue Oct 9 01:39:34 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7fd6798f", "local_conf_timestamp": 4245, "host-ts": 4245}, "global_maintenance": false} lago.ssh: DEBUG: start task:1cd91097-ce30-425f-856c-73f7581cc7bf:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:1cd91097-ce30-425f-856c-73f7581cc7bf:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 34323e5a on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 34323e5a on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 34323e5a on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4257 (Tue Oct 9 01:39:46 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4257 (Tue Oct 9 01:39:46 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "593fbc57", "local_conf_timestamp": 4257, "host-ts": 4257}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4255 (Tue Oct 9 01:39:44 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4255 (Tue Oct 9 01:39:44 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7b90868a", "local_conf_timestamp": 4255, "host-ts": 4255}, "global_maintenance": false} lago.ssh: DEBUG: start task:3aa0fe5c-5836-4e7b-9c7b-8aa0d676807d:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:3aa0fe5c-5836-4e7b-9c7b-8aa0d676807d:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 371b6650 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 371b6650 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 371b6650 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4257 (Tue Oct 9 01:39:46 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4257 (Tue Oct 9 01:39:46 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "593fbc57", "local_conf_timestamp": 4257, "host-ts": 4257}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4255 (Tue Oct 9 01:39:44 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4255 (Tue Oct 9 01:39:44 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7b90868a", "local_conf_timestamp": 4255, "host-ts": 4255}, "global_maintenance": false} lago.ssh: DEBUG: start task:cb267a07-39bb-4c78-aca2-d1d0652d6c7f:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:cb267a07-39bb-4c78-aca2-d1d0652d6c7f:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 3a5cb1b6 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 3a5cb1b6 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 3a5cb1b6 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4267 (Tue Oct 9 01:39:56 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4267 (Tue Oct 9 01:39:56 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "701bf950", "local_conf_timestamp": 4267, "host-ts": 4267}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4265 (Tue Oct 9 01:39:53 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4265 (Tue Oct 9 01:39:53 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "775b8785", "local_conf_timestamp": 4265, "host-ts": 4265}, "global_maintenance": false} lago.ssh: DEBUG: start task:1da66f14-fc55-4fdf-a10f-bbd07b7dc01e:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:1da66f14-fc55-4fdf-a10f-bbd07b7dc01e:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 3d5da38e on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 3d5da38e on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 3d5da38e on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4267 (Tue Oct 9 01:39:56 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4267 (Tue Oct 9 01:39:56 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "701bf950", "local_conf_timestamp": 4267, "host-ts": 4267}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4265 (Tue Oct 9 01:39:53 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4265 (Tue Oct 9 01:39:53 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "775b8785", "local_conf_timestamp": 4265, "host-ts": 4265}, "global_maintenance": false} lago.ssh: DEBUG: start task:489d8ae3-b227-4acc-8a31-9d0574f90918:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:489d8ae3-b227-4acc-8a31-9d0574f90918:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 40834a0a on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 40834a0a on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 40834a0a on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4277 (Tue Oct 9 01:40:06 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4277 (Tue Oct 9 01:40:06 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "de28c792", "local_conf_timestamp": 4277, "host-ts": 4277}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4275 (Tue Oct 9 01:40:04 2018)\nhost-id=2\nscore=3000\nvm_conf_refresh_time=4275 (Tue Oct 9 01:40:04 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "c039a00e", "local_conf_timestamp": 4275, "host-ts": 4275}, "global_maintenance": false} lago.ssh: DEBUG: start task:55a1f1ed-a80e-4e19-87b5-1e32bc97e4c1:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:55a1f1ed-a80e-4e19-87b5-1e32bc97e4c1:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 439d8a48 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 439d8a48 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 439d8a48 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4277 (Tue Oct 9 01:40:06 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4277 (Tue Oct 9 01:40:06 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "de28c792", "local_conf_timestamp": 4277, "host-ts": 4277}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4275 (Tue Oct 9 01:40:04 2018)\nhost-id=2\nscore=3000\nvm_conf_refresh_time=4275 (Tue Oct 9 01:40:04 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "c039a00e", "local_conf_timestamp": 4275, "host-ts": 4275}, "global_maintenance": false} lago.ssh: DEBUG: start task:7268f134-03c9-456b-b9a5-042f135adc89:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:7268f134-03c9-456b-b9a5-042f135adc89:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 46bdf672 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 46bdf672 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 46bdf672 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4287 (Tue Oct 9 01:40:16 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4287 (Tue Oct 9 01:40:16 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "539d9689", "local_conf_timestamp": 4287, "host-ts": 4287}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4285 (Tue Oct 9 01:40:14 2018)\nhost-id=2\nscore=3000\nvm_conf_refresh_time=4285 (Tue Oct 9 01:40:14 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "ffdea53d", "local_conf_timestamp": 4285, "host-ts": 4285}, "global_maintenance": false} lago.ssh: DEBUG: start task:5b5ddba0-e48c-4425-b001-ee2a99288230:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:5b5ddba0-e48c-4425-b001-ee2a99288230:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 4a0f5500 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 4a0f5500 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 4a0f5500 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4287 (Tue Oct 9 01:40:16 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4287 (Tue Oct 9 01:40:16 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineMigratingAway\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "539d9689", "local_conf_timestamp": 4287, "host-ts": 4287}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4285 (Tue Oct 9 01:40:14 2018)\nhost-id=2\nscore=3000\nvm_conf_refresh_time=4285 (Tue Oct 9 01:40:14 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "ffdea53d", "local_conf_timestamp": 4285, "host-ts": 4285}, "global_maintenance": false} lago.ssh: DEBUG: start task:2ce66497-456f-4e57-a3f8-fcf8117a4263:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:2ce66497-456f-4e57-a3f8-fcf8117a4263:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 4d2c78c6 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 4d2c78c6 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 4d2c78c6 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4297 (Tue Oct 9 01:40:26 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4297 (Tue Oct 9 01:40:26 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"reason": "VM migrated away successfully", "health": "bad", "vm": "down", "detail": "Down"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "4722e013", "local_conf_timestamp": 4297, "host-ts": 4297}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4295 (Tue Oct 9 01:40:24 2018)\nhost-id=2\nscore=3000\nvm_conf_refresh_time=4295 (Tue Oct 9 01:40:24 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "fb985a38", "local_conf_timestamp": 4295, "host-ts": 4295}, "global_maintenance": false} lago.ssh: DEBUG: start task:2c93f2a0-8500-4528-a7ed-702eaef4866b:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:2c93f2a0-8500-4528-a7ed-702eaef4866b:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 4e3af0b2 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 4e3af0b2 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 4e3af0b2 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4297 (Tue Oct 9 01:40:26 2018)\nhost-id=1\nscore=3000\nvm_conf_refresh_time=4297 (Tue Oct 9 01:40:26 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"reason": "VM migrated away successfully", "health": "bad", "vm": "down", "detail": "Down"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "4722e013", "local_conf_timestamp": 4297, "host-ts": 4297}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4295 (Tue Oct 9 01:40:24 2018)\nhost-id=2\nscore=3000\nvm_conf_refresh_time=4295 (Tue Oct 9 01:40:24 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineDown\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "fb985a38", "local_conf_timestamp": 4295, "host-ts": 4295}, "global_maintenance": false} lago.ssh: DEBUG: start task:dba870a3-6461-4e57-8b68-fb5174d97dd7:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: end task:dba870a3-6461-4e57-8b68-fb5174d97dd7:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: Running 554af398 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json lago.ssh: DEBUG: Command 554af398 on lago-he-node-ng-suite-4-2-host-0 returned with 0 lago.ssh: DEBUG: Command 554af398 on lago-he-node-ng-suite-4-2-host-0 output: {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4307 (Tue Oct 9 01:40:35 2018)\nhost-id=1\nscore=0\nvm_conf_refresh_time=4307 (Tue Oct 9 01:40:36 2018)\nconf_on_shared_storage=True\nmaintenance=True\nstate=LocalMaintenance\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"}, "score": 0, "stopped": false, "maintenance": true, "crc32": "3ab38b8d", "local_conf_timestamp": 4307, "host-ts": 4307}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\nmetadata_feature_version=1\ntimestamp=4305 (Tue Oct 9 01:40:33 2018)\nhost-id=2\nscore=3400\nvm_conf_refresh_time=4305 (Tue Oct 9 01:40:34 2018)\nconf_on_shared_storage=True\nmaintenance=False\nstate=EngineUp\nstopped=False\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"health": "good", "vm": "up", "detail": "Up"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "9edda5b0", "local_conf_timestamp": 4305, "host-ts": 4305}, "global_maintenance": false} root: INFO: * Engine has migrated. root: INFO: * Waiting For System Stability... lago.ssh: DEBUG: start task:e6633f02-b230-430f-9359-24fe2f4a7b4b:Get ssh client for lago-he-node-ng-suite-4-2-host-0: cli: DEBUG: signal 15 was caught root: ERROR: end task:e6633f02-b230-430f-9359-24fe2f4a7b4b:Get ssh client for lago-he-node-ng-suite-4-2-host-0: lago.ssh: DEBUG: File "/usr/lib/python2.7/site-packages/lago/ssh.py", line 360, in get_ssh_client timeout=ssh_timeout, File "/usr/lib/python2.7/site-packages/paramiko/client.py", line 338, in connect t.start_client(timeout=timeout) File "/usr/lib/python2.7/site-packages/paramiko/transport.py", line 496, in start_client event.wait(0.1) File "/usr/lib64/python2.7/threading.py", line 622, in wait self.__cond.wait(timeout, balancing) File "/usr/lib64/python2.7/threading.py", line 362, in wait _sleep(delay) File "/usr/lib/python2.7/site-packages/lago/cmd.py", line 922, in exit_handler sys.exit(128 + signum) --------------------- >> end captured logging << --------------------- Stack Trace: File "/usr/lib64/python2.7/unittest/case.py", line 369, in run testMethod() File "/usr/lib/python2.7/site-packages/nose/case.py", line 197, in runTest self.test(*self.arg) File "/usr/lib/python2.7/site-packages/ovirtlago/testlib.py", line 142, in wrapped_test test() File "/usr/lib/python2.7/site-packages/ovirtlago/testlib.py", line 60, in wrapper return func(get_test_prefix(), *args, **kwargs) File "/home/jenkins/workspace/ovirt-system-tests_he-node-ng-suite-4.2/ovirt-system-tests/he-node-ng-suite-4.2/test-scenarios/010_local_maintenance_cli.py", line 127, in local_maintenance ret = host.ssh(["hosted-engine", "--set-maintenance", "--mode=none"]) File "/usr/lib/python2.7/site-packages/lago/plugins/vm.py", line 529, in ssh password=self._spec.get('ssh-password'), File "/usr/lib/python2.7/site-packages/lago/ssh.py", line 46, in ssh password=password, File "/usr/lib/python2.7/site-packages/lago/ssh.py", line 360, in get_ssh_client timeout=ssh_timeout, File "/usr/lib/python2.7/site-packages/paramiko/client.py", line 338, in connect t.start_client(timeout=timeout) File "/usr/lib/python2.7/site-packages/paramiko/transport.py", line 496, in start_client event.wait(0.1) File "/usr/lib64/python2.7/threading.py", line 622, in wait self.__cond.wait(timeout, balancing) File "/usr/lib64/python2.7/threading.py", line 362, in wait _sleep(delay) File "/usr/lib/python2.7/site-packages/lago/cmd.py", line 922, in exit_handler sys.exit(128 + signum) '143\n-------------------- >> begin captured logging << --------------------\nroot: INFO: * Waiting For System Stability...\nlago.ssh: DEBUG: start task:3c73e9c4-b309-40fb-b1fa-ed36da927d07:Get ssh client for lago-he-node-ng-suite-4-2-host-1:\nlago.ssh: DEBUG: end task:3c73e9c4-b309-40fb-b1fa-ed36da927d07:Get ssh client for lago-he-node-ng-suite-4-2-host-1:\nlago.ssh: DEBUG: Running 24a15502 on lago-he-node-ng-suite-4-2-host-1: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 24a15502 on lago-he-node-ng-suite-4-2-host-1 returned with 0\nlago.ssh: DEBUG: Command 24a15502 on lago-he-node-ng-suite-4-2-host-1 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4217 (Tue Oct 9 01:39:06 2018)\\nhost-id=1\\nscore=3400\\nvm_conf_refresh_time=4217 (Tue Oct 9 01:39:06 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineUp\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Up"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "43ec0e80", "local_conf_timestamp": 4217, "host-ts": 4217}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4225 (Tue Oct 9 01:39:13 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4225 (Tue Oct 9 01:39:14 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "117d4e09", "local_conf_timestamp": 4225, "host-ts": 4225}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:1fcdbfe0-01de-40ae-bf85-7a17775da330:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:1fcdbfe0-01de-40ae-bf85-7a17775da330:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 25aded20 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --set-maintenance --mode=local\nlago.ssh: DEBUG: Command 25aded20 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nroot: INFO: * Waiting for engine to migrate...\nlago.ssh: DEBUG: start task:f3a614d4-1caf-4671-8ebc-2dfde68a8388:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:f3a614d4-1caf-4671-8ebc-2dfde68a8388:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 26c47904 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 26c47904 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 26c47904 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4227 (Tue Oct 9 01:39:16 2018)\\nhost-id=1\\nscore=3400\\nvm_conf_refresh_time=4227 (Tue Oct 9 01:39:16 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineUp\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Up"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "fc34c880", "local_conf_timestamp": 4227, "host-ts": 4227}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4225 (Tue Oct 9 01:39:13 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4225 (Tue Oct 9 01:39:14 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "117d4e09", "local_conf_timestamp": 4225, "host-ts": 4225}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:9fcf021e-6d26-468f-b607-a3670ee1eaaf:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:9fcf021e-6d26-468f-b607-a3670ee1eaaf:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 2e05fc88 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 2e05fc88 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 2e05fc88 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4247 (Tue Oct 9 01:39:36 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4248 (Tue Oct 9 01:39:36 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "67b39f04", "local_conf_timestamp": 4248, "host-ts": 4247}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4245 (Tue Oct 9 01:39:34 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4245 (Tue Oct 9 01:39:34 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7fd6798f", "local_conf_timestamp": 4245, "host-ts": 4245}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:f01bca9b-8543-4d58-939b-b3e24fff320b:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:f01bca9b-8543-4d58-939b-b3e24fff320b:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 30f91402 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 30f91402 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 30f91402 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4247 (Tue Oct 9 01:39:36 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4248 (Tue Oct 9 01:39:36 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "67b39f04", "local_conf_timestamp": 4248, "host-ts": 4247}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4245 (Tue Oct 9 01:39:34 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4245 (Tue Oct 9 01:39:34 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7fd6798f", "local_conf_timestamp": 4245, "host-ts": 4245}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:1cd91097-ce30-425f-856c-73f7581cc7bf:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:1cd91097-ce30-425f-856c-73f7581cc7bf:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 34323e5a on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 34323e5a on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 34323e5a on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4257 (Tue Oct 9 01:39:46 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4257 (Tue Oct 9 01:39:46 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "593fbc57", "local_conf_timestamp": 4257, "host-ts": 4257}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4255 (Tue Oct 9 01:39:44 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4255 (Tue Oct 9 01:39:44 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7b90868a", "local_conf_timestamp": 4255, "host-ts": 4255}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:3aa0fe5c-5836-4e7b-9c7b-8aa0d676807d:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:3aa0fe5c-5836-4e7b-9c7b-8aa0d676807d:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 371b6650 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 371b6650 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 371b6650 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4257 (Tue Oct 9 01:39:46 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4257 (Tue Oct 9 01:39:46 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "593fbc57", "local_conf_timestamp": 4257, "host-ts": 4257}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4255 (Tue Oct 9 01:39:44 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4255 (Tue Oct 9 01:39:44 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "7b90868a", "local_conf_timestamp": 4255, "host-ts": 4255}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:cb267a07-39bb-4c78-aca2-d1d0652d6c7f:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:cb267a07-39bb-4c78-aca2-d1d0652d6c7f:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 3a5cb1b6 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 3a5cb1b6 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 3a5cb1b6 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4267 (Tue Oct 9 01:39:56 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4267 (Tue Oct 9 01:39:56 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "701bf950", "local_conf_timestamp": 4267, "host-ts": 4267}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4265 (Tue Oct 9 01:39:53 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4265 (Tue Oct 9 01:39:53 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "775b8785", "local_conf_timestamp": 4265, "host-ts": 4265}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:1da66f14-fc55-4fdf-a10f-bbd07b7dc01e:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:1da66f14-fc55-4fdf-a10f-bbd07b7dc01e:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 3d5da38e on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 3d5da38e on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 3d5da38e on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4267 (Tue Oct 9 01:39:56 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4267 (Tue Oct 9 01:39:56 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "701bf950", "local_conf_timestamp": 4267, "host-ts": 4267}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4265 (Tue Oct 9 01:39:53 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4265 (Tue Oct 9 01:39:53 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "775b8785", "local_conf_timestamp": 4265, "host-ts": 4265}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:489d8ae3-b227-4acc-8a31-9d0574f90918:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:489d8ae3-b227-4acc-8a31-9d0574f90918:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 40834a0a on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 40834a0a on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 40834a0a on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4277 (Tue Oct 9 01:40:06 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4277 (Tue Oct 9 01:40:06 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "de28c792", "local_conf_timestamp": 4277, "host-ts": 4277}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4275 (Tue Oct 9 01:40:04 2018)\\nhost-id=2\\nscore=3000\\nvm_conf_refresh_time=4275 (Tue Oct 9 01:40:04 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "c039a00e", "local_conf_timestamp": 4275, "host-ts": 4275}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:55a1f1ed-a80e-4e19-87b5-1e32bc97e4c1:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:55a1f1ed-a80e-4e19-87b5-1e32bc97e4c1:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 439d8a48 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 439d8a48 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 439d8a48 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4277 (Tue Oct 9 01:40:06 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4277 (Tue Oct 9 01:40:06 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "de28c792", "local_conf_timestamp": 4277, "host-ts": 4277}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4275 (Tue Oct 9 01:40:04 2018)\\nhost-id=2\\nscore=3000\\nvm_conf_refresh_time=4275 (Tue Oct 9 01:40:04 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "c039a00e", "local_conf_timestamp": 4275, "host-ts": 4275}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:7268f134-03c9-456b-b9a5-042f135adc89:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:7268f134-03c9-456b-b9a5-042f135adc89:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 46bdf672 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 46bdf672 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 46bdf672 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4287 (Tue Oct 9 01:40:16 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4287 (Tue Oct 9 01:40:16 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "539d9689", "local_conf_timestamp": 4287, "host-ts": 4287}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4285 (Tue Oct 9 01:40:14 2018)\\nhost-id=2\\nscore=3000\\nvm_conf_refresh_time=4285 (Tue Oct 9 01:40:14 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "ffdea53d", "local_conf_timestamp": 4285, "host-ts": 4285}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:5b5ddba0-e48c-4425-b001-ee2a99288230:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:5b5ddba0-e48c-4425-b001-ee2a99288230:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 4a0f5500 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 4a0f5500 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 4a0f5500 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4287 (Tue Oct 9 01:40:16 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4287 (Tue Oct 9 01:40:16 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineMigratingAway\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"health": "good", "vm": "up", "detail": "Migration Source"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "539d9689", "local_conf_timestamp": 4287, "host-ts": 4287}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4285 (Tue Oct 9 01:40:14 2018)\\nhost-id=2\\nscore=3000\\nvm_conf_refresh_time=4285 (Tue Oct 9 01:40:14 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "ffdea53d", "local_conf_timestamp": 4285, "host-ts": 4285}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:2ce66497-456f-4e57-a3f8-fcf8117a4263:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:2ce66497-456f-4e57-a3f8-fcf8117a4263:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 4d2c78c6 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 4d2c78c6 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 4d2c78c6 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4297 (Tue Oct 9 01:40:26 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4297 (Tue Oct 9 01:40:26 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"reason": "VM migrated away successfully", "health": "bad", "vm": "down", "detail": "Down"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "4722e013", "local_conf_timestamp": 4297, "host-ts": 4297}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4295 (Tue Oct 9 01:40:24 2018)\\nhost-id=2\\nscore=3000\\nvm_conf_refresh_time=4295 (Tue Oct 9 01:40:24 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "fb985a38", "local_conf_timestamp": 4295, "host-ts": 4295}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:2c93f2a0-8500-4528-a7ed-702eaef4866b:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:2c93f2a0-8500-4528-a7ed-702eaef4866b:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 4e3af0b2 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 4e3af0b2 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 4e3af0b2 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4297 (Tue Oct 9 01:40:26 2018)\\nhost-id=1\\nscore=3000\\nvm_conf_refresh_time=4297 (Tue Oct 9 01:40:26 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"reason": "VM migrated away successfully", "health": "bad", "vm": "down", "detail": "Down"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "4722e013", "local_conf_timestamp": 4297, "host-ts": 4297}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4295 (Tue Oct 9 01:40:24 2018)\\nhost-id=2\\nscore=3000\\nvm_conf_refresh_time=4295 (Tue Oct 9 01:40:24 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineDown\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"reason": "bad vm status", "health": "bad", "vm": "down", "detail": "Migration Destination"}, "score": 3000, "stopped": false, "maintenance": false, "crc32": "fb985a38", "local_conf_timestamp": 4295, "host-ts": 4295}, "global_maintenance": false}\n\nlago.ssh: DEBUG: start task:dba870a3-6461-4e57-8b68-fb5174d97dd7:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: end task:dba870a3-6461-4e57-8b68-fb5174d97dd7:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: Running 554af398 on lago-he-node-ng-suite-4-2-host-0: hosted-engine --vm-status --json\nlago.ssh: DEBUG: Command 554af398 on lago-he-node-ng-suite-4-2-host-0 returned with 0\nlago.ssh: DEBUG: Command 554af398 on lago-he-node-ng-suite-4-2-host-0 output:\n {"1": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4307 (Tue Oct 9 01:40:35 2018)\\nhost-id=1\\nscore=0\\nvm_conf_refresh_time=4307 (Tue Oct 9 01:40:36 2018)\\nconf_on_shared_storage=True\\nmaintenance=True\\nstate=LocalMaintenance\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-0", "host-id": 1, "engine-status": {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"}, "score": 0, "stopped": false, "maintenance": true, "crc32": "3ab38b8d", "local_conf_timestamp": 4307, "host-ts": 4307}, "2": {"conf_on_shared_storage": true, "live-data": true, "extra": "metadata_parse_version=1\\nmetadata_feature_version=1\\ntimestamp=4305 (Tue Oct 9 01:40:33 2018)\\nhost-id=2\\nscore=3400\\nvm_conf_refresh_time=4305 (Tue Oct 9 01:40:34 2018)\\nconf_on_shared_storage=True\\nmaintenance=False\\nstate=EngineUp\\nstopped=False\\n", "hostname": "lago-he-node-ng-suite-4-2-host-1", "host-id": 2, "engine-status": {"health": "good", "vm": "up", "detail": "Up"}, "score": 3400, "stopped": false, "maintenance": false, "crc32": "9edda5b0", "local_conf_timestamp": 4305, "host-ts": 4305}, "global_maintenance": false}\n\nroot: INFO: * Engine has migrated.\nroot: INFO: * Waiting For System Stability...\nlago.ssh: DEBUG: start task:e6633f02-b230-430f-9359-24fe2f4a7b4b:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\ncli: DEBUG: signal 15 was caught\nroot: ERROR: end task:e6633f02-b230-430f-9359-24fe2f4a7b4b:Get ssh client for lago-he-node-ng-suite-4-2-host-0:\nlago.ssh: DEBUG: File "/usr/lib/python2.7/site-packages/lago/ssh.py", line 360, in get_ssh_client\n timeout=ssh_timeout,\n File "/usr/lib/python2.7/site-packages/paramiko/client.py", line 338, in connect\n t.start_client(timeout=timeout)\n File "/usr/lib/python2.7/site-packages/paramiko/transport.py", line 496, in start_client\n event.wait(0.1)\n File "/usr/lib64/python2.7/threading.py", line 622, in wait\n self.__cond.wait(timeout, balancing)\n File "/usr/lib64/python2.7/threading.py", line 362, in wait\n _sleep(delay)\n File "/usr/lib/python2.7/site-packages/lago/cmd.py", line 922, in exit_handler\n sys.exit(128 + signum)\n\n--------------------- >> end captured logging << ---------------------'