You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Sailaja Mada (JIRA)" <ji...@apache.org> on 2013/06/21 08:51:19 UTC

[jira] [Updated] (CLOUDSTACK-3110) [VMWARE]NPE while adding primary storage(scope=cluster) with Invalid hostname

     [ https://issues.apache.org/jira/browse/CLOUDSTACK-3110?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Sailaja Mada updated CLOUDSTACK-3110:
-------------------------------------

    Fix Version/s: 4.2.0
    
> [VMWARE]NPE while adding primary storage(scope=cluster) with Invalid hostname 
> ------------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-3110
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3110
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: Storage Controller, VMware
>    Affects Versions: 4.2.0
>            Reporter: Sailaja Mada
>             Fix For: 4.2.0
>
>         Attachments: apilog.log, management-server.log
>
>
> Steps:
> 1.Configure Advanced Zone with VMWARe
> 2. Add Additional primary storage at the cluster level by providing wrong Server Name.
> Observation:
> 1. It failed to add the primary storage but there is NPE during this.
> 2013-06-21 12:03:09,788 DEBUG [agent.manager.AgentManagerImpl] (catalina-exec-14:null) Details from executing class com.cloud.agent.api.CreateStoragePoolCommand: success
> 2013-06-21 12:03:09,790 DEBUG [cloud.storage.StorageManagerImpl] (catalina-exec-14:null) Adding pool null to  host 1
> 2013-06-21 12:03:09,796 DEBUG [agent.transport.Request] (catalina-exec-14:null) Seq 1-503583091: Sending  { Cmd , MgmtId: 94838926819810, via: 1, Ver: v1, Flags: 100011, [{"ModifyStoragePoolCommand":{"add":true,"pool":{"id":2,"uuid":"67132a34-0414-332c-a00a-e1196f6b27ee","host":"newdps1","path":"/cpg_vol/sailaja/newdummyps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//67132a34-0414-332c-a00a-e1196f6b27ee","wait":0}}] }
> 2013-06-21 12:03:09,796 DEBUG [agent.transport.Request] (catalina-exec-14:null) Seq 1-503583091: Executing:  { Cmd , MgmtId: 94838926819810, via: 1, Ver: v1, Flags: 100011, [{"ModifyStoragePoolCommand":{"add":true,"pool":{"id":2,"uuid":"67132a34-0414-332c-a00a-e1196f6b27ee","host":"newdps1","path":"/cpg_vol/sailaja/newdummyps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//67132a34-0414-332c-a00a-e1196f6b27ee","wait":0}}] }
> 2013-06-21 12:03:09,796 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-236:null) Seq 1-503583091: Executing request
> 2013-06-21 12:03:09,797 INFO  [vmware.resource.VmwareResource] (DirectAgent-236:10.102.192.18) Executing resource ModifyStoragePoolCommand: {"add":true,"pool":{"id":2,"uuid":"67132a34-0414-332c-a00a-e1196f6b27ee","host":"newdps1","path":"/cpg_vol/sailaja/newdummyps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//67132a34-0414-332c-a00a-e1196f6b27ee","wait":0}
> 2013-06-21 12:03:10,854 INFO  [vmware.mo.HostMO] (DirectAgent-236:10.102.192.18) Creation of NFS datastore on vCenter failed.  Details: vCenter API trace - mountDatastore(). target MOR: host-1086, vmfs: false, poolHost: newdps1, poolHostPort: 2049, poolPath: /cpg_vol/sailaja/newdummyps1, poolUuid: 67132a340414332ca00ae1196f6b27ee. Exception mesg: An error occurred during host configuration.
> 2013-06-21 12:03:10,854 ERROR [vmware.resource.VmwareResource] (DirectAgent-236:10.102.192.18) ModifyStoragePoolCommand failed due to Exception: java.lang.Exception
> Message: Creation of NFS datastore on vCenter failed.
> java.lang.Exception: Creation of NFS datastore on vCenter failed.
>         at com.cloud.hypervisor.vmware.mo.HostMO.mountDatastore(HostMO.java:765)
>         at com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:3727)
>         at com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:426)
>         at com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
>         at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
>         at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
>         at java.util.concurrent.FutureTask.run(FutureTask.java:166)
>         at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
>         at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
>         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)
> 2013-06-21 12:03:10,856 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-236:null) Seq 1-503583091: Response Received:
> 2013-06-21 12:03:10,857 DEBUG [agent.transport.Request] (DirectAgent-236:null) Seq 1-503583091: Processing:  { Ans: , MgmtId: 94838926819810, via: 1, Ver: v1, Flags: 10, [{"Answer":{"result":false,"details":"ModifyStoragePoolCommand failed due to Exception: java.lang.Exception\nMessage: Creation of NFS datastore on vCenter failed.\n","wait":0}}] }
> 2013-06-21 12:03:10,857 DEBUG [agent.transport.Request] (catalina-exec-14:null) Seq 1-503583091: Received:  { Ans: , MgmtId: 94838926819810, via: 1, Ver: v1, Flags: 10, { Answer } }
> 2013-06-21 12:03:10,857 DEBUG [agent.manager.AgentManagerImpl] (catalina-exec-14:null) Details from executing class com.cloud.agent.api.ModifyStoragePoolCommand: ModifyStoragePoolCommand failed due to Exception: java.lang.Exception
> Message: Creation of NFS datastore on vCenter failed.
> 2013-06-21 12:03:10,857 WARN  [apache.cloudstack.alerts] (catalina-exec-14:null)  alertType:: 7 // dataCenterId:: 1 // podId:: 1 // clusterId:: null // message:: Unable to attach storage pool2 to the host1
> 2013-06-21 12:03:10,876 WARN  [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl] (catalina-exec-14:null) Unable to establish a connection between Host[-1-Routing] and org.apache.cloudstack.storage.datastore.DefaultPrimaryDataStore@6a7be405
> com.cloud.utils.exception.CloudRuntimeException: Unable establish connection from storage head to storage pool 2 due to ModifyStoragePoolCommand failed due to Exception: java.lang.Exception
> Message: Creation of NFS datastore on vCenter failed.
> 2
>  at org.apache.cloudstack.storage.datastore.provider.DefaultHostListener.hostConnect(DefaultHostListener.java:61)
>         at com.cloud.storage.StorageManagerImpl.connectHostToSharedPool(StorageManagerImpl.java:982)
>         at org.apache.cloudstack.storage.datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl.attachCluster(CloudStackPrimaryDataStoreLifeCycleImpl.java:423)
>         at com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:848)
>         at com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:190)
>         at org.apache.cloudstack.api.command.admin.storage.CreateStoragePoolCmd.execute(CreateStoragePoolCmd.java:144)
>         at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
>  at com.cloud.api.ApiServer.queueCommand(ApiServer.java:528)
>         at com.cloud.api.ApiServer.handleRequest(ApiServer.java:371)
>         at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:304)
>         at com.cloud.api.ApiServlet.doGet(ApiServlet.java:66)
>         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)
> 2013-06-21 12:03:10,878 WARN  [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl] (catalina-exec-14:null) No host can access storage pool org.apache.cloudstack.storage.datastore.DefaultPrimaryDataStore@6a7be405 on cluster 1
> 2013-06-21 12:03:10,886 ERROR [cloud.api.ApiServer] (catalina-exec-14:null) unhandled exception executing api command: createStoragePool
> java.lang.NullPointerException
>         at org.apache.cloudstack.storage.datastore.manager.DefaultPrimaryDataStoreProviderManagerImpl.getPrimaryDataStore(DefaultPrimaryDataStoreProviderManagerImpl.java:60)
>         at org.apache.cloudstack.storage.datastore.DataStoreManagerImpl.getDataStore(DataStoreManagerImpl.java:45)
>         at com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:858)
>         at com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:190)
>         at org.apache.cloudstack.api.command.admin.storage.CreateStoragePoolCmd.execute(CreateStoragePoolCmd.java:144)
>         at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
>         at com.cloud.api.ApiServer.queueCommand(ApiServer.java:528)
>         at com.cloud.api.ApiServer.handleRequest(ApiServer.java:371)
>         at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:304)
>         at com.cloud.api.ApiServlet.doGet(ApiServlet.java:66)
>         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)
> 2013-06-21 12:03:10,888 DEBUG [cloud.api.ApiServlet] (catalina-exec-14:null) ===END===  10.144.6.19 -- GET  command=createStoragePool&scope=cluster&zoneid=6712a2e6-374e-4856-807b-9c940792652e&podid=c160cf1b-9823-4811-a500-dbc555cf47b7&clusterid=3eb6f29e-0d74-423e-a7e4-a5c020ae5a85&name=10.102.192.100&url=nfs%3A%2F%2Fnewdps1%2Fcpg_vol%2Fsailaja%2Fnewdummyps1&response=json&sessionkey=03IYRFKEBJuwKt7oEGlLlkVtBTU%3D&_=1371796576847
> 2013-06-21 12:03:12,862 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-7:null) SeqA 4-18837: Processing Seq 4-18837:  { Cmd , MgmtId: -1, via: 4, Ver: v1, Flags: 11, [{"ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n  \"connections\": []\n}","wait":0}}] }
> 2013-06-21 12:03:12,869 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-7:null) SeqA 4-18837: Sending Seq 4-18837:  { Ans: , MgmtId: 94838926819810, via: 4, Ver: v1, Flags: 100010, [{"AgentControlAnswer":{"result":true,"wait":0}}] }

--
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