Adding a host (installed from os) from Manager fails

Latest response

This is about RHEV 3 Beta.

 

I am trying to add a host (as an hypervisor) from RHEV 3 Beta Manager.

 

I hope the Hypervisor forum is the right place to put this question.

 

I have a machine with RHEV 3 Beta Manager and I think I have managed to setup an OS like described on: Lab 7 Objetives. 1. Install Red Hat Enterprise Linux Hosts in another machine.

 

Now I want to add the host as another hypervisor.

This is what I do: Select a cluster. Click on Hosts tab. Click on New. The New Host dialog appears. Enter data and click OK.

 

The Manager will try to install or setup the added host as an hypervisor.

 

It fails. I attached the interesting parts of rhevm log (I might attach twice the same error, not sure about that).

The log file is:

/var/log/rhevm/rhevm.log

Relevant content is:

 

2011-12-26 18:25:05,827 INFO  [org.ovirt.engine.core.bll.RemoveVdsCommand] (pool-21-thread-6) Running command: RemoveVdsCommand internal: false. Entities affected :  ID: 3dae9f4e-2fe6-11e1-a460-0200004c618e Type: VDS
2011-12-26 18:25:05,840 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-21-thread-6) START, RemoveVdsVDSCommand(vdsId = 3dae9f4e-2fe6-11e1-a460-0200004c618e), log id: 5364afe4
2011-12-26 18:25:05,840 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (pool-21-thread-6) vdsManager::disposing
2011-12-26 18:25:05,841 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (pool-21-thread-6) FINISH, RemoveVdsVDSCommand, log id: 5364afe4
2011-12-26 18:25:35,225 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (http-0.0.0.0-8443-1) Invoking /bin/echo -e `/bin/bash -c  /usr/sbin/dmidecode|/bin/awk ' /UUID/{ print $2; } ' | /usr/bin/tr '
' '_' && cat /sys/class/net/*/address | /bin/grep -v '00:00:00:00' | /bin/sort -u | /usr/bin/head --lines=1` on hypervisor.mydomain.net
2011-12-26 18:25:35,446 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (http-0.0.0.0-8443-1) RunSSHCommand returns true
2011-12-26 18:25:35,454 INFO  [org.ovirt.engine.core.bll.AddVdsCommand] (http-0.0.0.0-8443-1) Running command: AddVdsCommand internal: false. Entities affected :  ID: 99408929-82cf-4dc7-a532-9d998063fa95 Type: VdsGroups
2011-12-26 18:25:35,491 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (http-0.0.0.0-8443-1) Running command: AddVdsSpmIdCommand internal: true. Entities affected :  ID: 9f03a780-2fe6-11e1-b5c7-0200004c618e Type: VDS
2011-12-26 18:25:35,504 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (http-0.0.0.0-8443-1) Cannot get vdsManager for vdsid=9f03a780-2fe6-11e1-b5c7-0200004c618e
2011-12-26 18:25:35,505 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (http-0.0.0.0-8443-1) START, RemoveVdsVDSCommand(vdsId = 9f03a780-2fe6-11e1-b5c7-0200004c618e), log id: 63fa2e63
2011-12-26 18:25:35,505 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (http-0.0.0.0-8443-1) Cannot get vdsManager for vdsid=9f03a780-2fe6-11e1-b5c7-0200004c618e
2011-12-26 18:25:35,505 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (http-0.0.0.0-8443-1) FINISH, RemoveVdsVDSCommand, log id: 63fa2e63
2011-12-26 18:25:35,507 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (http-0.0.0.0-8443-1) Cannot get vdsManager for vdsid=9f03a780-2fe6-11e1-b5c7-0200004c618e
2011-12-26 18:25:35,507 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http-0.0.0.0-8443-1) START, AddVdsVDSCommand(vdsId = 9f03a780-2fe6-11e1-b5c7-0200004c618e), log id: 3dfb98dc
2011-12-26 18:25:35,507 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http-0.0.0.0-8443-1) AddVds - entered , starting logic to add VDS 9f03a780-2fe6-11e1-b5c7-0200004c618e
2011-12-26 18:25:35,512 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http-0.0.0.0-8443-1) AddVds - VDS 9f03a780-2fe6-11e1-b5c7-0200004c618e was added, will try to add it to the resource manager
2011-12-26 18:25:35,513 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (http-0.0.0.0-8443-1) Eneterd VdsManager:constructor
2011-12-26 18:25:35,513 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (http-0.0.0.0-8443-1) vdsBroker(hypervisor.mydomain.net,54.321)
2011-12-26 18:25:35,516 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (http-0.0.0.0-8443-1) ResourceManager::AddVds - VDS 9f03a780-2fe6-11e1-b5c7-0200004c618e was added to the Resource Manager
2011-12-26 18:25:35,516 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (http-0.0.0.0-8443-1) FINISH, AddVdsVDSCommand, log id: 3dfb98dc
2011-12-26 18:25:35,532 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-21-thread-6) Running command: InstallVdsCommand internal: true. Entities affected :  ID: 9f03a780-2fe6-11e1-b5c7-0200004c618e Type: VDS
2011-12-26 18:25:35,534 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-21-thread-6) Before Installation pool-21-thread-6
2011-12-26 18:25:35,534 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Executing installation stage. (Stage: Starting Host installation)
2011-12-26 18:25:35,534 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Executing installation stage. (Stage: Connecting to Host)
2011-12-26 18:25:35,678 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host hypervisor.mydomain.net with SSH key fingerprint: 70:47:5c:8c:b1:3b:6b:d1:dd:b1:2b:bf:9f:ca:e1:ff'/>. FYI. (Stage: Connecting to Host)
2011-12-26 18:25:35,692 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Successfully connected to server ssh. (Stage: Connecting to Host)
2011-12-26 18:25:35,692 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Executing installation stage. (Stage: Get the unique vds id)
2011-12-26 18:25:35,693 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Invoking /bin/echo -e `/bin/bash -c  /usr/sbin/dmidecode|/bin/awk ' /UUID/{ print $2; } ' | /usr/bin/tr '
' '_' && cat /sys/class/net/*/address | /bin/grep -v '00:00:00:00' | /bin/sort -u | /usr/bin/head --lines=1` on hypervisor.mydomain.net
2011-12-26 18:25:35,884 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Recieved message: F143834F-12EE-4A89-B968-A666EBFBEA50_02:00:00:e9:15:25
. FYI. (Stage: Get the unique vds id)
2011-12-26 18:25:35,891 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Assigning unique id F143834F-12EE-4A89-B968-A666EBFBEA50_02:00:00:e9:15:25 to Host. (Stage: Get the unique vds id)
2011-12-26 18:25:35,894 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) RunSSHCommand returns true
2011-12-26 18:25:35,894 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Executing installation stage. (Stage: Upload Installation script to Host)
2011-12-26 18:25:35,895 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Uploading file /usr/share/rhevm/scripts/vds_installer.py to /tmp/vds_installer_f71ed3b7-cee5-49e9-9ea8-c9c7276c4422.py on hypervisor.mydomain.net
2011-12-26 18:25:35,895 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Uploading file /usr/share/rhevm/scripts/vds_installer.py to /tmp/vds_installer_f71ed3b7-cee5-49e9-9ea8-c9c7276c4422.py on hypervisor.mydomain.net
2011-12-26 18:25:36,393 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. successfully done sftp operation ( Stage: Upload Installation script to Host)
2011-12-26 18:25:36,393 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) return true
2011-12-26 18:25:36,394 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Uploading file /tmp/firewall.conf102516274225215656.tmp to /tmp/firewall.conf.f71ed3b7-cee5-49e9-9ea8-c9c7276c4422 on hypervisor.mydomain.net
2011-12-26 18:25:36,394 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Uploading file /tmp/firewall.conf102516274225215656.tmp to /tmp/firewall.conf.f71ed3b7-cee5-49e9-9ea8-c9c7276c4422 on hypervisor.mydomain.net
2011-12-26 18:25:36,733 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. successfully done sftp operation ( Stage: Upload Installation script to Host)
2011-12-26 18:25:36,733 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) return true
2011-12-26 18:25:36,734 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Executing installation stage. (Stage: Running first installation script on Host)
2011-12-26 18:25:36,734 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Sending SSH Command chmod +x /tmp/vds_installer_f71ed3b7-cee5-49e9-9ea8-c9c7276c4422.py; /tmp/vds_installer_f71ed3b7-cee5-49e9-9ea8-c9c7276c4422.py -c 'ssl=true;management_port=54321' -O 'manager.mydomain.net'  -t 2011-12-26T17:25:35 -u False -f /tmp/firewall.conf.f71ed3b7-cee5-49e9-9ea8-c9c7276c4422 -p 8080 http://manager.mydomain.net:8080/Components/vds/ http://manager.mydomain.net:8080/Components/vds/ hypervisor.mydomain.net f71ed3b7-cee5-49e9-9ea8-c9c7276c4422 False. (Stage: Running first installation script on Host)
2011-12-26 18:25:36,734 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Invoking chmod +x /tmp/vds_installer_f71ed3b7-cee5-49e9-9ea8-c9c7276c4422.py; /tmp/vds_installer_f71ed3b7-cee5-49e9-9ea8-c9c7276c4422.py -c 'ssl=true;management_port=54321' -O 'manager.mydomain.net'  -t 2011-12-26T17:25:35 -u False -f /tmp/firewall.conf.f71ed3b7-cee5-49e9-9ea8-c9c7276c4422 -p 8080 http://manager.mydomain.net:8080/Components/vds/ http://manager.mydomain.net:8080/Components/vds/ hypervisor.mydomain.net f71ed3b7-cee5-49e9-9ea8-c9c7276c4422 False on hypervisor.mydomain.net
2011-12-26 18:25:37,536 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-20) Initializing Host: hypervisor.mydomain.net
2011-12-26 18:25:37,735 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Recieved message: <BSTRAP component='INSTALLER' status='OK' message='Test platform succeeded'/>
<BSTRAP component='INSTALLER LIB' status='OK' message='deployUtil.py download succeeded'/>
<BSTRAP component='INSTALLER' status='OK' message='vds_bootstrap.py download succeeded'/>
. FYI. (Stage: Running first installation script on Host)
2011-12-26 18:25:38,193 ERROR [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Recieved message: <BSTRAP component='RHN_REGISTRATION' status='OK' message='Host properly registered with RHN/Satellite.'/>
<BSTRAP component='VDSM_MAJOR_VER' status='OK' message='Available VDSM matches requirements'/>
<BSTRAP component='VT_SVM' status='FAIL' processor='AMD' message='Server does not support virtualization'/>
<BSTRAP component='RHEV_INSTALL' status='FAIL'/>
. Error occured. (Stage: Running first installation script on Host)
2011-12-26 18:25:38,239 ERROR [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) Repository rhel-source is listed more than once in the configuration
Repository rhel-source-beta is listed more than once in the configuration
Repository rhel-source is listed more than once in the configuration
Repository rhel-source-beta is listed more than once in the configuration

2011-12-26 18:25:38,239 ERROR [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Error: Repository rhel-source is listed more than once in the configuration
Repository rhel-source-beta is listed more than once in the configuration
Repository rhel-source is listed more than once in the configuration
Repository rhel-source-beta is listed more than once in the configuration
. (Stage: Running first installation script on Host)
2011-12-26 18:25:38,240 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (pool-21-thread-6) VDS message: Repository rhel-source is listed more than once in the configuration
2011-12-26 18:25:38,240 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (pool-21-thread-6) VDS message: Repository rhel-source-beta is listed more than once in the configuration
2011-12-26 18:25:38,240 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (pool-21-thread-6) VDS message: Repository rhel-source is listed more than once in the configuration
2011-12-26 18:25:38,240 INFO  [org.ovirt.engine.core.bll.InstallerMessages] (pool-21-thread-6) VDS message: Repository rhel-source-beta is listed more than once in the configuration
2011-12-26 18:25:38,240 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-21-thread-6) RunSSHCommand returns true
2011-12-26 18:25:38,240 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6)  RunScript ended:true
2011-12-26 18:25:38,240 ERROR [org.ovirt.engine.core.bll.VdsInstaller] (pool-21-thread-6) Installation of hypervisor.mydomain.net. Operation failure. (Stage: Running first installation script on Host)
2011-12-26 18:25:38,241 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-21-thread-6) After Installation pool-21-thread-6
2011-12-26 18:25:38,243 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-21-thread-6) START, SetVdsStatusVDSCommand(vdsId = 9f03a780-2fe6-11e1-b5c7-0200004c618e, status=InstallFailed, nonOperationalReason=NONE), log id: 285e3f1e
2011-12-26 18:25:38,262 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-21-thread-6) FINISH, SetVdsStatusVDSCommand, log id: 285e3f1e
2011-12-26 18:34:16,447 INFO  [org.ovirt.engine.core.bll.DbUserCacheManager] (QuartzScheduler_Worker-32) DbUserCacheManager::refreshAllUserData() - entered
2011-12-26 19:04:47,161 WARN  [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-21-thread-6) Client did not poll async queries updates for 30 cycles, suspending server side updates for session id = 9423A4F1621CCE4E436BB8299ED6D600
2011-12-26 19:04:48,164 WARN  [org.ovirt.engine.core.bll.BackendCallBacksDirector] (pool-21-thread-6) Client did not poll async queries updates for 30 cycles sessionId = 9423A4F1621CCE4E436BB8299ED6D600. Callback will be removed.

What should I try to fix first on the hypervisor to try again to add the host?

 

Thank you very much!

 

 

Responses