[ovirt-users] ovirt 3.6 Failed to execute stage 'Environment setup'

This is an OpenPGP/MIME signed message (RFC 4880 and 3156) --3W6fXveMv22FLGti6dq6jEIOIdx6nU7sR Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable Hi, I'm trying to test a self hosted engine oVirt 3.6 setup on a CentOS 7.1 minimal installation. But it fails quite early after running hosted-engine --deploy with [ ERROR ] Failed to execute stage 'Environment setup': <Fault 1: "<type 'exceptions.TypeError'>:cannot marshal None unless allow_none is enabled"> So far I've followed the repository installation instructions as mentioned on http://www.ovirt.org/OVirt_3.6_Release_Management, and added the current gluster repo to the default minimal CentOS 7.1 setup. The output of hosted-engine --deploy is as follows: # hosted-engine --deploy [ INFO ] Stage: Initializing [ INFO ] Generating a temporary VNC password. [ INFO ] Stage: Environment setup Continuing will configure this host for serving as hypervisor and create a VM where you have to install oVirt Engine afterwards. Are you sure you want to continue? (Yes, No)[Yes]: Configuration files: [] Log file: /var/log/ovirt-hosted-engine-setup/ovirt-hosted-engine-setup-201508311232= 58-w2syys.log Version: otopi-1.4.0_master (otopi-1.4.0-0.0.master.20150727232243.git04fa8c9.el7) It has been detected that this program is executed through an SSH connection without using screen. Continuing with the installation may lead to broken installation if the network connection fails. It is highly recommended to abort the installation and run it inside a screen session using command "screen". Do you want to continue anyway? (Yes, No)[No]: yes [ INFO ] Hardware supports virtualization [ INFO ] Stage: Environment packages setup [ INFO ] Stage: Programs detection [ INFO ] Stage: Environment setup [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ INFO ] Waiting for VDSM hardware info [ ERROR ] Failed to execute stage 'Environment setup': <Fault 1: "<type 'exceptions.TypeError'>:cannot marshal None unless allow_none is enabled"> [ INFO ] Stage: Clean up [ INFO ] Generating answer file '/var/lib/ovirt-hosted-engine-setup/answers/answers-20150831123315.conf' [ INFO ] Stage: Pre-termination [ INFO ] Stage: Termination The VDSM log shows that it fails to run dmidecode to gather hardware information. I've had the same issue with oVirt 3.5 but the access restriction to /dev/mem is kernel imposed so I'm not sure what to make of it since this kernel option is enabled on all the systems I've tested by default. There seem to be some gluster packages missing but I'm guessing that's not the problem at hand. I'm not sure what to search for in the logs so I'm kind of stuck as to what to try next. Any help is greatly appreciated. All the best Richard The rest of the VDSM log during the hosted-engine setup is as follows: BindingXMLRPC::INFO::2015-08-31 12:32:33,395::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47391 Thread-51::INFO::2015-08-31 12:32:33,396::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47391 started Thread-51::INFO::2015-08-31 12:32:33,399::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47391 stopped Reactor thread::INFO::2015-08-31 12:32:48,416::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47392 Reactor thread::DEBUG::2015-08-31 12:32:48,428::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:32:48,429::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47392 Reactor thread::DEBUG::2015-08-31 12:32:48,429::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47392) BindingXMLRPC::INFO::2015-08-31 12:32:48,429::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47392 Thread-52::INFO::2015-08-31 12:32:48,430::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47392 started Thread-52::INFO::2015-08-31 12:32:48,434::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47392 stopped Reactor thread::INFO::2015-08-31 12:33:03,452::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47393 Reactor thread::DEBUG::2015-08-31 12:33:03,464::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:03,465::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47393 Reactor thread::DEBUG::2015-08-31 12:33:03,465::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47393) BindingXMLRPC::INFO::2015-08-31 12:33:03,465::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47393 Thread-53::INFO::2015-08-31 12:33:03,466::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47393 started Thread-53::INFO::2015-08-31 12:33:03,469::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47393 stopped Reactor thread::INFO::2015-08-31 12:33:04,772::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47394 Reactor thread::DEBUG::2015-08-31 12:33:04,783::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:04,783::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47394 Reactor thread::DEBUG::2015-08-31 12:33:04,784::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47394) BindingXMLRPC::INFO::2015-08-31 12:33:04,784::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47394 Thread-54::INFO::2015-08-31 12:33:04,786::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47394 started Thread-54::DEBUG::2015-08-31 12:33:04,787::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-54::ERROR::2015-08-31 12:33:04,791::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-54::DEBUG::2015-08-31 12:33:04,793::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-54::INFO::2015-08-31 12:33:04,795::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47394 stopped Reactor thread::INFO::2015-08-31 12:33:05,798::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47395 Reactor thread::DEBUG::2015-08-31 12:33:05,812::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:05,812::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47395 Reactor thread::DEBUG::2015-08-31 12:33:05,812::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47395) BindingXMLRPC::INFO::2015-08-31 12:33:05,813::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47395 Thread-55::INFO::2015-08-31 12:33:05,814::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47395 started Thread-55::DEBUG::2015-08-31 12:33:05,815::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-55::ERROR::2015-08-31 12:33:05,818::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-55::DEBUG::2015-08-31 12:33:05,818::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-55::INFO::2015-08-31 12:33:05,821::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47395 stopped Reactor thread::INFO::2015-08-31 12:33:06,824::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47396 Reactor thread::DEBUG::2015-08-31 12:33:06,836::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:06,836::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47396 Reactor thread::DEBUG::2015-08-31 12:33:06,837::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47396) BindingXMLRPC::INFO::2015-08-31 12:33:06,837::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47396 Thread-56::INFO::2015-08-31 12:33:06,838::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47396 started Thread-56::DEBUG::2015-08-31 12:33:06,839::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-56::ERROR::2015-08-31 12:33:06,842::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-56::DEBUG::2015-08-31 12:33:06,842::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-56::INFO::2015-08-31 12:33:06,844::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47396 stopped Reactor thread::INFO::2015-08-31 12:33:07,847::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47397 Reactor thread::DEBUG::2015-08-31 12:33:07,859::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:07,859::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47397 Reactor thread::DEBUG::2015-08-31 12:33:07,860::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47397) BindingXMLRPC::INFO::2015-08-31 12:33:07,860::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47397 Thread-57::INFO::2015-08-31 12:33:07,861::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47397 started Thread-57::DEBUG::2015-08-31 12:33:07,862::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-57::ERROR::2015-08-31 12:33:07,865::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-57::DEBUG::2015-08-31 12:33:07,865::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-57::INFO::2015-08-31 12:33:07,867::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47397 stopped Reactor thread::INFO::2015-08-31 12:33:08,870::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47398 Reactor thread::DEBUG::2015-08-31 12:33:08,881::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:08,882::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47398 Reactor thread::DEBUG::2015-08-31 12:33:08,882::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47398) BindingXMLRPC::INFO::2015-08-31 12:33:08,882::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47398 Thread-58::INFO::2015-08-31 12:33:08,884::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47398 started Thread-58::DEBUG::2015-08-31 12:33:08,885::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-58::ERROR::2015-08-31 12:33:08,887::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-58::DEBUG::2015-08-31 12:33:08,888::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-58::INFO::2015-08-31 12:33:08,890::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47398 stopped Reactor thread::INFO::2015-08-31 12:33:09,892::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47399 Reactor thread::DEBUG::2015-08-31 12:33:09,904::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:09,904::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47399 Reactor thread::DEBUG::2015-08-31 12:33:09,905::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47399) BindingXMLRPC::INFO::2015-08-31 12:33:09,905::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47399 Thread-59::INFO::2015-08-31 12:33:09,906::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47399 started Thread-59::DEBUG::2015-08-31 12:33:09,907::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-59::ERROR::2015-08-31 12:33:09,909::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-59::DEBUG::2015-08-31 12:33:09,910::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-59::INFO::2015-08-31 12:33:09,912::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47399 stopped Reactor thread::INFO::2015-08-31 12:33:10,914::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47400 Reactor thread::DEBUG::2015-08-31 12:33:10,926::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:10,926::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47400 Reactor thread::DEBUG::2015-08-31 12:33:10,927::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47400) BindingXMLRPC::INFO::2015-08-31 12:33:10,927::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47400 Thread-60::INFO::2015-08-31 12:33:10,928::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47400 started Thread-60::DEBUG::2015-08-31 12:33:10,929::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-60::ERROR::2015-08-31 12:33:10,931::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-60::DEBUG::2015-08-31 12:33:10,932::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-60::INFO::2015-08-31 12:33:10,934::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47400 stopped Reactor thread::INFO::2015-08-31 12:33:11,936::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47401 Reactor thread::DEBUG::2015-08-31 12:33:11,948::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:11,948::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47401 Reactor thread::DEBUG::2015-08-31 12:33:11,948::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47401) BindingXMLRPC::INFO::2015-08-31 12:33:11,949::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47401 Thread-61::INFO::2015-08-31 12:33:11,949::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47401 started Thread-61::DEBUG::2015-08-31 12:33:11,950::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-61::ERROR::2015-08-31 12:33:11,953::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-61::DEBUG::2015-08-31 12:33:11,954::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-61::INFO::2015-08-31 12:33:11,955::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47401 stopped Reactor thread::INFO::2015-08-31 12:33:12,958::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47402 Reactor thread::DEBUG::2015-08-31 12:33:12,969::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:12,970::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47402 Reactor thread::DEBUG::2015-08-31 12:33:12,970::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47402) BindingXMLRPC::INFO::2015-08-31 12:33:12,970::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47402 Thread-62::INFO::2015-08-31 12:33:12,971::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47402 started Thread-62::DEBUG::2015-08-31 12:33:12,972::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-62::ERROR::2015-08-31 12:33:12,975::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-62::DEBUG::2015-08-31 12:33:12,976::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-62::INFO::2015-08-31 12:33:12,977::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47402 stopped Reactor thread::INFO::2015-08-31 12:33:13,980::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47403 Reactor thread::DEBUG::2015-08-31 12:33:13,991::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:13,992::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47403 Reactor thread::DEBUG::2015-08-31 12:33:13,992::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47403) BindingXMLRPC::INFO::2015-08-31 12:33:13,993::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47403 Thread-63::INFO::2015-08-31 12:33:13,994::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47403 started Thread-63::DEBUG::2015-08-31 12:33:13,995::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getHardwareInfo with () {} Thread-63::ERROR::2015-08-31 12:33:13,998::API::1328::vds::(getHardwareInfo) failed to retrieve hardware info Traceback (most recent call last): File "/usr/share/vdsm/API.py", line 1325, in getHardwareInfo hw =3D supervdsm.getProxy().getHardwareInfo() File "/usr/share/vdsm/supervdsm.py", line 50, in __call__ return callMethod() File "/usr/share/vdsm/supervdsm.py", line 48, in <lambda> **kwargs) File "<string>", line 2, in getHardwareInfo File "/usr/lib64/python2.7/multiprocessing/managers.py", line 773, in _callmethod raise convert_to_error(kind, result) RuntimeError: [src/dmidecodemodule.c:317] Error decoding DMI data Thread-63::DEBUG::2015-08-31 12:33:13,998::bindingxmlrpc::1263::vds::(wrapper) return getHardwareInfo with {'status': {'message': 'Failed to read hardware information', 'code': 57}} Thread-63::INFO::2015-08-31 12:33:14,000::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47403 stopped Reactor thread::INFO::2015-08-31 12:33:15,042::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47404 Reactor thread::DEBUG::2015-08-31 12:33:15,054::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:15,054::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47404 Reactor thread::DEBUG::2015-08-31 12:33:15,054::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47404) BindingXMLRPC::INFO::2015-08-31 12:33:15,055::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47404 Thread-64::INFO::2015-08-31 12:33:15,056::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47404 started Thread-64::DEBUG::2015-08-31 12:33:15,057::bindingxmlrpc::1256::vds::(wrapper) client [127.0.0.1]::call getCapabilities with () {} Thread-64::DEBUG::2015-08-31 12:33:15,111::utils::661::root::(execCmd) /usr/sbin/tc qdisc show (cwd None) Thread-64::DEBUG::2015-08-31 12:33:15,124::utils::679::root::(execCmd) SUCCESS: <err> =3D ''; <rc> =3D= 0 Thread-64::DEBUG::2015-08-31 12:33:15,127::utils::661::root::(execCmd) /usr/bin/sudo -n /usr/sbin/dmidecode -s system-uuid (cwd None) Thread-64::DEBUG::2015-08-31 12:33:15,153::utils::679::root::(execCmd) FAILED: <err> =3D '/dev/mem: Operation not permitted\n'; <rc> =3D 1 Thread-64::WARNING::2015-08-31 12:33:15,154::utils::812::root::(getHostUUID) Could not find host UUID. Thread-64::DEBUG::2015-08-31 12:33:15,156::caps::780::root::(_getKeyPackages) rpm package ('glusterfs-rdma',) not found Thread-64::DEBUG::2015-08-31 12:33:15,158::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift',) not found Thread-64::DEBUG::2015-08-31 12:33:15,160::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift-object',) not found Thread-64::DEBUG::2015-08-31 12:33:15,161::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift-plugin',) not found Thread-64::DEBUG::2015-08-31 12:33:15,164::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift-account',) not found Thread-64::DEBUG::2015-08-31 12:33:15,164::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift-proxy',) not found Thread-64::DEBUG::2015-08-31 12:33:15,165::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift-doc',) not found Thread-64::DEBUG::2015-08-31 12:33:15,165::caps::780::root::(_getKeyPackages) rpm package ('gluster-swift-container',) not found Thread-64::DEBUG::2015-08-31 12:33:15,170::bindingxmlrpc::1263::vds::(wrapper) return getCapabilities with {'status': {'message': 'Done', 'code': 0}, 'info': {'HBAInventory': {'iSCSI': [{'InitiatorName': 'iqn.1994-05.com.redhat:aa2f33e6faca'}], 'FC': []}, 'packages2': {'kernel': {'release': '229.el7.x86_64', 'buildtime': 1425638202.0, 'version': '3.10.0'}, 'glusterfs-fuse': {'release': '1.el7', 'buildtime': 1438093544L, 'version': '3.7.3'}, 'spice-server': {'release': '9.el7', 'buildtime': 1426031557L, 'version': '0.12.4'}, 'librbd1': {'release': '2.el7', 'buildtime': 1425594433L, 'version': '0.80.7'}, 'vdsm': {'release': '0.el7.centos', 'buildtime': 1440055696L, 'version': '4.17.3'}, 'qemu-kvm': {'release': '23.el7_1.6.1', 'buildtime': 1438078890L, 'version': '2.1.2'}, 'qemu-img': {'release': '23.el7_1.6.1', 'buildtime': 1438078890L, 'version': '2.1.2'}, 'libvirt': {'release': '16.el7_1.3', 'buildtime': 1431461920L, 'version': '1.2.8'}, 'glusterfs': {'release': '1.el7', 'buildtime': 1438093544L, 'version': '3.7.3'}, 'mom': {'release': '1.el7.centos', 'buildtime': 1436814841L, 'version': '0.5.0'}, 'glusterfs-server': {'release': '1.el7', 'buildtime': 1438093544L, 'version': '3.7.3'}, 'glusterfs-geo-replication': {'release': '1.el7', 'buildtime': 1438093544L, 'version': '3.7.3'}}, 'numaNodeDistance': {'1': [21, 10], '0': [10, 21]}, 'cpuModel': 'Intel(R) Xeon(R) CPU E5-2690 v2 @ 3.00GHz', 'liveMerge': 'true', 'hooks': {'before_vm_start': {'50_hostedengine': {'md5': '2a6d96c26a3599812be6cf1a13d9f485'}}}, 'vmTypes': ['kvm'], 'selinux': {'mode': '1'}, 'liveSnapshot': 'true', 'kdumpStatus': 0, 'networks': {}, 'bridges': {}, 'uuid': None, 'onlineCpus': '0,1,2,3,4,5,6,7,8,9,20,21,22,23,24,25,26,27,28,29,10,11,12,13,14,15,16,1= 7,18,19,30,31,32,33,34,35,36,37,38,39', 'nics': {'eno1': {'permhwaddr': '00:1e:67:b9:33:f9', 'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'SLAVE': 'yes', 'BOOTPROTO': 'none', 'MASTER': 'bond0', 'DEVICE': 'eno1', 'TYPE': 'Ethernet', 'ONBOOT': 'yes'}, 'hwaddr': '00:1e:67:b9:33:f9', 'speed': 1000, 'gateway': ''}, 'eno2': {'permhwaddr': '00:1e:67:b9:33:fa', 'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'SLAVE': 'yes', 'BOOTPROTO': 'none', 'MASTER': 'bond0', 'DEVICE': 'eno2', 'TYPE': 'Ethernet', 'ONBOOT': 'yes'}, 'hwaddr': '00:1e:67:b9:33:f9', 'speed': 1000, 'gateway': ''}, 'eno3': {'permhwaddr': '00:1e:67:b9:33:fb', 'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'SLAVE': 'yes', 'BOOTPROTO': 'none', 'MASTER': 'bond0', 'DEVICE': 'eno3', 'TYPE': 'Ethernet', 'ONBOOT': 'yes'}, 'hwaddr': '00:1e:67:b9:33:f9', 'speed': 1000, 'gateway': ''}, 'eno4': {'permhwaddr': '00:1e:67:b9:33:fc', 'addr': '', 'ipv6gateway': '::', 'ipv6addrs': [], 'mtu': '1500', 'dhcpv4': False, 'netmask': '', 'dhcpv6': False, 'ipv4addrs': [], 'cfg': {'SLAVE': 'yes', 'BOOTPROTO': 'none', 'MASTER': 'bond0', 'DEVICE': 'eno4', 'TYPE': 'Ethernet', 'ONBOOT': 'yes'}, 'hwaddr': '00:1e:67:b9:33:f9', 'speed': 1000, 'gateway': ''}}, 'software_revision': '0', 'hostdevPassthrough': 'false', 'clusterLevels': ['3.4', '3.5', '3.6'], 'cpuFlags': 'fpu,vme,de,pse,tsc,msr,pae,mce,cx8,apic,sep,mtrr,pge,mca,cmov,pat,pse36,= clflush,dts,acpi,mmx,fxsr,sse,sse2,ss,ht,tm,pbe,syscall,nx,pdpe1gb,rdtscp= ,lm,constant_tsc,arch_perfmon,pebs,bts,rep_good,nopl,xtopology,nonstop_ts= c,aperfmperf,eagerfpu,pni,pclmulqdq,dtes64,monitor,ds_cpl,vmx,smx,est,tm2= ,ssse3,cx16,xtpr,pdcm,pcid,dca,sse4_1,sse4_2,x2apic,popcnt,tsc_deadline_t= imer,aes,xsave,avx,f16c,rdrand,lahf_lm,ida,arat,epb,xsaveopt,pln,pts,dthe= rm,tpr_shadow,vnmi,flexpriority,ept,vpid,fsgsbase,smep,erms,model_Nehalem= ,model_Conroe,model_coreduo,model_core2duo,model_Penryn,model_Westmere,mo= del_n270,model_SandyBridge', 'ISCSIInitiatorName': 'iqn.1994-05.com.redhat:aa2f33e6faca', 'netConfigDirty': 'False', 'supportedENGINEs': ['3.4', '3.5', '3.6'], 'autoNumaBalancing': 1, 'additionalFeatures': ['GLUSTER_SNAPSHOT', 'GLUSTER_GEO_REPLICATION', 'GLUSTER_BRICK_MANAGEMENT'], 'reservedMem': '321', 'bondings': {'bond0': {'ipv4addrs': ['131.130.44.101/24'], 'addr': '131.130.44.101', 'cfg': {'IPV6INIT': 'no', 'BONDING_MASTER': 'yes', 'IPADDR': '131.130.44.101', 'IPV4_FAILURE_FATAL': 'no', 'PREFIX': '24', 'BOOTPROTO': 'none', 'BONDING_OPTS': 'miimon=3D100 mode=3D802.3ad', 'DEVICE': 'bond0', 'TYPE': 'Bond', 'ONBOOT': 'yes', 'NAME': 'Bond connection bond0'}, 'ipv6addrs': ['fe80::21e:67ff:feb9:33f9/64'], 'active_slave': '', 'mtu': '1500', 'dhcpv4': False, 'netmask': '255.255.255.0', 'dhcpv6': False, 'slaves': ['eno1', 'eno2', 'eno3', 'eno4'], 'hwaddr': '00:1e:67:b9:33:f9', 'ipv6gateway': '::', 'gateway': '131.130.44.1', 'opts': {'miimon': '100', 'mode': '4'}}}, 'software_version': '4.17', 'memSize': '515720', 'cpuSpeed': '1272.304', 'numaNodes': {'1': {'totalMemory': '262144', 'cpus': [10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 30, 31, 32, 33, 34, 35, 36, 37, 38, 39]}, '0': {'totalMemory': '262065', 'cpus': [0, 1, 2, 3, 4, 5, 6, 7, 8, 9, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29]}}, 'cpuSockets': '2', 'vlans': {}, 'lastClientIface': 'lo', 'cpuCores': '20', 'kvmEnabled': 'true', 'guestOverhead': '65', 'version_name': 'Snow Man', 'cpuThreads': '40', 'emulatedMachines': ['pc-i440fx-rhel7.1.0', 'rhel6.3.0', 'pc-q35-rhel7.0.0', 'rhel6.1.0', 'rhel6.6.0', 'rhel6.2.0', 'pc', 'pc-q35-rhel7.1.0', 'q35', 'rhel6.4.0', 'rhel6.0.0', 'rhel6.5.0', 'pc-i440fx-rhel7.0.0'], 'rngSources': ['random'], 'operatingSystem': {'release': '1.1503.el7.centos.2.8', 'version': '7', 'name': 'RHEL'}, 'lastClient': '127.0.0.1'}} Thread-64::INFO::2015-08-31 12:33:15,298::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47404 stopped Reactor thread::INFO::2015-08-31 12:33:18,486::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47405 Reactor thread::DEBUG::2015-08-31 12:33:18,498::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:18,499::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47405 Reactor thread::DEBUG::2015-08-31 12:33:18,499::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47405) BindingXMLRPC::INFO::2015-08-31 12:33:18,499::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47405 Thread-65::INFO::2015-08-31 12:33:18,501::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47405 started Thread-65::INFO::2015-08-31 12:33:18,504::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47405 stopped Reactor thread::INFO::2015-08-31 12:33:33,520::protocoldetector::72::ProtocolDetector.AcceptorImpl::(handl= e_accept) Accepting connection from 127.0.0.1:47406 Reactor thread::DEBUG::2015-08-31 12:33:33,532::protocoldetector::82::ProtocolDetector.Detector::(__init__)= Using required_size=3D11 Reactor thread::INFO::2015-08-31 12:33:33,533::protocoldetector::118::ProtocolDetector.Detector::(handle_r= ead) Detected protocol xml from 127.0.0.1:47406 Reactor thread::DEBUG::2015-08-31 12:33:33,533::bindingxmlrpc::1296::XmlDetector::(handle_socket) xml over http detected from ('127.0.0.1', 47406) BindingXMLRPC::INFO::2015-08-31 12:33:33,533::xmlrpc::73::vds.XMLRPCServer::(handle_request) Starting request handler for 127.0.0.1:47406 Thread-66::INFO::2015-08-31 12:33:33,535::xmlrpc::84::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47406 started Thread-66::INFO::2015-08-31 12:33:33,538::xmlrpc::92::vds.XMLRPCServer::(_process_requests) Request handler for 127.0.0.1:47406 stopped --=20 /dev/null --3W6fXveMv22FLGti6dq6jEIOIdx6nU7sR Content-Type: application/pgp-signature; name="signature.asc" Content-Description: OpenPGP digital signature Content-Disposition: attachment; filename="signature.asc" --3W6fXveMv22FLGti6dq6jEIOIdx6nU7sR--