- Users - oVirt List Archives

[hosted-engine] engine VM doesn't respawn when its host was killed (poweroff)
by Wee Sritippho 04 May '16

04 May '16

Hi, From the hosted-engine FAQ, the engine VM should be up and running in about 5 minutes after its host was forced poweroff. However, after updated oVirt 3.6.4 to 3.6.5, the engine VM won't restart automatically even after 10+ minutes (I already made sure that global maintenance mode is set to none). I initially thought its a time sync issue, so I installed and enabled ntp on the hosts and engine. However, the issue still persists. ###Versions: [root@host01 ~]# rpm -qa | grep ovirt libgovirt-0.3.3-1.el7_2.1.x86_64 ovirt-vmconsole-1.0.0-1.el7.centos.noarch ovirt-vmconsole-host-1.0.0-1.el7.centos.noarch ovirt-hosted-engine-ha-1.3.5.3-1.el7.centos.noarch ovirt-host-deploy-1.4.1-1.el7.centos.noarch ovirt-engine-sdk-python-3.6.5.0-1.el7.centos.noarch ovirt-hosted-engine-setup-1.3.5.0-1.el7.centos.noarch ovirt-release36-007-1.noarch ovirt-setup-lib-1.0.1-1.el7.centos.noarch [root@host01 ~]# rpm -qa | grep vdsm vdsm-infra-4.17.26-0.el7.centos.noarch vdsm-jsonrpc-4.17.26-0.el7.centos.noarch vdsm-gluster-4.17.26-0.el7.centos.noarch vdsm-python-4.17.26-0.el7.centos.noarch vdsm-yajsonrpc-4.17.26-0.el7.centos.noarch vdsm-4.17.26-0.el7.centos.noarch vdsm-cli-4.17.26-0.el7.centos.noarch vdsm-xmlrpc-4.17.26-0.el7.centos.noarch vdsm-hook-vmfex-dev-4.17.26-0.el7.centos.noarch ###Log files: https://app.box.com/s/fkurmwagogwkv5smkwwq7i4ztmwf9q9r ###After host02 was killed: [root@host03 wees]# hosted-engine --vm-status --== Host 1 status ==-- Status up-to-date : True Hostname : host01.ovirt.forest.go.th Host ID : 1 Engine status : {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"} Score : 3400 stopped : False Local maintenance : False crc32 : 396766e0 Host timestamp : 4391 --== Host 2 status ==-- Status up-to-date : True Hostname : host02.ovirt.forest.go.th Host ID : 2 Engine status : {"health": "good", "vm": "up", "detail": "up"} Score : 0 stopped : True Local maintenance : False crc32 : 3a345b65 Host timestamp : 1458 --== Host 3 status ==-- Status up-to-date : True Hostname : host03.ovirt.forest.go.th Host ID : 3 Engine status : {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"} Score : 3400 stopped : False Local maintenance : False crc32 : 4c34b0ed Host timestamp : 11958 ###After host02 was killed for a while: [root@host03 wees]# hosted-engine --vm-status --== Host 1 status ==-- Status up-to-date : False Hostname : host01.ovirt.forest.go.th Host ID : 1 Engine status : unknown stale-data Score : 3400 stopped : False Local maintenance : False crc32 : 72e4e418 Host timestamp : 4415 --== Host 2 status ==-- Status up-to-date : False Hostname : host02.ovirt.forest.go.th Host ID : 2 Engine status : unknown stale-data Score : 0 stopped : True Local maintenance : False crc32 : 3a345b65 Host timestamp : 1458 --== Host 3 status ==-- Status up-to-date : False Hostname : host03.ovirt.forest.go.th Host ID : 3 Engine status : unknown stale-data Score : 3400 stopped : False Local maintenance : False crc32 : 4c34b0ed Host timestamp : 11958 ###After host02 was up again completely: [root@host03 wees]# hosted-engine --vm-status --== Host 1 status ==-- Status up-to-date : True Hostname : host01.ovirt.forest.go.th Host ID : 1 Engine status : {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"} Score : 0 stopped : False Local maintenance : False crc32 : f5728fca Host timestamp : 5555 --== Host 2 status ==-- Status up-to-date : True Hostname : host02.ovirt.forest.go.th Host ID : 2 Engine status : {"health": "good", "vm": "up", "detail": "up"} Score : 3400 stopped : False Local maintenance : False crc32 : e5284763 Host timestamp : 715 --== Host 3 status ==-- Status up-to-date : True Hostname : host03.ovirt.forest.go.th Host ID : 3 Engine status : {"reason": "vm not running on this host", "health": "bad", "vm": "down", "detail": "unknown"} Score : 3400 stopped : False Local maintenance : False crc32 : bc10c7fc Host timestamp : 13119 -- Wee

3 6

cloned vm template id
by Dobó László 04 May '16

04 May '16

Hello, How can i get back the original template id after vm is cloned with python sdk? print api.vms.get(id=vm_id).template.id result: 00000000-0000-0000-0000-000000000000 (blank template) However under vm general tab on web ui, the tamplate name is showing correctli. regards, enax

3 10

Open in Full Screen
by Colin Coe 04 May '16

04 May '16

Hi all Is there a setting for globally turning on the console option of "Open in Full Screen"? Also, can the "Connect Automatically" be permanently and globally disabled? We're on RHEV 3.5.7 Thanks CC

3 3

Hosts temporarily in "Non Operational" state after upgrade
by Will Dennis 04 May '16

04 May '16

Hi all, Had run updates tonight on my three oVirt hosts (3.6 hyperconverged) on on two of them, they went into “non Operational” state for a few minutes each before springing back to life… The synopsis was this: - Ran updates throughout the web Admin UI ...then I got the following series of messages via the “Events” tab in the UI: - Updates successfully ran - VDSM “command failed: Heartbeat exceeded” message - host is not responding message - "Failed to connect to hosted_storage" message - “The error message for connection localhost:/engine returned by VDSM was: Problem while trying to mount target” - "Host <name> reports about one of the Active Storage Domains as Problematic” - “Host <name> cannot access the Storage Domain(s) hosted_storage attached to the data center Default. Setting host state to Non-Operational.” - "Detected change in status of brick {…} of volume {…} from DOWN to UP.” (once for every brick on the host for every Gluster volume.) - "Host <name> was autorecovered.” - "Status of host <name> was set to Up." (BTW, it would be awesome if the UI’s Events log could be copied and pasted… Doesn’t work for me at least…) Duration of outage was ~3 mins per each affected host. Didn’t happen on the first host I upgraded, but did on the last two. I know I’m a little over the bleeding edge running hyperconverged on 3.6 :) but, should this behavior be expected? Also, if I go onto the hosts directly and run a ‘yum update’ after this upgrade process (not that I went thru with it, just wanted to see what was available to be upgraded) I see a bunch of ovirt-* packages that can be upgraded, which didn’t get updated thru the web UI’s upgrade process — ovirt-engine-sdk-python noarch 3.6.5.0-1.el7.centos ovirt-3.6 480 k ovirt-hosted-engine-ha noarch 1.3.5.3-1.1.el7 centos-ovirt36 295 k ovirt-hosted-engine-setup noarch 1.3.5.0-1.1.el7 centos-ovirt36 270 k ovirt-release36 noarch 007-1 ovirt-3.6 9.5 k Are these packages not related to the “Upgrade” process available thru the web UI? FYI, here’s what did get updated thru the web UI “Upgrade” process — Apr 27 21:36:28 Updated: libvirt-client-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:28 Updated: libvirt-daemon-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:28 Updated: libvirt-daemon-driver-network-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:28 Updated: libvirt-daemon-driver-qemu-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:28 Updated: libvirt-daemon-driver-nwfilter-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:28 Updated: vdsm-infra-4.17.26-1.el7.noarch Apr 27 21:36:28 Updated: vdsm-python-4.17.26-1.el7.noarch Apr 27 21:36:28 Updated: vdsm-xmlrpc-4.17.26-1.el7.noarch Apr 27 21:36:28 Updated: libvirt-daemon-config-nwfilter-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: mom-0.5.3-1.1.el7.noarch Apr 27 21:36:29 Updated: libvirt-lock-sanlock-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: libvirt-daemon-driver-secret-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: libvirt-daemon-driver-nodedev-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: libvirt-daemon-driver-interface-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: libvirt-daemon-driver-storage-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: libvirt-daemon-kvm-1.2.17-13.el7_2.4.x86_64 Apr 27 21:36:29 Updated: 1:libguestfs-1.28.1-1.55.el7.centos.2.x86_64 Apr 27 21:36:29 Updated: 1:libguestfs-tools-c-1.28.1-1.55.el7.centos.2.x86_64 Apr 27 21:36:29 Installed: libguestfs-winsupport-7.2-1.el7.x86_64 Apr 27 21:36:29 Updated: vdsm-yajsonrpc-4.17.26-1.el7.noarch Apr 27 21:36:29 Updated: vdsm-jsonrpc-4.17.26-1.el7.noarch Apr 27 21:36:29 Installed: unzip-6.0-15.el7.x86_64 Apr 27 21:36:30 Installed: gtk2-2.24.28-8.el7.x86_64 Apr 27 21:36:31 Installed: 1:virt-v2v-1.28.1-1.55.el7.centos.2.x86_64 Apr 27 21:36:31 Updated: safelease-1.0-7.el7.x86_64 Apr 27 21:36:31 Updated: vdsm-hook-vmfex-dev-4.17.26-1.el7.noarch Apr 27 21:36:32 Updated: vdsm-4.17.26-1.el7.noarch Apr 27 21:36:32 Updated: vdsm-gluster-4.17.26-1.el7.noarch Apr 27 21:36:32 Updated: vdsm-cli-4.17.26-1.el7.noarch Thanks, Will

3 6

ovirt-vmconsole serial
by Paul Groeneweg | Pazion 04 May '16

04 May '16

I have followed the setup on http://www.ovirt.org/documentation/admin-guide/serial-console-setup/ I am able to ssh to the hosted engine and select a VM. A VM with console enabled and permissions set gives a blank screen ( freezes ). So I checked serial-getty@.service Am I right this service should run on a host? When I check status, I get this: ... systemd[1]: *Dependency failed for Serial Getty on hvc0.* .. systemd[1]: *Job serial-getty(a)hvc0.service/start failed with result 'dependency'.* What needs to be done? When I restart the service it takes a long tine and looks like a timeout is triggered. Looking forward to use the serial console feature.

4 3

Two or more mount process running for engine volume
by knarra 04 May '16

04 May '16

Hi All, I have hosted engine setup with glusterfs as my storage domain. when i move a storage domain to maintenance and activate it again i see that there are two glusterfs process running for every storage domain. Is this expected behaviour or a bug ? root 27143 0.0 0.0 451308 40556 ? S<sl 10:30 0:00 /usr/sbin/glusterfs --volfile-server=<hostname> --volfile-server=<hostname> --volfile-server=<hostname> --volfile-id=/vmstore /rhev/data-center/mnt/glusterSD/<hostname>:_vmstore root 28125 27.7 0.0 584512 49824 ? S<sl 10:33 7:12 /usr/sbin/glusterfs --volfile-server=<hostname> --volfile-server=<hostname> --volfile-server=<hostname> --volfile-id=/vmstore /rhev/data-center/mnt/glusterSD/<hostanme>:_vmstore Can some please help me in understanding this? Thanks kasturi

2 1

Re: [ovirt-users] hosted-engine setup Gluster fails to execute
by Langley, Robert 03 May '16

03 May '16

--_000_BY1PR09MB08244A730F73CA59AEF3C92587790BY1PR09MB0824namp_ Content-Type: text/plain; charset="us-ascii" Content-Transfer-Encoding: quoted-printable Hi Sahina, Thank you for your response. Let me know if you'll need any of the log befo= re the Storage Configuration section. I looked at this earlier and I was wo= ndering why, after choosing to use GlusterFS, there is still reference to N= FS (nfs.py)? I do believe NFS is disabled in my Gluster config for the engi= ne cluster. -Robert 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND --=3D=3D STORAGE CONFIGURATION =3D=3D-- 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND 2016-05-02 09:16:53 DEBUG otopi.context context._executeMethod:142 Stage cu= stomization METHOD otopi.plugins.ovirt_hosted_engine_setup.storage.storage.= Plugin._early_customization 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND During customization use CTRL-D to abort= . 2016-05-02 09:16:53 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.s= torage storage._check_existing_pools:1100 _check_existing_pools 2016-05-02 09:16:53 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.s= torage storage._check_existing_pools:1101 getConnectedStoragePoolsList 2016-05-02 09:16:53 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.s= torage storage._check_existing_pools:1103 {'status': {'message': 'OK', 'cod= e': 0}, 'poollist': []} 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi.dialog.human human.queryStrin= g:156 query OVEHOSTED_STORAGE_DOMAIN_TYPE 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND Please specify the storage you would lik= e to use (glusterfs, iscsi, fc, nfs3, nfs4)[nfs3]: 2016-05-02 09:16:59 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:RECEIVE glusterfs 2016-05-02 09:16:59 DEBUG otopi.context context.dumpEnvironment:500 ENVIRON= MENT DUMP - BEGIN 2016-05-02 09:16:59 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/domainType=3Dstr:'glusterfs' 2016-05-02 09:16:59 DEBUG otopi.context context.dumpEnvironment:514 ENVIRON= MENT DUMP - END 2016-05-02 09:16:59 DEBUG otopi.context context._executeMethod:142 Stage cu= stomization METHOD otopi.plugins.ovirt_hosted_engine_setup.storage.glusterf= s.Plugin._customization 2016-05-02 09:16:59 DEBUG otopi.context context._executeMethod:142 Stage cu= stomization METHOD otopi.plugins.ovirt_hosted_engine_setup.storage.glusterf= s.Plugin._brick_customization 2016-05-02 09:16:59 DEBUG otopi.context context._executeMethod:148 conditio= n False 2016-05-02 09:16:59 DEBUG otopi.context context._executeMethod:142 Stage cu= stomization METHOD otopi.plugins.ovirt_hosted_engine_setup.storage.nfs.Plug= in._customization 2016-05-02 09:16:59 INFO otopi.plugins.ovirt_hosted_engine_setup.storage.nf= s nfs._customization:360 Please note that Replica 3 support is required for= the shared storage. 2016-05-02 09:16:59 DEBUG otopi.plugins.otopi.dialog.human human.queryStrin= g:156 query OVEHOSTED_STORAGE_DOMAIN_CONNECTION 2016-05-02 09:16:59 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND Please specify the full shared storage c= onnection path to use (example: host:/path): 2016-05-02 09:17:22 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:RECEIVE gsave0.engine.local:/engine-vol 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.n= fs plugin.executeRaw:828 execute: ('/sbin/gluster', '--mode=3Dscript', '--x= ml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.local')= , executable=3D'None', cwd=3D'None', env=3DNone 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.n= fs plugin.executeRaw:878 execute-result: ('/sbin/gluster', '--mode=3Dscript= ', '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.= local'), rc=3D2 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.n= fs plugin.execute:936 execute-output: ('/sbin/gluster', '--mode=3Dscript', = '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.loc= al') stdout: 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.n= fs plugin.execute:941 execute-output: ('/sbin/gluster', '--mode=3Dscript', = '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.loc= al') stderr: 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt_hosted_engine_setup.storage.n= fs nfs._customization:395 exception Traceback (most recent call last): File "/usr/share/ovirt-hosted-engine-setup/scripts/../plugins/ovirt-hoste= d-engine-setup/storage/nfs.py", line 390, in _customization check_space=3DFalse, File "/usr/share/ovirt-hosted-engine-setup/scripts/../plugins/ovirt-hoste= d-engine-setup/storage/nfs.py", line 302, in _validateDomain self._check_volume_properties(connection) File "/usr/share/ovirt-hosted-engine-setup/scripts/../plugins/ovirt-hoste= d-engine-setup/storage/nfs.py", line 179, in _check_volume_properties raiseOnError=3DTrue File "/usr/lib/python2.7/site-packages/otopi/plugin.py", line 946, in exe= cute command=3Dargs[0], RuntimeError: Command '/sbin/gluster' failed to execute 2016-05-02 09:17:22 ERROR otopi.plugins.ovirt_hosted_engine_setup.storage.n= fs nfs._customization:405 Cannot access storage connection gsave0.engine.lo= cal:/engine-vol: Command '/sbin/gluster' failed to execute 2016-05-02 09:17:22 DEBUG otopi.plugins.otopi.dialog.human human.queryStrin= g:156 query OVEHOSTED_STORAGE_DOMAIN_CONNECTION 2016-05-02 09:17:22 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND Please specify the full shared storage c= onnection path to use (example: host:/path): 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:156 method e= xception Traceback (most recent call last): File "/usr/lib/python2.7/site-packages/otopi/context.py", line 146, in _e= xecuteMethod method['method']() File "/usr/share/ovirt-hosted-engine-setup/scripts/../plugins/ovirt-hoste= d-engine-setup/storage/nfs.py", line 379, in _customization caseSensitive=3DTrue, File "/usr/share/otopi/plugins/otopi/dialog/human.py", line 174, in query= String value =3D self._readline(hidden=3Dhidden) File "/usr/lib/python2.7/site-packages/otopi/dialog.py", line 263, in _re= adline raise IOError(_('End of file')) IOError: End of file 2016-05-02 09:17:35 ERROR otopi.context context._executeMethod:165 Failed t= o execute stage 'Environment customization': End of file 2016-05-02 09:17:35 DEBUG otopi.context context.dumpEnvironment:500 ENVIRON= MENT DUMP - BEGIN 2016-05-02 09:17:35 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/error=3Dbool:'True' 2016-05-02 09:17:35 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/exceptionInfo=3Dlist:'[(<type 'exceptions.IOError'>, IOError('End of file= ',), <traceback object at 0x7f50379e87a0>)]' 2016-05-02 09:17:35 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageDomainConnection=3Dstr:'gsave0.engine.local:/engine-v= ol' 2016-05-02 09:17:35 DEBUG otopi.context context.dumpEnvironment:514 ENVIRON= MENT DUMP - END 2016-05-02 09:17:35 INFO otopi.context context.runSequence:427 Stage: Clean= up 2016-05-02 09:17:35 DEBUG otopi.context context.runSequence:431 STAGE clean= up 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.core.remote_answerfile= .Plugin._cleanup 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.engine.add_host.Plugin= ._cleanup 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.pki.vdsmpki.Plugin._cl= eanup 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.storage.storage.Plugin= ._cleanup 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.vm.boot_disk.Plugin._c= leanup 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.vm.cloud_init.Plugin._= cleanup 2016-05-02 09:17:35 DEBUG otopi.context context._executeMethod:148 conditio= n False 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage cl= eanup METHOD otopi.plugins.ovirt_hosted_engine_setup.core.answerfile.Plugin= ._save_answers_at_cleanup 2016-05-02 09:17:36 INFO otopi.plugins.ovirt_hosted_engine_setup.core.answe= rfile answerfile._save_answers:74 Generating answer file '/var/lib/ovirt-ho= sted-engine-setup/answers/answers-20160502091736.conf' 2016-05-02 09:17:36 INFO otopi.context context.runSequence:427 Stage: Pre-t= ermination 2016-05-02 09:17:36 DEBUG otopi.context context.runSequence:431 STAGE pre-t= erminate 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage pr= e-terminate METHOD otopi.plugins.otopi.core.misc.Plugin._preTerminate 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:500 ENVIRON= MENT DUMP - BEGIN 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/aborted=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/debug=3Dint:'0' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/error=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/exceptionInfo=3Dlist:'[(<type 'exceptions.IOError'>, IOError('End of file= ',), <traceback object at 0x7f50379e87a0>)]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/executionDirectory=3Dstr:'/var/log/ovirt-hosted-engine-setup' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/exitCode=3Dlist:'[{'priority': 90001, 'code': 0}]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/log=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/pluginGroups=3Dstr:'otopi:ovirt-hosted-engine-setup' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/pluginPath=3Dstr:'/usr/share/otopi/plugins:/usr/share/ovirt-hosted-engine= -setup/scripts/../plugins' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV BAS= E/suppressEnvironmentKeys=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/chkconfig=3Dstr:'/sbin/chkconfig' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/chown=3Dstr:'/bin/chown' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/chronyc=3Dstr:'/bin/chronyc' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/date=3Dstr:'/bin/date' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/dig=3Dstr:'/bin/dig' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/file=3Dstr:'/bin/file' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/firewall-cmd=3Dstr:'/bin/firewall-cmd' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/genisoimage=3Dstr:'/bin/genisoimage' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/gluster=3Dstr:'/sbin/gluster' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/hwclock=3Dstr:'/sbin/hwclock' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/initctl=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/ip=3Dstr:'/sbin/ip' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/iscsiadm=3Dstr:'/sbin/iscsiadm' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/losetup=3Dstr:'/sbin/losetup' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/lsof=3Dstr:'/sbin/lsof' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/mkfs=3Dstr:'/sbin/mkfs' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/mount=3Dstr:'/bin/mount' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/ntpq=3Dstr:'/sbin/ntpq' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/openssl=3Dstr:'/bin/openssl' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/ping=3Dstr:'/bin/ping' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/qemu-img=3Dstr:'/bin/qemu-img' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/rc=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/rc-update=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/reboot=3Dstr:'/sbin/reboot' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/remote-viewer=3Dstr:'/bin/remote-viewer' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/service=3Dstr:'/sbin/service' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/sshd=3Dstr:'/sbin/sshd' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/sudo=3Dstr:'/bin/sudo' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/systemctl=3Dstr:'/bin/systemctl' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/truncate=3Dstr:'/bin/truncate' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/umount=3Dstr:'/bin/umount' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COM= MAND/vdsm-tool=3Dstr:'/bin/vdsm-tool' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/configFileAppend=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/configFileName=3Dstr:'/etc/otopi.conf' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/failOnPrioOverride=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/internalPackageTransaction=3DTransaction:'transaction' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logDir=3Dstr:'/var/log/ovirt-hosted-engine-setup' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logFileHandle=3Dfile:'<open file '/var/log/ovirt-hosted-engine-setup/ovir= t-hosted-engine-setup-20160502091641-h9z3t4.log', mode 'a' at 0x7f503d79dae= 0>' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logFileName=3Dstr:'/var/log/ovirt-hosted-engine-setup/ovirt-hosted-engine= -setup-20160502091641-h9z3t4.log' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logFileNamePrefix=3Dstr:'ovirt-hosted-engine-setup' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logFilter=3D_MyLoggerFilter:'filter' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logFilterKeys=3Dlist:'['OVEHOSTED_FIRST_HOST/rootPassword', 'OVEHOSTED_EN= GINE/adminPassword', 'OVEHOSTED_VM/cloudinitRootPwd', 'OVEHOSTED_VDSM/passw= d']' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/logRemoveAtExit=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/mainTransaction=3DTransaction:'transaction' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/modifiedFiles=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV COR= E/randomizeEvents=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV DIA= LOG/boundary=3Dstr:'--=3D451b80dc-996f-432e-9e4f-2b29ef6d1141=3D--' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV DIA= LOG/cliVersion=3Dint:'1' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV DIA= LOG/customization=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV DIA= LOG/dialect=3Dstr:'human' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV INF= O/PACKAGE_NAME=3Dstr:'otopi' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV INF= O/PACKAGE_VERSION=3Dstr:'1.4.1' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/firewalldAvailable=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/firewalldDisableServices=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/firewalldEnable=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/iptablesEnable=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/iptablesRules=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/sshEnable=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/sshKey=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV NET= WORK/sshUser=3Dstr:'' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/additionalHostEnabled=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/additionalHostReDeployment=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/checkRequirements=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/confirmSettings=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/deployProceed=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/etcAnswerFile=3Dstr:'/etc/ovirt-hosted-engine/answers.conf' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/isAdditionalHost=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/nodeSetup=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/screenProceed=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/tempDir=3Dstr:'/var/tmp' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_CORE/userAnswerFile=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/adminPassword=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/appHostName=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/clusterName=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/engineSetupTimeout=3Dint:'600' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/forceCreateVG=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/insecureSSL=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/promptNonOperational=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_ENGINE/temporaryCertificate=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_FIRST_HOST/deployWithHE35Hosts=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_FIRST_HOST/fetchAnswer=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_FIRST_HOST/fqdn=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_FIRST_HOST/rootPassword=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_FIRST_HOST/sshdPort=3Dint:'22' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/bridgeIf=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/bridgeName=3Dstr:'ovirtmgmt' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/firewallManager=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/firewalldServices=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/firewalldSubst=3Ddict:'{}' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/fqdn=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/fqdnReverseValidation=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/gateway=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/promptRequiredNetworks=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NETWORK/sshdPort=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NOTIF/destEmail=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NOTIF/smtpPort=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NOTIF/smtpServer=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_NOTIF/sourceEmail=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_SANLOCK/lockspaceName=3Dstr:'hosted-engine' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_SANLOCK/serviceName=3Dstr:'sanlock' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/GUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/LunID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/blockDeviceSizeGB=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/brokerConfContent=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/confImageSizeGB=3Dint:'1' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/confImageUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/confVolUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/connectionUUID=3Dstr:'3c56397d-12ec-48d1-a8a0-44ebe0b37402' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/domainType=3Dstr:'glusterfs' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/fakeMasterSdConnUUID=3Dstr:'8925e58a-61df-4947-be15-64e4a84f= 3a78' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/fakeMasterSdUUID=3Dstr:'699a27e8-510b-485b-ab66-2bb68ca2b661= ' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/glusterBrick=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/glusterProvisionedShareName=3Dstr:'hosted_engine_glusterfs' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/glusterProvisioningEnabled=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/hostID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/iSCSIPortal=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/iSCSIPortalIPAddress=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/iSCSIPortalPassword=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/iSCSIPortalPort=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/iSCSIPortalUser=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/iSCSITargetName=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/imgDesc=3Dstr:'Hosted Engine Image' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/imgSizeGB=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/imgUUID=3Dstr:'1d66efe1-8289-4065-a831-112f88ac5251' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/lockspaceImageUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/lockspaceVolumeUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/metadataImageUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/metadataVolumeUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/sdUUID=3Dstr:'244c54b9-81ee-4031-a526-f32a317bae16' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/spUUID=3Dstr:'e58179fa-377e-40d1-b74a-9e87ee0cc621' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageAnswerFileContent=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageDatacenterName=3Dstr:'hosted_datacenter' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageDomainConnection=3Dstr:'gsave0.engine.local:/engine-v= ol' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageDomainName=3Dstr:'hosted_storage' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageHEConfContent=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/storageType=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/vgUUID=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/vmConfContent=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_STORAGE/volUUID=3Dstr:'83dd8331-d3f9-4211-9915-4c3a21652fdc' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/caSubject=3Dstr:'/C=3DEN/L=3DTest/O=3DTest/CN=3DTestCA' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/consoleType=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/cpu=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/engineCpu=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/glusterMinimumVersion=3Dstr:'3.7.2' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/kvmGid=3Dint:'36' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/passwd=3Dstr:'**FILTERED**' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/passwdValiditySecs=3Dstr:'10800' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/pkiSubject=3Dstr:'/C=3DEN/L=3DTest/O=3DTest/CN=3DTest' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/serviceName=3Dstr:'vdsmd' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/spicePkiSubject=3Dunicode:'C=3DEN, L=3DTest, O=3DTest, CN=3DTes= t' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/useSSL=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/vdscli=3Dinstance:'<ServerProxy for 0.0.0.0:54321/RPC2>' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VDSM/vdsmUid=3Dint:'36' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/applianceMem=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/applianceVCpus=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/automateVMShutdown=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cdromUUID=3Dstr:'5c3a9b2d-3696-4d43-ba3b-43fb0e2d5b41' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudInitISO=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitExecuteEngineSetup=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitInstanceDomainName=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitInstanceHostName=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitRootPwd=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitVMDNS=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitVMETCHOSTS=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/cloudinitVMStaticCIDR=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/consoleUUID=3Dstr:'e68e9f6c-0269-40bb-a85e-ff086c19d62a' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/emulatedMachine=3Dstr:'pc' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/nicUUID=3Dstr:'b0ff0139-7bb7-4e1f-a4b8-cd3da1b9212d' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/ovfArchive=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/subst=3Ddict:'{}' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/vmBoot=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/vmCDRom=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/vmMACAddr=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/vmMemSizeMB=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/vmUUID=3Dstr:'a3190faf-9494-44dd-8bba-cd878a82c381' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= HOSTED_VM/vmVCpus=3DNoneType:'None' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV OVE= SETUP_CORE/offlinePackager=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/dnfDisabledPlugins=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/dnfExpireCache=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/dnfRollback=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/dnfpackagerEnabled=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/keepAliveInterval=3Dint:'30' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/yumDisabledPlugins=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/yumEnabledPlugins=3Dlist:'[]' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/yumExpireCache=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/yumRollback=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV PAC= KAGER/yumpackagerEnabled=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV SYS= TEM/clockMaxGap=3Dint:'5' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV SYS= TEM/clockSet=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV SYS= TEM/commandPath=3Dstr:'/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/s= bin:/bin' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV SYS= TEM/reboot=3Dbool:'False' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV SYS= TEM/rebootAllow=3Dbool:'True' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:510 ENV SYS= TEM/rebootDeferTime=3Dint:'10' 2016-05-02 09:17:36 DEBUG otopi.context context.dumpEnvironment:514 ENVIRON= MENT DUMP - END 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage pr= e-terminate METHOD otopi.plugins.otopi.dialog.cli.Plugin._pre_terminate 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:148 conditio= n False 2016-05-02 09:17:36 INFO otopi.context context.runSequence:427 Stage: Termi= nation 2016-05-02 09:17:36 DEBUG otopi.context context.runSequence:431 STAGE termi= nate 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage te= rminate METHOD otopi.plugins.ovirt_hosted_engine_setup.core.misc.Plugin._te= rminate 2016-05-02 09:17:36 ERROR otopi.plugins.ovirt_hosted_engine_setup.core.misc= misc._terminate:170 Hosted Engine deployment failed: this system is not re= liable, please check the issue, fix and redeploy 2016-05-02 09:17:36 DEBUG otopi.plugins.otopi.dialog.human dialog.__logStri= ng:219 DIALOG:SEND Log file is located at /var/log/ovirt-ho= sted-engine-setup/ovirt-hosted-engine-setup-20160502091641-h9z3t4.log 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage te= rminate METHOD otopi.plugins.otopi.dialog.human.Plugin._terminate 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage te= rminate METHOD otopi.plugins.otopi.dialog.machine.Plugin._terminate 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:148 conditio= n False 2016-05-02 09:17:36 DEBUG otopi.context context._executeMethod:142 Stage te= rminate METHOD otopi.plugins.otopi.core.log.Plugin._terminate --_000_BY1PR09MB08244A730F73CA59AEF3C92587790BY1PR09MB0824namp_ Content-Type: text/html; charset="us-ascii" Content-Transfer-Encoding: quoted-printable <html xmlns:v=3D"urn:schemas-microsoft-com:vml" xmlns:o=3D"urn:schemas-micr= osoft-com:office:office" xmlns:w=3D"urn:schemas-microsoft-com:office:word" = xmlns:m=3D"http://schemas.microsoft.com/office/2004/12/omml" xmlns=3D"http:= //www.w3.org/TR/REC-html40"> <head> <meta http-equiv=3D"Content-Type" content=3D"text/html; charset=3Dus-ascii"= > <meta name=3D"Generator" content=3D"Microsoft Word 15 (filtered medium)"> <style></style> </head> <body lang=3D"EN-US" link=3D"#0563C1" vlink=3D"#954F72"> <div class=3D"WordSection1"> Hi Sahina,<o:p></o:p> <o:p> </o:p> Thank you for your response. Let me know if you&#821= 7;ll need any of the log before the Storage Configuration section. I looked= at this earlier and I was wondering why, after choosing to use GlusterFS, = there is still reference to NFS (nfs.py)? I do believe NFS is disabled in my Gluster config for the engine cluster. = -Robert<o:p></o:p> <o:p> </o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND    &nb= sp;            --=3D= =3D STORAGE CONFIGURATION =3D=3D--<o:p></o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND     &n= bsp;          <o:p></o:p>= 2016-05-02 09:16:53 DEBUG otopi.context conte= xt._executeMethod:142 Stage customization METHOD otopi.plugins.ovirt_hosted= _engine_setup.storage.storage.Plugin._early_customization<o:p></o:p>= 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND    &nb= sp;            Durin= g customization use CTRL-D to abort.<o:p></o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.storage storage._check_existing_pools:1100 _ch= eck_existing_pools<o:p></o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.storage storage._check_existing_pools:1101 get= ConnectedStoragePoolsList<o:p></o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.storage storage._check_existing_pools:1103 {'s= tatus': {'message': 'OK', 'code': 0}, 'poollist': []}<o:p></o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi= .dialog.human human.queryString:156 query OVEHOSTED_STORAGE_DOMAIN_TYPE<o:p= ></o:p> 2016-05-02 09:16:53 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND    &nb= sp;            Pleas= e specify the storage you would like to use (glusterfs, iscsi, fc, nfs3, nfs4)[nfs3]: <o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:RECEIVE    glust= erfs<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt.dumpEnvironment:500 ENVIRONMENT DUMP - BEGIN<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/domainType=3Dstr:'glusterfs'<o= :p></o:p> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt.dumpEnvironment:514 ENVIRONMENT DUMP - END<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt._executeMethod:142 Stage customization METHOD otopi.plugins.ovirt_hosted= _engine_setup.storage.glusterfs.Plugin._customization<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt._executeMethod:142 Stage customization METHOD otopi.plugins.ovirt_hosted= _engine_setup.storage.glusterfs.Plugin._brick_customization<o:p></o:p></spa= n> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt._executeMethod:148 condition False<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.context conte= xt._executeMethod:142 Stage customization METHOD otopi.plugins.ovirt_hosted= _engine_setup.storage.nfs.Plugin._customization<o:p></o:p> 2016-05-02 09:16:59 INFO otopi.plugins.ovirt_= hosted_engine_setup.storage.nfs nfs._customization:360 Please note that Rep= lica 3 support is required for the shared storage.<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.plugins.otopi= .dialog.human human.queryString:156 query OVEHOSTED_STORAGE_DOMAIN_CONNECTI= ON<o:p></o:p> 2016-05-02 09:16:59 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND    &nb= sp;            Pleas= e specify the full shared storage connection path to use (example: host:/path): <o:p></o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:RECEIVE    gsave= 0.engine.local:/engine-vol<o:p></o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.nfs plugin.executeRaw:828 execute: ('/sbin/glu= ster', '--mode=3Dscript', '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.local'), executable=3D'None',= cwd=3D'None', env=3DNone<o:p></o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.nfs plugin.executeRaw:878 execute-result: ('/s= bin/gluster', '--mode=3Dscript', '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.local'), rc=3D2<o:p><= /o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.nfs plugin.execute:936 execute-output: ('/sbin= /gluster', '--mode=3Dscript', '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.local') stdout:<o:p></o:p></s= pan> <o:p> </o:p> <o:p> </o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.nfs plugin.execute:941 execute-output: ('/sbin= /gluster', '--mode=3Dscript', '--xml', 'volume', 'info', 'engine-vol', '--remote-host=3Dgsave0.engine.local') stderr:<o:p></o:p></s= pan> <o:p> </o:p> <o:p> </o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.ovirt= _hosted_engine_setup.storage.nfs nfs._customization:395 exception<o:p></o:p= > Traceback (most recent call last):<o:p></o:p>=   File "/usr/share/ovirt-hosted-eng= ine-setup/scripts/../plugins/ovirt-hosted-engine-setup/storage/nfs.py"= , line 390, in _customization<o:p></o:p>     check_space=3DFalse,<o:p><= /o:p>   File "/usr/share/ovirt-hosted-eng= ine-setup/scripts/../plugins/ovirt-hosted-engine-setup/storage/nfs.py"= , line 302, in _validateDomain<o:p></o:p>     self._check_volume_propert= ies(connection)<o:p></o:p>   File "/usr/share/ovirt-hosted-eng= ine-setup/scripts/../plugins/ovirt-hosted-engine-setup/storage/nfs.py"= , line 179, in _check_volume_properties<o:p></o:p>     raiseOnError=3DTrue<o:p></= o:p>   File "/usr/lib/python2.7/site-pac= kages/otopi/plugin.py", line 946, in execute<o:p></o:p>     command=3Dargs[0],<o:p></o= :p> RuntimeError: Command '/sbin/gluster' failed = to execute<o:p></o:p> 2016-05-02 09:17:22 ERROR otopi.plugins.ovirt= _hosted_engine_setup.storage.nfs nfs._customization:405 Cannot access stora= ge connection gsave0.engine.local:/engine-vol: Command '/sbin/gluster' failed to execute<o:p></o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.otopi= .dialog.human human.queryString:156 query OVEHOSTED_STORAGE_DOMAIN_CONNECTI= ON<o:p></o:p> 2016-05-02 09:17:22 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND    &nb= sp;            Pleas= e specify the full shared storage connection path to use (example: host:/path): <o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:156 method exception<o:p></o:p> Traceback (most recent call last):<o:p></o:p>=   File "/usr/lib/python2.7/site-pac= kages/otopi/context.py", line 146, in _executeMethod<o:p></o:p>=     method['method']()<o:p></o= :p>   File "/usr/share/ovirt-hosted-eng= ine-setup/scripts/../plugins/ovirt-hosted-engine-setup/storage/nfs.py"= , line 379, in _customization<o:p></o:p>     caseSensitive=3DTrue,<o:p>= </o:p>   File "/usr/share/otopi/plugins/ot= opi/dialog/human.py", line 174, in queryString<o:p></o:p>     value =3D self._readline(h= idden=3Dhidden)<o:p></o:p>   File "/usr/lib/python2.7/site-pac= kages/otopi/dialog.py", line 263, in _readline<o:p></o:p>     raise IOError(_('End of fi= le'))<o:p></o:p> IOError: End of file<o:p></o:p> 2016-05-02 09:17:35 ERROR otopi.context conte= xt._executeMethod:165 Failed to execute stage 'Environment customization': = End of file<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt.dumpEnvironment:500 ENVIRONMENT DUMP - BEGIN<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/error=3Dbool:'True'<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/exceptionInfo=3Dlist:'[(<type 'exception= s.IOError'>, IOError('End of file',), <traceback object at 0x7f50379e87a0>)]'<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageDomainConnection=3Dstr:= 'gsave0.engine.local:/engine-vol'<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt.dumpEnvironment:514 ENVIRONMENT DUMP - END<o:p></o:p> 2016-05-02 09:17:35 INFO otopi.context contex= t.runSequence:427 Stage: Clean up<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt.runSequence:431 STAGE cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.core.remote_answerfile.Plugin._cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.engine.add_host.Plugin._cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.pki.vdsmpki.Plugin._cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.storage.storage.Plugin._cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.vm.boot_disk.Plugin._cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.vm.cloud_init.Plugin._cleanup<o:p></o:p> 2016-05-02 09:17:35 DEBUG otopi.context conte= xt._executeMethod:148 condition False<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage cleanup METHOD otopi.plugins.ovirt_hosted_engin= e_setup.core.answerfile.Plugin._save_answers_at_cleanup<o:p></o:p></= p> 2016-05-02 09:17:36 INFO otopi.plugins.ovirt_= hosted_engine_setup.core.answerfile answerfile._save_answers:74 Generating = answer file '/var/lib/ovirt-hosted-engine-setup/answers/answers-20160502091= 736.conf'<o:p></o:p> 2016-05-02 09:17:36 INFO otopi.context contex= t.runSequence:427 Stage: Pre-termination<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.runSequence:431 STAGE pre-terminate<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage pre-terminate METHOD otopi.plugins.otopi.core.m= isc.Plugin._preTerminate<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:500 ENVIRONMENT DUMP - BEGIN<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/aborted=3Dbool:'False'<o:p></o:p></p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/debug=3Dint:'0'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/error=3Dbool:'True'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/exceptionInfo=3Dlist:'[(<type 'exception= s.IOError'>, IOError('End of file',), <traceback object at 0x7f50379e87a0>)]'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/executionDirectory=3Dstr:'/var/log/ovirt-ho= sted-engine-setup'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/exitCode=3Dlist:'[{'priority': 90001, 'code= ': 0}]'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/log=3Dbool:'True'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/pluginGroups=3Dstr:'otopi:ovirt-hosted-engi= ne-setup'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/pluginPath=3Dstr:'/usr/share/otopi/plugins:= /usr/share/ovirt-hosted-engine-setup/scripts/../plugins'<o:p></o:p><= /p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV BASE/suppressEnvironmentKeys=3Dlist:'[]'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/chkconfig=3Dstr:'/sbin/chkconfig'<o:p></= o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/chown=3Dstr:'/bin/chown'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/chronyc=3Dstr:'/bin/chronyc'<o:p></o:p><= /span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/date=3Dstr:'/bin/date'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/dig=3Dstr:'/bin/dig'<o:p></o:p></= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/file=3Dstr:'/bin/file'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/firewall-cmd=3Dstr:'/bin/firewall-cmd'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/genisoimage=3Dstr:'/bin/genisoimage'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/gluster=3Dstr:'/sbin/gluster'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/hwclock=3Dstr:'/sbin/hwclock'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/initctl=3DNoneType:'None'<o:p></o:p></sp= an> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/ip=3Dstr:'/sbin/ip'<o:p></o:p></p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/iscsiadm=3Dstr:'/sbin/iscsiadm'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/losetup=3Dstr:'/sbin/losetup'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/lsof=3Dstr:'/sbin/lsof'<o:p></o:p></span= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/mkfs=3Dstr:'/sbin/mkfs'<o:p></o:p></span= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/mount=3Dstr:'/bin/mount'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/ntpq=3Dstr:'/sbin/ntpq'<o:p></o:p></span= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/openssl=3Dstr:'/bin/openssl'<o:p></o:p><= /span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/ping=3Dstr:'/bin/ping'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/qemu-img=3Dstr:'/bin/qemu-img'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/rc=3DNoneType:'None'<o:p></o:p></= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/rc-update=3DNoneType:'None'<o:p></o:p></= span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/reboot=3Dstr:'/sbin/reboot'<o:p></o:p></= span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/remote-viewer=3Dstr:'/bin/remote-viewer'= <o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/service=3Dstr:'/sbin/service'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/sshd=3Dstr:'/sbin/sshd'<o:p></o:p></span= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/sudo=3Dstr:'/bin/sudo'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/systemctl=3Dstr:'/bin/systemctl'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/truncate=3Dstr:'/bin/truncate'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/umount=3Dstr:'/bin/umount'<o:p></o:p></s= pan> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV COMMAND/vdsm-tool=3Dstr:'/bin/vdsm-tool'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/configFileAppend=3DNoneType:'None'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/configFileName=3Dstr:'/etc/otopi.conf'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/failOnPrioOverride=3Dbool:'False'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/internalPackageTransaction=3DTransaction:'t= ransaction'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logDir=3Dstr:'/var/log/ovirt-hosted-engine-= setup'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logFileHandle=3Dfile:'<open file '/var/l= og/ovirt-hosted-engine-setup/ovirt-hosted-engine-setup-20160502091641-h9z3t= 4.log', mode 'a' at 0x7f503d79dae0>'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logFileName=3Dstr:'/var/log/ovirt-hosted-en= gine-setup/ovirt-hosted-engine-setup-20160502091641-h9z3t4.log'<o:p></o:p><= /span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logFileNamePrefix=3Dstr:'ovirt-hosted-engin= e-setup'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logFilter=3D_MyLoggerFilter:'filter'<o:p></= o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logFilterKeys=3Dlist:'['OVEHOSTED_FIRST_HOS= T/rootPassword', 'OVEHOSTED_ENGINE/adminPassword', 'OVEHOSTED_VM/cloudinitRootPwd', 'OVEHOSTED_VDSM/passwd']'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/logRemoveAtExit=3Dbool:'False'<o:p></o:p></= span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/mainTransaction=3DTransaction:'transaction'= <o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/modifiedFiles=3Dlist:'[]'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV CORE/randomizeEvents=3Dbool:'False'<o:p></o:p></= span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV DIALOG/boundary=3Dstr:'--=3D451b80dc-996f-432e-9= e4f-2b29ef6d1141=3D--'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV DIALOG/cliVersion=3Dint:'1'<o:p></o:p></p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV DIALOG/customization=3Dbool:'False'<o:p></o:p></= span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV DIALOG/dialect=3Dstr:'human'<o:p></o:p></= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV INFO/PACKAGE_NAME=3Dstr:'otopi'<o:p></o:p></span= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV INFO/PACKAGE_VERSION=3Dstr:'1.4.1'<o:p></o:p></s= pan> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/firewalldAvailable=3Dbool:'True'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/firewalldDisableServices=3Dlist:'[]'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/firewalldEnable=3Dbool:'False'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/iptablesEnable=3Dbool:'False'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/iptablesRules=3DNoneType:'None'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/sshEnable=3Dbool:'False'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/sshKey=3DNoneType:'None'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV NETWORK/sshUser=3Dstr:''<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/additionalHostEnabled=3Dbool:'Fal= se'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/additionalHostReDeployment=3DNone= Type:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/checkRequirements=3Dbool:'True'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/confirmSettings=3DNoneType:'None'= <o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/deployProceed=3Dbool:'True'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/etcAnswerFile=3Dstr:'/etc/ovirt-h= osted-engine/answers.conf'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/isAdditionalHost=3DNoneType:'None= '<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/nodeSetup=3Dbool:'False'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/screenProceed=3DNoneType:'None'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/tempDir=3Dstr:'/var/tmp'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_CORE/userAnswerFile=3DNoneType:'None'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/adminPassword=3DNoneType:'None'= <o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/appHostName=3DNoneType:'None'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/clusterName=3DNoneType:'None'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/engineSetupTimeout=3Dint:'600'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/forceCreateVG=3DNoneType:'None'= <o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/insecureSSL=3DNoneType:'None'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/promptNonOperational=3Dbool:'Tr= ue'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_ENGINE/temporaryCertificate=3DNoneType= :'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_FIRST_HOST/deployWithHE35Hosts=3DNoneT= ype:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_FIRST_HOST/fetchAnswer=3DNoneType:'Non= e'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_FIRST_HOST/fqdn=3DNoneType:'None'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_FIRST_HOST/rootPassword=3DNoneType:'No= ne'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_FIRST_HOST/sshdPort=3Dint:'22'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/bridgeIf=3DNoneType:'None'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/bridgeName=3Dstr:'ovirtmgmt'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/firewallManager=3DNoneType:'No= ne'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/firewalldServices=3Dlist:'[]'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/firewalldSubst=3Ddict:'{}'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/fqdn=3DNoneType:'None'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/fqdnReverseValidation=3Dbool:'= False'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/gateway=3DNoneType:'None'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/promptRequiredNetworks=3Dbool:= 'True'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NETWORK/sshdPort=3DNoneType:'None'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NOTIF/destEmail=3DNoneType:'None'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NOTIF/smtpPort=3DNoneType:'None'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NOTIF/smtpServer=3DNoneType:'None'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_NOTIF/sourceEmail=3DNoneType:'None'<o:= p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_SANLOCK/lockspaceName=3Dstr:'hosted-en= gine'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_SANLOCK/serviceName=3Dstr:'sanlock'<o:= p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/GUID=3DNoneType:'None'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/LunID=3DNoneType:'None'<o:p></= o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/blockDeviceSizeGB=3DNoneType:'= None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/brokerConfContent=3DNoneType:'= None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/confImageSizeGB=3Dint:'1'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/confImageUUID=3DNoneType:'None= '<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/confVolUUID=3DNoneType:'None'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/connectionUUID=3Dstr:'3c56397d= -12ec-48d1-a8a0-44ebe0b37402'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/domainType=3Dstr:'glusterfs'<o= :p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/fakeMasterSdConnUUID=3Dstr:'89= 25e58a-61df-4947-be15-64e4a84f3a78'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/fakeMasterSdUUID=3Dstr:'699a27= e8-510b-485b-ab66-2bb68ca2b661'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/glusterBrick=3DNoneType:'None'= <o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/glusterProvisionedShareName=3D= str:'hosted_engine_glusterfs'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/glusterProvisioningEnabled=3Db= ool:'False'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/hostID=3DNoneType:'None'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/iSCSIPortal=3DNoneType:'None'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/iSCSIPortalIPAddress=3DNoneTyp= e:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/iSCSIPortalPassword=3DNoneType= :'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/iSCSIPortalPort=3DNoneType:'No= ne'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/iSCSIPortalUser=3DNoneType:'No= ne'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/iSCSITargetName=3DNoneType:'No= ne'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/imgDesc=3Dstr:'Hosted Engine I= mage'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/imgSizeGB=3DNoneType:'None'<o:= p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/imgUUID=3Dstr:'1d66efe1-8289-4= 065-a831-112f88ac5251'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/lockspaceImageUUID=3DNoneType:= 'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/lockspaceVolumeUUID=3DNoneType= :'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/metadataImageUUID=3DNoneType:'= None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/metadataVolumeUUID=3DNoneType:= 'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/sdUUID=3Dstr:'244c54b9-81ee-40= 31-a526-f32a317bae16'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/spUUID=3Dstr:'e58179fa-377e-40= d1-b74a-9e87ee0cc621'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageAnswerFileContent=3DNon= eType:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageDatacenterName=3Dstr:'h= osted_datacenter'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageDomainConnection=3Dstr:= 'gsave0.engine.local:/engine-vol'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageDomainName=3Dstr:'hoste= d_storage'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageHEConfContent=3DNoneTyp= e:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/storageType=3DNoneType:'None'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/vgUUID=3DNoneType:'None'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/vmConfContent=3DNoneType:'None= '<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_STORAGE/volUUID=3Dstr:'83dd8331-d3f9-4= 211-9915-4c3a21652fdc'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/caSubject=3Dstr:'/C=3DEN/L=3DTest= /O=3DTest/CN=3DTestCA'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/consoleType=3DNoneType:'None'<o:p= ></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/cpu=3DNoneType:'None'<o:p></o:p><= /span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/engineCpu=3DNoneType:'None'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/glusterMinimumVersion=3Dstr:'3.7.= 2'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/kvmGid=3Dint:'36'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/passwd=3Dstr:'**FILTERED**'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/passwdValiditySecs=3Dstr:'10800'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/pkiSubject=3Dstr:'/C=3DEN/L=3DTes= t/O=3DTest/CN=3DTest'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/serviceName=3Dstr:'vdsmd'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/spicePkiSubject=3Dunicode:'C=3DEN= , L=3DTest, O=3DTest, CN=3DTest'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/useSSL=3Dbool:'True'<o:p></o:p></= span> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/vdscli=3Dinstance:'<ServerProx= y for 0.0.0.0:54321/RPC2>'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VDSM/vdsmUid=3Dint:'36'<o:p></o:p></sp= an> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/applianceMem=3DNoneType:'None'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/applianceVCpus=3DNoneType:'None'<o:= p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/automateVMShutdown=3DNoneType:'None= '<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cdromUUID=3Dstr:'5c3a9b2d-3696-4d43= -ba3b-43fb0e2d5b41'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudInitISO=3DNoneType:'None'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitExecuteEngineSetup=3DNoneT= ype:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitInstanceDomainName=3DNoneT= ype:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitInstanceHostName=3DNoneTyp= e:'None'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitRootPwd=3DNoneType:'None'<= o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitVMDNS=3DNoneType:'None'<o:= p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitVMETCHOSTS=3DNoneType:'Non= e'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/cloudinitVMStaticCIDR=3DNoneType:'N= one'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/consoleUUID=3Dstr:'e68e9f6c-0269-40= bb-a85e-ff086c19d62a'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/emulatedMachine=3Dstr:'pc'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/nicUUID=3Dstr:'b0ff0139-7bb7-4e1f-a= 4b8-cd3da1b9212d'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/ovfArchive=3DNoneType:'None'<o:p></= o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/subst=3Ddict:'{}'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/vmBoot=3DNoneType:'None'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/vmCDRom=3DNoneType:'None'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/vmMACAddr=3DNoneType:'None'<o:p></o= :p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/vmMemSizeMB=3DNoneType:'None'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/vmUUID=3Dstr:'a3190faf-9494-44dd-8b= ba-cd878a82c381'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVEHOSTED_VM/vmVCpus=3DNoneType:'None'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV OVESETUP_CORE/offlinePackager=3Dbool:'True'<o:p>= </o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/dnfDisabledPlugins=3Dlist:'[]'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/dnfExpireCache=3Dbool:'True'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/dnfRollback=3Dbool:'True'<o:p></o:p></s= pan> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/dnfpackagerEnabled=3Dbool:'True'<o:p></= o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/keepAliveInterval=3Dint:'30'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/yumDisabledPlugins=3Dlist:'[]'<o:p></o:= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/yumEnabledPlugins=3Dlist:'[]'<o:p></o:p= > 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/yumExpireCache=3Dbool:'True'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/yumRollback=3Dbool:'True'<o:p></o:p></s= pan> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV PACKAGER/yumpackagerEnabled=3Dbool:'False'<o:p><= /o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV SYSTEM/clockMaxGap=3Dint:'5'<o:p></o:p></= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV SYSTEM/clockSet=3Dbool:'False'<o:p></o:p>= 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV SYSTEM/commandPath=3Dstr:'/usr/local/sbin:/usr/l= ocal/bin:/usr/sbin:/usr/bin:/sbin:/bin'<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV SYSTEM/reboot=3Dbool:'False'<o:p></o:p></= p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV SYSTEM/rebootAllow=3Dbool:'True'<o:p></o:p></spa= n> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:510 ENV SYSTEM/rebootDeferTime=3Dint:'10'<o:p></o:p></sp= an> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.dumpEnvironment:514 ENVIRONMENT DUMP - END<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage pre-terminate METHOD otopi.plugins.otopi.dialog= .cli.Plugin._pre_terminate<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:148 condition False<o:p></o:p> 2016-05-02 09:17:36 INFO otopi.context contex= t.runSequence:427 Stage: Termination<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt.runSequence:431 STAGE terminate<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage terminate METHOD otopi.plugins.ovirt_hosted_eng= ine_setup.core.misc.Plugin._terminate<o:p></o:p> 2016-05-02 09:17:36 ERROR otopi.plugins.ovirt= _hosted_engine_setup.core.misc misc._terminate:170 Hosted Engine deployment= failed: this system is not reliable, please check the issue, fix and redeploy<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.plugins.otopi= .dialog.human dialog.__logString:219 DIALOG:SEND    &nb= sp;            Log f= ile is located at /var/log/ovirt-hosted-engine-setup/ovirt-hosted-engine-se= tup-20160502091641-h9z3t4.log<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage terminate METHOD otopi.plugins.otopi.dialog.hum= an.Plugin._terminate<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage terminate METHOD otopi.plugins.otopi.dialog.mac= hine.Plugin._terminate<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:148 condition False<o:p></o:p> 2016-05-02 09:17:36 DEBUG otopi.context conte= xt._executeMethod:142 Stage terminate METHOD otopi.plugins.otopi.core.log.P= lugin._terminate<o:p></o:p> <o:p> </o:p> </div> </body> </html> --_000_BY1PR09MB08244A730F73CA59AEF3C92587790BY1PR09MB0824namp_--

3 4

Additional hosted-engine host deployment failed due to message timeout
by Wee Sritippho 03 May '16

03 May '16

This is a multi-part message in MIME format. --------------080805070702090104010500 Content-Type: text/plain; charset=utf-8; format=flowed Content-Transfer-Encoding: 7bit Hi, I'm making a fresh hosted-engine installation on 3 hosts. First 2 hosts succeeded, but the 3rd one stuck at termination state "Installing Host hosted_engine_3. Stage: Termination.", then, 3 minutes later, "VDSM hosted_engine_3 command failed: Message timeout which can be caused by communication issues". Currently, the 3rd host status in web UI is stuck at "Installing". How can I proceed? Could I just run this script <https://www.ovirt.org/documentation/how-to/hosted-engine/#recoving-from-fai…> in the 3rd host, and run "hosted-engine --deploy" again? log files: https://app.box.com/s/a5typfe6cbozs9uo9osg68gtmq8793t6 [me@host03 ~]$ rpm -qa | grep ovirt ovirt-release36-007-1.noarch ovirt-hosted-engine-setup-1.3.5.0-1.1.el7.noarch libgovirt-0.3.3-1.el7_2.1.x86_64 ovirt-engine-sdk-python-3.6.5.0-1.el7.centos.noarch ovirt-setup-lib-1.0.1-1.el7.centos.noarch ovirt-vmconsole-1.0.0-1.el7.centos.noarch ovirt-vmconsole-host-1.0.0-1.el7.centos.noarch ovirt-host-deploy-1.4.1-1.el7.centos.noarch ovirt-hosted-engine-ha-1.3.5.3-1.1.el7.noarch [me@host03 ~]$ rpm -qa | grep vdsm vdsm-hook-vmfex-dev-4.17.26-1.el7.noarch vdsm-xmlrpc-4.17.26-1.el7.noarch vdsm-infra-4.17.26-1.el7.noarch vdsm-yajsonrpc-4.17.26-1.el7.noarch vdsm-python-4.17.26-1.el7.noarch vdsm-4.17.26-1.el7.noarch vdsm-cli-4.17.26-1.el7.noarch vdsm-jsonrpc-4.17.26-1.el7.noarch [root@engine ~]# rpm -qa | grep ovirt ovirt-engine-wildfly-8.2.1-1.el7.x86_64 ovirt-engine-setup-plugin-ovirt-engine-common-3.6.5.3-1.el7.centos.noarch ovirt-vmconsole-1.0.0-1.el7.centos.noarch ovirt-engine-cli-3.6.2.0-1.el7.centos.noarch ovirt-engine-setup-plugin-ovirt-engine-3.6.5.3-1.el7.centos.noarch ovirt-engine-backend-3.6.5.3-1.el7.centos.noarch ovirt-iso-uploader-3.6.0-1.el7.centos.noarch ovirt-engine-extensions-api-impl-3.6.5.3-1.el7.centos.noarch ovirt-host-deploy-1.4.1-1.el7.centos.noarch ovirt-release36-007-1.noarch ovirt-engine-sdk-python-3.6.5.0-1.el7.centos.noarch ovirt-image-uploader-3.6.0-1.el7.centos.noarch ovirt-engine-extension-aaa-jdbc-1.0.6-1.el7.noarch ovirt-setup-lib-1.0.1-1.el7.centos.noarch ovirt-host-deploy-java-1.4.1-1.el7.centos.noarch ovirt-engine-setup-base-3.6.5.3-1.el7.centos.noarch ovirt-engine-setup-plugin-websocket-proxy-3.6.5.3-1.el7.centos.noarch ovirt-engine-tools-backup-3.6.5.3-1.el7.centos.noarch ovirt-vmconsole-proxy-1.0.0-1.el7.centos.noarch ovirt-engine-vmconsole-proxy-helper-3.6.5.3-1.el7.centos.noarch ovirt-engine-setup-3.6.5.3-1.el7.centos.noarch ovirt-engine-webadmin-portal-3.6.5.3-1.el7.centos.noarch ovirt-engine-tools-3.6.5.3-1.el7.centos.noarch ovirt-engine-restapi-3.6.5.3-1.el7.centos.noarch ovirt-engine-3.6.5.3-1.el7.centos.noarch ovirt-engine-wildfly-overlay-8.0.5-1.el7.noarch ovirt-engine-lib-3.6.5.3-1.el7.centos.noarch ovirt-engine-websocket-proxy-3.6.5.3-1.el7.centos.noarch ovirt-engine-setup-plugin-vmconsole-proxy-helper-3.6.5.3-1.el7.centos.noarch ovirt-engine-userportal-3.6.5.3-1.el7.centos.noarch ovirt-engine-dbscripts-3.6.5.3-1.el7.centos.noarch Thanks, -- Wee --------------080805070702090104010500 Content-Type: text/html; charset=utf-8 Content-Transfer-Encoding: 7bit <html> <head> <meta http-equiv="content-type" content="text/html; charset=utf-8"> </head> <body bgcolor="#FFFFFF" text="#000000"> Hi, I'm making a fresh hosted-engine installation on 3 hosts. First 2 hosts succeeded, but the 3rd one stuck at termination state "Installing Host hosted_engine_3. Stage: Termination.", then, 3 minutes later, "VDSM hosted_engine_3 command failed: Message timeout which can be caused by communication issues". Currently, the 3rd host status in web UI is stuck at "Installing". How can I proceed? Could I just run <a href="https://www.ovirt.org/documentation/how-to/hosted-engine/#recoving-from-fai…">this script</a> in the 3rd host, and run "hosted-engine --deploy" again? log files: <a class="moz-txt-link-freetext" href="https://app.box.com/s/a5typfe6cbozs9uo9osg68gtmq8793t6">https://app.box.com/s/a5typfe6cbozs9uo9osg68gtmq8793t6</a> [me@host03 ~]$ rpm -qa | grep ovirt ovirt-release36-007-1.noarch ovirt-hosted-engine-setup-1.3.5.0-1.1.el7.noarch libgovirt-0.3.3-1.el7_2.1.x86_64 ovirt-engine-sdk-python-3.6.5.0-1.el7.centos.noarch ovirt-setup-lib-1.0.1-1.el7.centos.noarch ovirt-vmconsole-1.0.0-1.el7.centos.noarch ovirt-vmconsole-host-1.0.0-1.el7.centos.noarch ovirt-host-deploy-1.4.1-1.el7.centos.noarch ovirt-hosted-engine-ha-1.3.5.3-1.1.el7.noarch [me@host03 ~]$ rpm -qa | grep vdsm vdsm-hook-vmfex-dev-4.17.26-1.el7.noarch vdsm-xmlrpc-4.17.26-1.el7.noarch vdsm-infra-4.17.26-1.el7.noarch vdsm-yajsonrpc-4.17.26-1.el7.noarch vdsm-python-4.17.26-1.el7.noarch vdsm-4.17.26-1.el7.noarch vdsm-cli-4.17.26-1.el7.noarch vdsm-jsonrpc-4.17.26-1.el7.noarch [root@engine ~]# rpm -qa | grep ovirt ovirt-engine-wildfly-8.2.1-1.el7.x86_64 ovirt-engine-setup-plugin-ovirt-engine-common-3.6.5.3-1.el7.centos.noarch ovirt-vmconsole-1.0.0-1.el7.centos.noarch ovirt-engine-cli-3.6.2.0-1.el7.centos.noarch ovirt-engine-setup-plugin-ovirt-engine-3.6.5.3-1.el7.centos.noarch ovirt-engine-backend-3.6.5.3-1.el7.centos.noarch ovirt-iso-uploader-3.6.0-1.el7.centos.noarch ovirt-engine-extensions-api-impl-3.6.5.3-1.el7.centos.noarch ovirt-host-deploy-1.4.1-1.el7.centos.noarch ovirt-release36-007-1.noarch ovirt-engine-sdk-python-3.6.5.0-1.el7.centos.noarch ovirt-image-uploader-3.6.0-1.el7.centos.noarch ovirt-engine-extension-aaa-jdbc-1.0.6-1.el7.noarch ovirt-setup-lib-1.0.1-1.el7.centos.noarch ovirt-host-deploy-java-1.4.1-1.el7.centos.noarch ovirt-engine-setup-base-3.6.5.3-1.el7.centos.noarch ovirt-engine-setup-plugin-websocket-proxy-3.6.5.3-1.el7.centos.noarch ovirt-engine-tools-backup-3.6.5.3-1.el7.centos.noarch ovirt-vmconsole-proxy-1.0.0-1.el7.centos.noarch ovirt-engine-vmconsole-proxy-helper-3.6.5.3-1.el7.centos.noarch ovirt-engine-setup-3.6.5.3-1.el7.centos.noarch ovirt-engine-webadmin-portal-3.6.5.3-1.el7.centos.noarch ovirt-engine-tools-3.6.5.3-1.el7.centos.noarch ovirt-engine-restapi-3.6.5.3-1.el7.centos.noarch ovirt-engine-3.6.5.3-1.el7.centos.noarch ovirt-engine-wildfly-overlay-8.0.5-1.el7.noarch ovirt-engine-lib-3.6.5.3-1.el7.centos.noarch ovirt-engine-websocket-proxy-3.6.5.3-1.el7.centos.noarch ovirt-engine-setup-plugin-vmconsole-proxy-helper-3.6.5.3-1.el7.centos.noarch ovirt-engine-userportal-3.6.5.3-1.el7.centos.noarch ovirt-engine-dbscripts-3.6.5.3-1.el7.centos.noarch Thanks, <pre class="moz-signature" cols="72">-- Wee</pre> </body> </html> --------------080805070702090104010500--

3 3

hosted engine setup failed for 10 minutes delay.. engine seems alive
by Gianluca Cecchi 03 May '16

03 May '16

Hello, trying to deploy a self hosted engine on an Intel NUC6i5SYB with CentOS 7.2 using oVirt 3.6.5 and appliance (picked up rpm is ovirt-engine-appliance-3.6-20160420.1.el7.centos.noarch) Near the end of the command hosted-engine --deploy I get ... |- [ INFO ] Initializing PostgreSQL |- [ INFO ] Creating PostgreSQL 'engine' database |- [ INFO ] Configuring PostgreSQL |- [ INFO ] Creating/refreshing Engine database schema |- [ INFO ] Creating/refreshing Engine 'internal' domain database schema [ ERROR ] Engine setup got stuck on the appliance [ ERROR ] Failed to execute stage 'Closing up': Engine setup is stalled on the appliance since 600 seconds ago. Please check its log on the appliance. [ INFO ] Stage: Clean up [ INFO ] Generating answer file '/var/lib/ovirt-hosted-engine-setup/answers/answers-20160430200654.conf' [ INFO ] Stage: Pre-termination [ INFO ] Stage: Termination [ ERROR ] Hosted Engine deployment failed: this system is not reliable, please check the issue, fix and redeploy On host log I indeed see the 10 minutes timeout: 2016-04-30 19:56:52 DEBUG otopi.plugins.otopi.dialog.human dialog.__logString:219 DIALOG:SEND |- [ INFO ] Creating/refreshing Engine 'internal' domain database schema 2016-04-30 20:06:53 ERROR otopi.plugins.ovirt_hosted_engine_setup.engine.health health._closeup:140 Engine setup got stuck on the appliance On engine I don't see any particular problem but a ten minutes delay in its log: 2016-04-30 17:56:57 DEBUG otopi.context context.dumpEnvironment:514 ENVIRONMENT DUMP - END 2016-04-30 17:56:57 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_engine_setup.ovirt_engine.config.aaajdbc.Plugin._setupAdminPassword 2016-04-30 17:56:57 DEBUG otopi.plugins.ovirt_engine_setup.ovirt_engine.config.aaajdbc plugin.executeRaw:828 execute: ('/usr/bin/ovirt-aaa-jdbc-tool', '--db-config=/etc/ovirt-engine/aaa/internal.properties', 'user', 'password-reset', 'admin', '--password=env:pass', '--force', '--password-valid-to=2216-03-13 17:56:57Z'), executable='None', cwd='None', env={'LANG': 'en_US.UTF-8', 'SHLVL': '1', 'PYTHONPATH': '/usr/share/ovirt-engine/setup/bin/..::', 'pass': '**FILTERED**', 'OVIRT_ENGINE_JAVA_HOME_FORCE': '1', 'PWD': '/', 'OVIRT_ENGINE_JAVA_HOME': u'/usr/lib/jvm/jre', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin', 'OTOPI_LOGFILE': '/var/log/ovirt-engine/setup/ovirt-engine-setup-20160430175551-dttt2p.log', 'OVIRT_JBOSS_HOME': '/usr/share/ovirt-engine-wildfly', 'OTOPI_EXECDIR': '/'} 2016-04-30 18:07:06 DEBUG otopi.plugins.ovirt_engine_setup.ovirt_engine.config.aaajdbc plugin.executeRaw:878 execute-result: ('/usr/bin/ovirt-aaa-jdbc-tool', '--db-config=/etc/ovirt-engine/aaa/internal.properties', 'user', 'password-reset', 'admin', '--password=env:pass', '--force', '--password-valid-to=2216-03-13 17:56:57Z'), rc=0 and its last lines are: 2016-04-30 18:07:06 DEBUG otopi.plugins.ovirt_engine_setup.ovirt_engine.config.aaajdbc plugin.execute:936 execute-output: ('/usr/bin/ovirt-aaa-jdbc-tool', '--db-config=/etc/ovirt-engine/aaa/internal.properties', 'user', 'password-reset', 'admin', '--password=env:pass', '--force', '--password-valid-to=2216-03-13 17:56:57Z') stdout: updating user admin... user updated successfully 2016-04-30 18:07:06 DEBUG otopi.plugins.ovirt_engine_setup.ovirt_engine.config.aaajdbc plugin.execute:941 execute-output: ('/usr/bin/ovirt-aaa-jdbc-tool', '--db-config=/etc/ovirt-engine/aaa/internal.properties', 'user', 'password-reset', 'admin', '--password=env:pass', '--force', '--password-valid-to=2216-03-13 17:56:57Z') stderr: 2016-04-30 18:07:06 DEBUG otopi.context context._executeMethod:142 Stage misc METHOD otopi.plugins.ovirt_engine_setup.ovirt_engine.pki.ca.Plugin._miscUpgrade 2016-04-30 18:07:06 INFO otopi.plugins.ovirt_engine_setup.ovirt_engine.pki.ca ca._miscUpgrade:510 Upgrading CA Full logs of host and engine here: https://drive.google.com/file/d/0BwoPbcrMv8mvQm9jeDhpZEdRUjg/view?usp=shari… I can connect via vnc to the engine and see 277 tables in engine database (277 rows in output of "\d" command) Can anyone tell me if I can follow up without starting from scratch and how in case? Also understand the reason of this delay, as the NUC is a physical host with 32Gb of ram and SSD disks and should be quite fast... faster than a VM non my laptop where I had no problems in similar setup... As a last question how to clean up things in case I have to start from scratch. I can leave the situation as it is in the moment, so I can work on the live environment before power off.... Thanks in advance, Gianluca

3 7

Shared storage between DC
by Arsène Gschwind 03 May '16

03 May '16

Hi, Is it possible to have a shared Storage domain between 2 Datacenter in oVirt? We do replicate a FC Volume between 2 datacenter using FC SAN storage technology and we have an oVirt cluster on each site defined in separate DCs. The idea behind this is to setup a DR site and also balance the load between each site. What happens if I do import a storage domain already active in one DC, will it break the Storage domain? Thanks for any information.. Regards, Arsène

3 5