[ https://issues.apache.org/jira/browse/CLOUDSTACK-182?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13460971#comment-13460971 ]
edison su commented on CLOUDSTACK-182: -------------------------------------- Seems failed to create local storage on your host, I added more logs in agent code in order to debug. Also, next time, you can manually set log level to debug on the agent side, by sed -i 's/INFO/DEBUG/g' /etc/cloud/agent/log4j-cloud.xml on kvm host. Then you will get more agent error logs. > Not able to add KVM (rhel 6.3 ) host to the MS > ---------------------------------------------- > > Key: CLOUDSTACK-182 > URL: https://issues.apache.org/jira/browse/CLOUDSTACK-182 > Project: CloudStack > Issue Type: Bug > Components: KVM, Management Server > Affects Versions: pre-4.0.0 > Environment: MS : Rhel 6.3 > HOST : KVM Rhel 6.3 > Build : Git Revision: 0699d65ef155aeff60aab294987815251cc94900 Git URL: > https://git-wip-us.apache.org/repos/asf/incubator-cloudstack.git] > http://jenkins.cloudstack.org/job/build-4.0-rhel63/56/artifact/CloudStack-oss-4.0.0-56.tar.bz2 > Reporter: Abhinav Roy > Priority: Blocker > Fix For: pre-4.0.0 > > Attachments: agent.log, management-server.log > > > Steps : > ===================== > 1. Deploy a Advanced zone setup. > 2. Install agent on the KVM host. > 3. Add host to MS. > Expected behaviour : > ===================== > Host should be successfully added to the MS > Observed behaviour : > ===================== > 1. While adding the host to the MS for the first time I see these errors in > Host's agent logs > 2012-09-21 16:39:34,570 INFO [cloud.agent.Agent] (main:null) id is > 2012-09-21 16:39:34,712 INFO > [resource.virtualnetwork.VirtualRoutingResource] (main:null) > VirtualRoutingResource _scriptDir to use: scripts/network/domr/kvm > 2012-09-21 16:39:35,586 INFO [kvm.resource.LibvirtComputingResource] > (main:null) No libvirt.vif.driver specififed. Defaults to BridgeVifDriver. > 2012-09-21 16:39:35,608 INFO [cloud.agent.Agent] (main:null) Agent [id = new > : type = LibvirtComputingResource : zone = 1 : pod = 1 : workers = 5 : host = > 10.102.125.201 : port = 8250 > 2012-09-21 16:39:35,617 INFO [utils.nio.NioClient] (Agent-Selector:null) > Connecting to 10.102.125.201:8250 > 2012-09-21 16:39:35,863 INFO [utils.nio.NioClient] (Agent-Selector:null) > SSL: Handshake done > 2012-09-21 16:39:36,153 WARN [utils.nio.Task] (Agent-Handler-1:null) Caught > the following exception but pushing on > java.lang.NullPointerException > at > com.cloud.hypervisor.kvm.storage.LibvirtStorageAdaptor.createStoragePool(LibvirtStorageAdaptor.java:563) > at > com.cloud.hypervisor.kvm.storage.KVMStoragePoolManager.createStoragePool(KVMStoragePoolManager.java:57) > at > com.cloud.hypervisor.kvm.resource.LibvirtComputingResource.initialize(LibvirtComputingResource.java:3245) > at com.cloud.agent.Agent.sendStartup(Agent.java:320) > at com.cloud.agent.Agent$ServerHandler.doTask(Agent.java:850) > at com.cloud.utils.nio.Task.run(Task.java:83) > at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) > at java.lang.Thread.run(Thread.java:679) > 2. Management server log has this : > 2012-09-21 15:37:59,353 DEBUG [cloud.api.ApiServlet] (catalina-exec-5:null) > Invalid paramemter in URL found. param: hosttags= > 2012-09-21 15:37:59,370 INFO [cloud.resource.ResourceManagerImpl] > (catalina-exec-5:null) Trying to add a new host at http://10.102.125.222 in > data center 1 > 2012-09-21 15:37:59,722 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-5:null) > Executing cmd: lsmod|grep kvm > 2012-09-21 15:38:00,880 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-5:null) > lsmod|grep kvm output:kvm_intel 52570 0 > kvm 314739 1 kvm_intel > 2012-09-21 15:38:01,757 DEBUG [cloud.server.StatsCollector] > (StatsCollector-2:null) VmStatsCollector is running... > 2012-09-21 15:38:01,758 DEBUG [cloud.server.StatsCollector] > (StatsCollector-1:null) HostStatsCollector is running... > 2012-09-21 15:38:01,774 DEBUG [cloud.server.StatsCollector] > (StatsCollector-3:null) StorageCollector is running... > 2012-09-21 15:38:01,887 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-5:null) > Executing cmd: cloud-setup-agent -m 10.102.125.201 -z 1 -p 1 -c 1 -g > c93ed88a-6b58-3c53-aea3-62cff49cafbc -a --pubNic=cloudbr0 --prvNic=cloudbr0 > --guestNic=cloudbr0 > 2012-09-21 15:38:17,107 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage > UPintenance mode > 2012-09-21 15:38:22,629 DEBUG > [network.router.VirtualNetworkApplianceManagerImpl] > (RouterStatusMonitor-1:null) Found 0 routers. > 2012-09-21 15:38:36,437 DEBUG [utils.ssh.SSHCmdHelper] (catalina-exec-5:null) > cloud-setup-agent -m 10.102.125.201 -z 1 -p 1 -c 1 -g > c93ed88a-6b58-3c53-aea3-62cff49cafbc -a --pubNic=cloudbr0 --prvNic=cloudbr0 > --guestNic=cloudbr0 output:CloudStack Agent setup is done! > Configure Cgroup ... > 2012-09-21 15:38:47,107 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Skip capacity scan due to there is no Primary Storage > UPintenance mode > 2012-09-21 15:48:19,081 DEBUG [kvm.discoverer.KvmServerDiscoverer] > (catalina-exec-21:null) Timeout, to wait for the host connecting to mgt svr, > assuming it is failed > 2012-09-21 15:48:19,084 WARN [cloud.resource.ResourceManagerImpl] > (catalina-exec-21:null) Unable to find the server resources at > http://10.102.125.222 > 2012-09-21 15:48:19,084 WARN [api.commands.AddHostCmd] > (catalina-exec-21:null) Exception: > com.cloud.exception.DiscoveryException: Unable to add the host > at > com.cloud.resource.ResourceManagerImpl.discoverHostsFull(ResourceManagerImpl.java:737) > at > com.cloud.resource.ResourceManagerImpl.discoverHosts(ResourceManagerImpl.java:544) > at com.cloud.api.commands.AddHostCmd.execute(AddHostCmd.java:140) > at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:138) > at com.cloud.api.ApiServer.queueCommand(ApiServer.java:543) > at com.cloud.api.ApiServer.handleRequest(ApiServer.java:422) > at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:304) > at com.cloud.api.ApiServlet.doGet(ApiServlet.java:63) > at javax.servlet.http.HttpServlet.service(HttpServlet.java:617) > at javax.servlet.http.HttpServlet.service(HttpServlet.java:717) > at > org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290) > at > org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206) > at > org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233) > at > org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191) > at > org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127) > at > org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102) > at > org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:555) > at > org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109) > at > org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298) > at > org.apache.coyote.http11.Http11NioProcessor.process(Http11NioProcessor.java:889) > at > org.apache.coyote.http11.Http11NioProtocol$Http11ConnectionHandler.process(Http11NioProtocol.java:721) > at > org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.run(NioEndpoint.java:2268) > at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) > at java.lang.Thread.run(Thread.java:679) > 2012-09-21 15:48:19,085 WARN [cloud.api.ApiDispatcher] > (catalina-exec-21:null) class com.cloud.api.ServerApiException : Unable to > add the host -- This message is automatically generated by JIRA. If you think it was sent incorrectly, please contact your JIRA administrators For more information on JIRA, see: http://www.atlassian.com/software/jira