[
https://issues.apache.org/jira/browse/CLOUDSTACK-3995?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel
]
Sailaja Mada updated CLOUDSTACK-3995:
-------------------------------------
Fix Version/s: 4.5.0
> No error notification is generated when Primary storage (Zonelevel) is added
> with wrong path and it is allowed to add
> ---------------------------------------------------------------------------------------------------------------------
>
> Key: CLOUDSTACK-3995
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3995
> 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
> Priority: Minor
> Fix For: 4.4.0, 4.5.0
>
> Attachments: apilog.log, management-server.log
>
>
> Steps:
> 1. Configure Adv zone with VMWARE
> 2. Tried to add wrong Zone wide primary storage point
> Observation:
> It is allowed to add with wrong path and there is no failure error
> notification. But in the logs it says storage pool addition failed.
> 2013-08-01 10:11:30,741 DEBUG [cloud.api.ApiServlet] (catalina-exec-17:null)
> ===START=== 10.144.6.19 -- GET
> command=createStoragePool&scope=zone&zoneid=176d7081-e1d2-4472-8a17-eff1322ddd39&hypervisor=VMware&name=wrongzwps1&url=nfs%3A%2F%2F10.102.192.100%2Fcpg_vol%2Fsailaja%2Fwrongzwps1&response=json&sessionkey=x8JP8GtGm4LirW0b8AK9sVj26D0%3D&_=1375332320686
> 2013-08-01 10:11:30,748 DEBUG
> [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl]
> (catalina-exec-17:null) createPool Params @ scheme - nfs storageHost -
> 10.102.192.100 hostPath - /cpg_vol/sailaja/wrongzwps1 port - -1
> 2013-08-01 10:11:30,763 DEBUG [cloud.storage.StorageManagerImpl]
> (catalina-exec-17:null) Adding pool null to host 1
> 2013-08-01 10:11:30,767 DEBUG [agent.transport.Request]
> (catalina-exec-17:null) Seq 1-757532167: Sending { Cmd , MgmtId:
> 187767034175903, via: 1, Ver: v1, Flags: 100011,
> [{"com.cloud.agent.api.ModifyStoragePoolCommand":{"add":true,"pool":{"id":6,"uuid":"8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","host":"10.102.192.100","path":"/cpg_vol/sailaja/wrongzwps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","wait":0}}]
> }
> 2013-08-01 10:11:30,767 DEBUG [agent.transport.Request]
> (catalina-exec-17:null) Seq 1-757532167: Executing: { Cmd , MgmtId:
> 187767034175903, via: 1, Ver: v1, Flags: 100011,
> [{"com.cloud.agent.api.ModifyStoragePoolCommand":{"add":true,"pool":{"id":6,"uuid":"8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","host":"10.102.192.100","path":"/cpg_vol/sailaja/wrongzwps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","wait":0}}]
> }
> 2013-08-01 10:11:30,768 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-52:null) Seq 1-757532167: Executing request
> 2013-08-01 10:11:30,768 INFO [vmware.resource.VmwareResource]
> (DirectAgent-52:10.102.192.18) Executing resource ModifyStoragePoolCommand:
> {"add":true,"pool":{"id":6,"uuid":"8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","host":"10.102.192.100","path":"/cpg_vol/sailaja/wrongzwps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","wait":0}
> 2013-08-01 10:11:30,949 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 3 routers to update status.
> 2013-08-01 10:11:30,951 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
> 2013-08-01 10:11:30,962 INFO [vmware.mo.HostMO]
> (DirectAgent-52:10.102.192.18) Creation of NFS datastore on vCenter failed.
> Details: vCenter API trace - mountDatastore(). target MOR: host-8973, vmfs:
> false, poolHost: 10.102.192.100, poolHostPort: 2049, poolPath:
> /cpg_vol/sailaja/wrongzwps1, poolUuid: 8f4e2b4b76a23f11b98c2ee8108ab900.
> Exception mesg: An error occurred during host configuration.
> 2013-08-01 10:11:30,962 ERROR [vmware.resource.VmwareResource]
> (DirectAgent-52: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:772)
> at
> com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:4102)
> at
> com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:472)
> 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-08-01 10:11:30,964 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-52:null) Seq 1-757532167: Response Received:
> 2013-08-01 10:11:30,964 DEBUG [agent.transport.Request] (DirectAgent-52:null)
> Seq 1-757532167: Processing: { Ans: , MgmtId: 187767034175903, via: 1, Ver:
> v1, Flags: 10,
> [{"com.cloud.agent.api.Answer":{"result":false,"details":"ModifyStoragePoolCommand
> failed due to Exception: java.lang.Exception\nMessage: Creation of NFS
> datastore on vCenter failed.\n","wait":0}}] }
> 2013-08-01 10:11:30,964 DEBUG [agent.transport.Request]
> (catalina-exec-17:null) Seq 1-757532167: Received: { Ans: , MgmtId:
> 187767034175903, via: 1, Ver: v1, Flags: 10, { Answer } }
> 2013-08-01 10:11:30,964 DEBUG [agent.manager.AgentManagerImpl]
> (catalina-exec-17: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-08-01 10:11:30,964 WARN [apache.cloudstack.alerts]
> (catalina-exec-17:null) alertType:: 7 // dataCenterId:: 1 // podId:: null //
> clusterId:: null // message:: Unable to attach storage pool6 to the host1
> 2013-08-01 10:11:30,973 WARN
> [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl]
> (catalina-exec-17:null) Unable to establish a connection between
> Host[-1-Routing] and
> org.apache.cloudstack.storage.datastore.PrimaryDataStoreImpl@56862dbf
> com.cloud.utils.exception.CloudRuntimeException: Unable establish connection
> from storage head to storage pool 6 due to ModifyStoragePoolCommand failed
> due to Exception: java.lang.Exception
> Message: Creation of NFS datastore on vCenter failed.
> 6
> at
> org.apache.cloudstack.storage.datastore.provider.DefaultHostListener.hostConnect(DefaultHostListener.java:66)
> at
> com.cloud.storage.StorageManagerImpl.connectHostToSharedPool(StorageManagerImpl.java:882)
> at
> org.apache.cloudstack.storage.datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl.attachZone(CloudStackPrimaryDataStoreLifeCycleImpl.java:413)
> at
> com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:749)
> at
> com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:176)
> at
> org.apache.cloudstack.api.command.admin.storage.CreateStoragePoolCmd.execute(CreateStoragePoolCmd.java:168)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at com.cloud.api.ApiServer.queueCommand(ApiServer.java:514)
> at com.cloud.api.ApiServer.handleRequest(ApiServer.java:372)
> at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:305)
> 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-08-01 10:11:30,977 DEBUG [cloud.storage.StorageManagerImpl]
> (catalina-exec-17:null) Adding pool null to host 4
> 2013-08-01 10:11:30,982 DEBUG [agent.transport.Request]
> (catalina-exec-17:null) Seq 4-1692535874: Sending { Cmd , MgmtId:
> 187767034175903, via: 4, Ver: v1, Flags: 100011,
> [{"com.cloud.agent.api.ModifyStoragePoolCommand":{"add":true,"pool":{"id":6,"uuid":"8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","host":"10.102.192.100","path":"/cpg_vol/sailaja/wrongzwps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","wait":0}}]
> }
> 2013-08-01 10:11:30,982 DEBUG [agent.transport.Request]
> (catalina-exec-17:null) Seq 4-1692535874: Executing: { Cmd , MgmtId:
> 187767034175903, via: 4, Ver: v1, Flags: 100011,
> [{"com.cloud.agent.api.ModifyStoragePoolCommand":{"add":true,"pool":{"id":6,"uuid":"8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","host":"10.102.192.100","path":"/cpg_vol/sailaja/wrongzwps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","wait":0}}]
> }
> 2013-08-01 10:11:30,982 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-240:null) Seq 4-1692535874: Executing request
> 2013-08-01 10:11:30,983 INFO [vmware.resource.VmwareResource]
> (DirectAgent-240:10.102.192.23) Executing resource ModifyStoragePoolCommand:
> {"add":true,"pool":{"id":6,"uuid":"8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","host":"10.102.192.100","path":"/cpg_vol/sailaja/wrongzwps1","port":2049,"type":"NetworkFilesystem"},"localPath":"/mnt//8f4e2b4b-76a2-3f11-b98c-2ee8108ab900","wait":0}
> 2013-08-01 10:11:31,088 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 3 routers to update status.
> 2013-08-01 10:11:31,090 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
> 2013-08-01 10:11:31,171 INFO [vmware.mo.HostMO]
> (DirectAgent-240:10.102.192.23) Creation of NFS datastore on vCenter failed.
> Details: vCenter API trace - mountDatastore(). target MOR: host-8984, vmfs:
> false, poolHost: 10.102.192.100, poolHostPort: 2049, poolPath:
> /cpg_vol/sailaja/wrongzwps1, poolUuid: 8f4e2b4b76a23f11b98c2ee8108ab900.
> Exception mesg: An error occurred during host configuration.
> 2013-08-01 10:11:31,172 ERROR [vmware.resource.VmwareResource]
> (DirectAgent-240:10.102.192.23) 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:772)
> at
> com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:4102)
> at
> com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:472)
> 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-08-01 10:11:31,174 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-240:null) Seq 4-1692535874: Response Received:
> 2013-08-01 10:11:31,174 DEBUG [agent.transport.Request]
> (DirectAgent-240:null) Seq 4-1692535874: Processing: { Ans: , MgmtId:
> 187767034175903, via: 4, Ver: v1, Flags: 10,
> [{"com.cloud.agent.api.Answer":{"result":false,"details":"ModifyStoragePoolCommand
> failed due to Exception: java.lang.Exception\nMessage: Creation of NFS
> datastore on vCenter failed.\n","wait":0}}] }
> 2013-08-01 10:11:31,174 DEBUG [agent.transport.Request]
> (catalina-exec-17:null) Seq 4-1692535874: Received: { Ans: , MgmtId:
> 187767034175903, via: 4, Ver: v1, Flags: 10, { Answer } }
> 2013-08-01 10:11:31,174 DEBUG [agent.manager.AgentManagerImpl]
> (catalina-exec-17: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-08-01 10:11:31,175 WARN [apache.cloudstack.alerts]
> (catalina-exec-17:null) alertType:: 7 // dataCenterId:: 1 // podId:: null //
> clusterId:: null // message:: Unable to attach storage pool6 to the host4
> 2013-08-01 10:11:31,183 WARN
> [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl]
> (catalina-exec-17:null) Unable to establish a connection between
> Host[-4-Routing] and
> org.apache.cloudstack.storage.datastore.PrimaryDataStoreImpl@56862dbf
> com.cloud.utils.exception.CloudRuntimeException: Unable establish connection
> from storage head to storage pool 6 due to ModifyStoragePoolCommand failed
> due to Exception: java.lang.Exception
> Message: Creation of NFS datastore on vCenter failed.
> 6
> at
> org.apache.cloudstack.storage.datastore.provider.DefaultHostListener.hostConnect(DefaultHostListener.java:66)
> at
> com.cloud.storage.StorageManagerImpl.connectHostToSharedPool(StorageManagerImpl.java:882)
> at
> org.apache.cloudstack.storage.datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl.attachZone(CloudStackPrimaryDataStoreLifeCycleImpl.java:413)
> at
> com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:749)
> at
> com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:176)
> at
> org.apache.cloudstack.api.command.admin.storage.CreateStoragePoolCmd.execute(CreateStoragePoolCmd.java:168)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158)
> at com.cloud.api.ApiServer.queueCommand(ApiServer.java:514)
> at com.cloud.api.ApiServer.handleRequest(ApiServer.java:372)
> at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:305)
> 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-08-01 10:11:31,201 DEBUG [cloud.api.ApiServlet] (catalina-exec-17:null)
> ===END=== 10.144.6.19 -- GET
> command=createStoragePool&scope=zone&zoneid=176d7081-e1d2-4472-8a17-eff1322ddd39&hypervisor=VMware&name=wrongzwps1&url=nfs%3A%2F%2F10.102.192.100%2Fcpg_vol%2Fsailaja%2Fwrongzwps1&response=json&sessionkey=x8JP8GtGm4LirW0b8AK9sVj26D0%3D&_=1375332320686
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
