[Users] ovirt3.1 add node error

tian b tianb87 at me.com
Mon Jun 25 09:54:58 UTC 2012


Dear,all
	Can you help me?


# tail /var/log/ovirt-engine/engine.log -f
2012-06-25 17:50:42,796 INFO  [org.ovirt.engine.core.utils.hostinstall.HostKeyVerifier] (NioProcessor-21) SSH key fingerprint b4:f3:b9:4b:93:40:e8:9e:57:fc:b3:fe:b3:af:13:b4 for host 172.30.1.63 (172.30.1.63) has been successfully verified.
2012-06-25 17:50:42,872 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (ajp--0.0.0.0-8009-3) 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 172.30.1.63
2012-06-25 17:50:42,959 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (ajp--0.0.0.0-8009-3) RunSSHCommand returns true
2012-06-25 17:50:42,985 INFO  [org.ovirt.engine.core.bll.AddVdsCommand] (ajp--0.0.0.0-8009-3) [7d335777] Running command: AddVdsCommand internal: false. Entities affected :  ID: 99408929-82cf-4dc7-a532-9d998063fa95 Type: VdsGroups
2012-06-25 17:50:43,017 INFO  [org.ovirt.engine.core.bll.AddVdsSpmIdCommand] (ajp--0.0.0.0-8009-3) [318b963a] Running command: AddVdsSpmIdCommand internal: true. Entities affected :  ID: 3a9d9a40-beab-11e1-9366-525400fe2d56 Type: VDS
2012-06-25 17:50:43,048 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--0.0.0.0-8009-3) [318b963a] Cannot get vdsManager for vdsid=3a9d9a40-beab-11e1-9366-525400fe2d56
2012-06-25 17:50:43,049 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--0.0.0.0-8009-3) [318b963a] START, RemoveVdsVDSCommand(vdsId = 3a9d9a40-beab-11e1-9366-525400fe2d56), log id: 7bd4b2c7
2012-06-25 17:50:43,051 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--0.0.0.0-8009-3) [318b963a] Cannot get vdsManager for vdsid=3a9d9a40-beab-11e1-9366-525400fe2d56
2012-06-25 17:50:43,052 INFO  [org.ovirt.engine.core.vdsbroker.RemoveVdsVDSCommand] (ajp--0.0.0.0-8009-3) [318b963a] FINISH, RemoveVdsVDSCommand, log id: 7bd4b2c7
2012-06-25 17:50:43,053 ERROR [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--0.0.0.0-8009-3) [318b963a] Cannot get vdsManager for vdsid=3a9d9a40-beab-11e1-9366-525400fe2d56
2012-06-25 17:50:43,054 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--0.0.0.0-8009-3) [318b963a] START, AddVdsVDSCommand(vdsId = 3a9d9a40-beab-11e1-9366-525400fe2d56), log id: 49256654
2012-06-25 17:50:43,056 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--0.0.0.0-8009-3) [318b963a] AddVds - entered , starting logic to add VDS 3a9d9a40-beab-11e1-9366-525400fe2d56
2012-06-25 17:50:43,059 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--0.0.0.0-8009-3) [318b963a] AddVds - VDS 3a9d9a40-beab-11e1-9366-525400fe2d56 was added, will try to add it to the resource manager
2012-06-25 17:50:43,062 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--0.0.0.0-8009-3) [318b963a] Eneterd VdsManager:constructor
2012-06-25 17:50:43,063 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (ajp--0.0.0.0-8009-3) [318b963a] vdsBroker(172.30.1.63,54,321)
2012-06-25 17:50:43,065 INFO  [org.ovirt.engine.core.vdsbroker.ResourceManager] (ajp--0.0.0.0-8009-3) [318b963a] ResourceManager::AddVds - VDS 3a9d9a40-beab-11e1-9366-525400fe2d56 was added to the Resource Manager
2012-06-25 17:50:43,067 INFO  [org.ovirt.engine.core.vdsbroker.AddVdsVDSCommand] (ajp--0.0.0.0-8009-3) [318b963a] FINISH, AddVdsVDSCommand, log id: 49256654
2012-06-25 17:50:43,098 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-49) [44a5dc80] Running command: InstallVdsCommand internal: true. Entities affected :  ID: 3a9d9a40-beab-11e1-9366-525400fe2d56 Type: VDS
2012-06-25 17:50:43,102 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-49) [44a5dc80] Before Installation pool-3-thread-49
2012-06-25 17:50:43,103 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Executing installation stage. (Stage: Starting Host installation)
2012-06-25 17:50:43,105 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Executing installation stage. (Stage: Connecting to Host)
2012-06-25 17:50:43,134 INFO  [org.ovirt.engine.core.utils.hostinstall.HostKeyVerifier] (NioProcessor-27) SSH key fingerprint b4:f3:b9:4b:93:40:e8:9e:57:fc:b3:fe:b3:af:13:b4 for host 172.30.1.63 (172.30.1.63) has been successfully verified.
2012-06-25 17:50:43,206 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host 172.30.1.63 with SSH key fingerprint: b4:f3:b9:4b:93:40:e8:9e:57:fc:b3:fe:b3:af:13:b4'/>. FYI. (Stage: Connecting to Host)
2012-06-25 17:50:43,223 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Successfully connected to server ssh. (Stage: Connecting to Host)
2012-06-25 17:50:43,224 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Executing installation stage. (Stage: Get the unique vds id)
2012-06-25 17:50:43,225 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) 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 172.30.1.63
2012-06-25 17:50:43,292 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Recieved message: 00010000-FE01-0300-00C4-43504C4400C7_00:23:8b:65:08:90
. FYI. (Stage: Get the unique vds id)
2012-06-25 17:50:43,306 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Assigning unique id 00010000-FE01-0300-00C4-43504C4400C7_00:23:8b:65:08:90 to Host. (Stage: Get the unique vds id)
2012-06-25 17:50:43,311 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) RunSSHCommand returns true
2012-06-25 17:50:43,316 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Executing installation stage. (Stage: Upload Installation script to Host)
2012-06-25 17:50:43,325 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) Uploading file /usr/share/ovirt-engine/scripts/vds_installer.py to /tmp/vds_installer_2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6.py on 172.30.1.63
2012-06-25 17:50:43,335 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) Uploading file /usr/share/ovirt-engine/scripts/vds_installer.py to /tmp/vds_installer_2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6.py on 172.30.1.63
2012-06-25 17:50:43,668 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. successfully done sftp operation ( Stage: Upload Installation script to Host)
2012-06-25 17:50:43,674 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) return true
2012-06-25 17:50:43,676 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) Uploading file /tmp/firewall.conf4248057098344742688.tmp to /tmp/firewall.conf.2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6 on 172.30.1.63
2012-06-25 17:50:43,678 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) Uploading file /tmp/firewall.conf4248057098344742688.tmp to /tmp/firewall.conf.2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6 on 172.30.1.63
2012-06-25 17:50:43,965 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. successfully done sftp operation ( Stage: Upload Installation script to Host)
2012-06-25 17:50:43,966 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) return true
2012-06-25 17:50:43,967 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Executing installation stage. (Stage: Running first installation script on Host)
2012-06-25 17:50:43,968 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Sending SSH Command chmod +x /tmp/vds_installer_2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6.py; /tmp/vds_installer_2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6.py -c 'ssl=true;management_port=54321' -O 'oVirt' -t 2012-06-25T09:50:43 -f /tmp/firewall.conf.2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6 -p 80 -b   http://fedora17.kvm.com:80/Components/vds/ http://fedora17.kvm.com:80/Components/vds/ 172.30.1.63 2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6 False. (Stage: Running first installation script on Host)
2012-06-25 17:50:43,971 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) Invoking chmod +x /tmp/vds_installer_2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6.py; /tmp/vds_installer_2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6.py -c 'ssl=true;management_port=54321' -O 'oVirt' -t 2012-06-25T09:50:43 -f /tmp/firewall.conf.2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6 -p 80 -b   http://fedora17.kvm.com:80/Components/vds/ http://fedora17.kvm.com:80/Components/vds/ 172.30.1.63 2ea9f19e-7e9d-46a5-bdfb-dc86532c1fe6 False on 172.30.1.63
2012-06-25 17:50:44,040 WARN  [org.ovirt.engine.core.ServletUtils] (ajp--0.0.0.0-8009-5) File "/usr/share/vdsm-bootstrap/vds_bootstrap.py is 33883 bytes long. Please reconsider using this servlet for files larger than 8192 bytes.
2012-06-25 17:50:44,976 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='oVirt Node DETECTED'/>
<BSTRAP component='INSTALLER LIB' status='OK' message='Install library already exists'/>
<BSTRAP component='INSTALLER' status='OK' message='vds_bootstrap.py download succeeded'/>
. FYI. (Stage: Running first installation script on Host)
2012-06-25 17:50:45,067 INFO  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-55) Initializing Host: node3.kvm.com
2012-06-25 17:50:45,345 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80] Installation of 172.30.1.63. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='RHEV-H ACCESSIBLE'/>
. Stage completed. (Stage: Running first installation script on Host)
2012-06-25 17:50:45,362 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-49) RunSSHCommand returns true
2012-06-25 17:50:45,369 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-49) [44a5dc80]  RunScript ended:true
2012-06-25 17:50:45,369 INFO  [org.ovirt.engine.core.bll.RegisterVdsQuery] (ajp--0.0.0.0-8009-1) Running Command: RegisterVds
2012-06-25 17:50:45,378 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-49) [44a5dc80] After Installation pool-3-thread-49
2012-06-25 17:50:45,388 INFO  [org.ovirt.engine.core.bll.ApproveVdsCommand] (pool-3-thread-50) [40044463] Running command: ApproveVdsCommand internal: true. Entities affected :  ID: 3a9d9a40-beab-11e1-9366-525400fe2d56 Type: VDS
2012-06-25 17:50:45,390 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-50) [40044463] Before Installation pool-3-thread-50, Powerclient/oVirtNode case: setting status to installing
2012-06-25 17:50:45,393 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-3-thread-50) [40044463] START, SetVdsStatusVDSCommand(vdsId = 3a9d9a40-beab-11e1-9366-525400fe2d56, status=Installing, nonOperationalReason=NONE), log id: ee6f19
2012-06-25 17:50:45,395 INFO  [org.ovirt.engine.core.register.RegisterServlet] (ajp--0.0.0.0-8009-1) Succeeded to run RegisterVds.
2012-06-25 17:50:45,407 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-3-thread-50) [40044463] FINISH, SetVdsStatusVDSCommand, log id: ee6f19
2012-06-25 17:50:45,418 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-50) [40044463] Before Installation pool-3-thread-50
2012-06-25 17:50:45,424 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Starting Host installation)
2012-06-25 17:50:45,432 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Connecting to Host)
2012-06-25 17:50:45,471 INFO  [org.ovirt.engine.core.utils.hostinstall.HostKeyVerifier] (NioProcessor-33) SSH key fingerprint b4:f3:b9:4b:93:40:e8:9e:57:fc:b3:fe:b3:af:13:b4 for host 172.30.1.63 (172.30.1.63) has been successfully verified.
2012-06-25 17:50:45,556 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Recieved message: <BSTRAP component='RHEV_INSTALL' status='OK' message='Connected to Host 172.30.1.63 with SSH key fingerprint: b4:f3:b9:4b:93:40:e8:9e:57:fc:b3:fe:b3:af:13:b4'/>. FYI. (Stage: Connecting to Host)
2012-06-25 17:50:45,580 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Successfully connected to server ssh. (Stage: Connecting to Host)
2012-06-25 17:50:45,588 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Running first installation script on Host)
2012-06-25 17:50:45,590 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Invoking /usr/share/vdsm-reg/vdsm-gen-cert -O "oVirt" 172.30.1.63 97174773-9fa8-46af-9e31-46307330aeac on 172.30.1.63


2012-06-25 17:50:56,379 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Recieved message: <BSTRAP component='Encryption setup' status='OK'/>
<BSTRAP component='RHEV_INSTALL' status='OK'/>
. Stage completed. (Stage: Running first installation script on Host)
2012-06-25 17:50:56,393 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) RunSSHCommand returns true
2012-06-25 17:50:56,394 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Downloading certificate request from Host)
2012-06-25 17:50:56,395 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Downloading file /tmp/cert_97174773-9fa8-46af-9e31-46307330aeac.req from 172.30.1.63 to /etc/pki/ovirt-engine/requests/cert_97174773-9fa8-46af-9e31-46307330aeac.req
2012-06-25 17:50:56,680 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. successfully done sftp operation ( Stage: Downloading certificate request from Host)
2012-06-25 17:50:56,688 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) return true
2012-06-25 17:50:56,693 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463]  DownloadCertificateRequest ended:true
2012-06-25 17:50:56,699 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Sign certificate request and generate certificate)
2012-06-25 17:50:57,713 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463]  SignCertificateRequest ended:true
2012-06-25 17:50:57,718 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Upload signed sertificate to Host)
2012-06-25 17:50:57,724 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Uploading file /etc/pki/ovirt-engine/certs/172.30.1.63cert.pem to /tmp/cert_97174773-9fa8-46af-9e31-46307330aeac.pem on 172.30.1.63
2012-06-25 17:50:57,726 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Uploading file /etc/pki/ovirt-engine/certs/172.30.1.63cert.pem to /tmp/cert_97174773-9fa8-46af-9e31-46307330aeac.pem on 172.30.1.63

2012-06-25 17:50:57,988 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. successfully done sftp operation ( Stage: Upload signed sertificate to Host)
2012-06-25 17:50:57,989 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) return true
2012-06-25 17:50:57,990 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463]  UploadSignedCertificate ended:true
2012-06-25 17:50:57,991 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage. (Stage: Upload Cerficate Autority to Host)
2012-06-25 17:50:57,992 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Uploading file /etc/pki/ovirt-engine/ca.pem to /tmp/CA_97174773-9fa8-46af-9e31-46307330aeac.pem on 172.30.1.63
2012-06-25 17:50:57,994 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Uploading file /etc/pki/ovirt-engine/ca.pem to /tmp/CA_97174773-9fa8-46af-9e31-46307330aeac.pem on 172.30.1.63
2012-06-25 17:50:58,249 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. successfully done sftp operation ( Stage: Upload Cerficate Autority to Host)
2012-06-25 17:50:58,258 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) return true
2012-06-25 17:50:58,263 INFO  [org.ovirt.engine.core.bll.CBCInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Executing oVirt installation stage, sending SSH Command /usr/share/vdsm-reg/vdsm-complete -c 'ssl=true' 97174773-9fa8-46af-9e31-46307330aeac 0. (Stage: Running second installation script on Host)
2012-06-25 17:50:58,267 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) Invoking /usr/share/vdsm-reg/vdsm-complete -c 'ssl=true' 97174773-9fa8-46af-9e31-46307330aeac 0 on 172.30.1.63


2012-06-25 17:51:02,269 INFO  [org.ovirt.engine.core.bll.VdsInstaller] (pool-3-thread-50) [40044463] Installation of 172.30.1.63. Recieved message: <BSTRAP component='instCert' status='OK'/>
<BSTRAP component='CoreDump' status='OK'/>
<BSTRAP component='cleanAll' status='OK'/>
<BSTRAP component='VDS Configuration' status='OK'/>
<BSTRAP component='Restart' status='OK' message='Restarting vdsmd service' />
<BSTRAP component='RHEV_INSTALL' status='OK'/>
. Stage completed. (Stage: Running second installation script on Host)
2012-06-25 17:51:02,317 INFO  [org.ovirt.engine.core.utils.hostinstall.MinaInstallWrapper] (pool-3-thread-50) RunSSHCommand returns true

2012-06-25 17:51:02,318 INFO  [org.ovirt.engine.core.bll.InstallVdsCommand] (pool-3-thread-50) [40044463] After Installation pool-3-thread-50
2012-06-25 17:51:02,319 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-3-thread-50) [40044463] START, SetVdsStatusVDSCommand(vdsId = 3a9d9a40-beab-11e1-9366-525400fe2d56, status=NonResponsive, nonOperationalReason=NONE), log id: 513cfcb8
2012-06-25 17:51:02,343 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-3-thread-50) [40044463] FINISH, SetVdsStatusVDSCommand, log id: 513cfcb8
2012-06-25 17:51:02,351 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-3-thread-50) [40044463] START, SetVdsStatusVDSCommand(vdsId = 3a9d9a40-beab-11e1-9366-525400fe2d56, status=Unassigned, nonOperationalReason=NONE), log id: 36058f20
2012-06-25 17:51:02,367 INFO  [org.ovirt.engine.core.vdsbroker.SetVdsStatusVDSCommand] (pool-3-thread-50) [40044463] FINISH, SetVdsStatusVDSCommand, log id: 36058f20
2012-06-25 17:51:02,372 INFO  [org.ovirt.engine.core.bll.RegisterVdsQuery] (pool-3-thread-50) [40044463] Approval of oVirt 3a9d9a40-beab-11e1-9366-525400fe2d56 ended successefully. 
2012-06-25 17:51:03,109 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-83) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:03,115 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-83) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 

2012-06-25 17:51:05,127 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-95) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:05,140 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-95) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 

2012-06-25 17:51:07,162 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-76) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:07,170 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-76) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 

2012-06-25 17:51:09,187 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-84) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:09,189 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-84) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 
2012-06-25 17:51:11,202 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-91) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:11,204 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-91) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 

2012-06-25 17:51:13,217 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-88) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:13,219 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-88) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 
2012-06-25 17:51:15,240 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-8) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:15,245 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-8) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 

2012-06-25 17:51:17,260 ERROR [org.ovirt.engine.core.vdsbroker.vdsbroker.VdsBrokerCommand] (QuartzScheduler_Worker-5) XML RPC error in command GetCapabilitiesVDS ( Vds: node3.kvm.com ), the error was: java.util.concurrent.ExecutionException: java.lang.reflect.InvocationTargetException, EOFException: SSL peer shut down incorrectly 
2012-06-25 17:51:17,262 WARN  [org.ovirt.engine.core.vdsbroker.VdsManager] (QuartzScheduler_Worker-5) ResourceManager::refreshVdsRunTimeInfo::Failed to refresh VDS , vds = 3a9d9a40-beab-11e1-9366-525400fe2d56 : node3.kvm.com, VDS Network Error, continuing.
VDSNetworkException: 

# ping node3.kvm.com
PING node3.kvm.com (172.30.1.63) 56(84) bytes of data.
64 bytes from 172.30.1.63: icmp_req=1 ttl=64 time=0.325 ms

# ping `hostname`
PING fedora17-ovirt.kvm.com (172.30.1.30) 56(84) bytes of data.
64 bytes from fedora17-ovirt.kvm.com (172.30.1.30): icmp_req=1 ttl=64 time=0.036 ms

# systemctl status jboss-as.service 
jboss-as.service - The JBoss Application Server
	  Loaded: loaded (/usr/lib/systemd/system/jboss-as.service; enabled)
	  Active: active (running) since Mon, 25 Jun 2012 17:29:06 +0800; 24min ago
	Main PID: 4873 (standalone.sh)
	  CGroup: name=systemd:/system/jboss-as.service
		  ├ 4873 /bin/sh /usr/share/jboss-as/bin/standalone.sh -c standalone-web.xml
		  └ 4925 java -D[Standalone] -server -XX:+UseCompressedOops -XX:+TieredCompilation -Xms64m -Xmx512m -XX:MaxPermSize=256m -Djava.net.preferIPv4Stack=true -Dorg.j...

# systemctl status libvirtd.service 
libvirtd.service - Virtualization daemon
	  Loaded: loaded (/usr/lib/systemd/system/libvirtd.service; enabled)
	  Active: active (running) since Mon, 25 Jun 2012 17:10:36 +0800; 43min ago
	Main PID: 3567 (libvirtd)
	  CGroup: name=systemd:/system/libvirtd.service
		  └ 3567 /usr/sbin/libvirtd --listen

Jun 25 17:10:36 fedora17-ovirt.kvm.com libvirtd[3567]: Could not find keytab file: /etc/libvirt/krb5.tab: No such file or directory
Jun 25 17:10:36 fedora17-ovirt.kvm.com libvirtd[3567]: server add_plugin entry_point error generic failure
Jun 25 17:10:36 fedora17-ovirt.kvm.com libvirtd[3567]: _sasl_plugin_load failed on sasl_server_plug_init for plugin: gssapiv2


# systemctl status vdsmd.service
vdsmd.service - Virtual Desktop Server Manager
	  Loaded: loaded (/usr/lib/systemd/system/vdsmd.service; enabled)
	  Active: active (running) since Mon, 25 Jun 2012 17:22:22 +0800; 31min ago
	Main PID: 4630 (respawn)
	  CGroup: name=systemd:/system/vdsmd.service
		  ├ 4630 /bin/bash -e /usr/share/vdsm/respawn --minlifetime 10 --daemon --masterpid /var/run/vdsm/respawn.pid /usr/share/vdsm/vdsm
		  ├ 4633 /usr/bin/python /usr/share/vdsm/vdsm
		  ├ 4653 /usr/bin/sudo -n /usr/bin/python /usr/share/vdsm/supervdsmServer.py 3eaebf05-cc78-4d61-abfe-9e675fcaf1b8 4633
		  └ 4654 /usr/bin/python /usr/share/vdsm/supervdsmServer.py 3eaebf05-cc78-4d61-abfe-9e675fcaf1b8 4633

Jun 25 17:22:20 fedora17-ovirt.kvm.com systemd-vdsmd[4396]: Starting iscsid:
Jun 25 17:22:20 fedora17-ovirt.kvm.com systemd-vdsmd[4396]: Starting libvirtd (via systemctl):  [  OK  ]
Jun 25 17:22:21 fedora17-ovirt.kvm.com systemd-vdsmd[4396]: Starting up vdsm daemon:
Jun 25 17:22:21 fedora17-ovirt.kvm.com runuser[4627]: pam_unix(runuser:session): session opened for user vdsm by (uid=0)
Jun 25 17:22:21 fedora17-ovirt.kvm.com runuser[4627]: pam_unix(runuser:session): session closed for user vdsm
Jun 25 17:22:22 fedora17-ovirt.kvm.com systemd-vdsmd[4396]: [27B blob data]
Jun 25 17:22:22 fedora17-ovirt.kvm.com python[4633]: DIGEST-MD5 client step 2
Jun 25 17:22:22 fedora17-ovirt.kvm.com python[4633]: DIGEST-MD5 client step 2
Jun 25 17:22:22 fedora17-ovirt.kvm.com python[4633]: DIGEST-MD5 client step 3
Jun 25 17:22:25 fedora17-ovirt.kvm.com vdsm[4633]: vdsm vds ERROR Unable to load the rest server module. Please make sure it is installed.






More information about the Users mailing list