Return-Path: X-Original-To: apmail-cloudstack-issues-archive@www.apache.org Delivered-To: apmail-cloudstack-issues-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id EE99410A7D for ; Sat, 27 Jul 2013 07:51:54 +0000 (UTC) Received: (qmail 54098 invoked by uid 500); 27 Jul 2013 07:51:52 -0000 Delivered-To: apmail-cloudstack-issues-archive@cloudstack.apache.org Received: (qmail 54080 invoked by uid 500); 27 Jul 2013 07:51:51 -0000 Mailing-List: contact issues-help@cloudstack.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@cloudstack.apache.org Delivered-To: mailing list issues@cloudstack.apache.org Received: (qmail 54072 invoked by uid 500); 27 Jul 2013 07:51:50 -0000 Delivered-To: apmail-incubator-cloudstack-issues@incubator.apache.org Received: (qmail 54067 invoked by uid 99); 27 Jul 2013 07:51:48 -0000 Received: from arcas.apache.org (HELO arcas.apache.org) (140.211.11.28) by apache.org (qpsmtpd/0.29) with ESMTP; Sat, 27 Jul 2013 07:51:48 +0000 Date: Sat, 27 Jul 2013 07:51:48 +0000 (UTC) From: "Sailaja Mada (JIRA)" To: cloudstack-issues@incubator.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Updated] (CLOUDSTACK-3873) No error notification is generated when Primary storage (Cluster level) is added with wrong path MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: 7bit X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 [ https://issues.apache.org/jira/browse/CLOUDSTACK-3873?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ] Sailaja Mada updated CLOUDSTACK-3873: ------------------------------------- Attachment: apilog.log management-server.log > No error notification is generated when Primary storage (Cluster level) is added with wrong path > ------------------------------------------------------------------------------------------------- > > Key: CLOUDSTACK-3873 > URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3873 > Project: CloudStack > Issue Type: Bug > Security Level: Public(Anyone can view this level - this is the default.) > Components: Management Server > Affects Versions: 4.2.0 > Reporter: Sailaja Mada > Assignee: Sateesh Chodapuneedi > Fix For: 4.2.0 > > Attachments: apilog.log, management-server.log > > > Steps: > 1. Configure Adv zone with VMWARE host > 2. Tried to add cluster level primary storage with wrong path > 3. It is not added but there is no notification about the failure. > Only from MS logs Admin can figure out that it failed to add : > 2013-07-27 12:15:04,954 DEBUG [agent.transport.Request] (StatsCollector-3:null) Seq 1-1364136443: Received: { Ans: , MgmtId: 55638679939377, via: 1, Ver: v1, Flags: 10, { GetVmStatsAnswer } } > 2013-07-27 12:15:06,193 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-13:null) SeqA 2-10614: Processing Seq 2-10614: { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n \"connections\": []\n}","wait":0}}] } > 2013-07-27 12:15:06,294 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-13:null) SeqA 2-10614: Sending Seq 2-10614: { Ans: , MgmtId: 55638679939377, via: 2, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] } > 2013-07-27 12:15:06,831 INFO [vmware.mo.HostMO] (DirectAgent-341:10.102.192.19) Creation of NFS datastore on vCenter failed. Details: vCenter API trace - mountDatastore(). target MOR: host-10, vmfs: false, poolHost: 10.102.192.100, poolHostPort: 2049, poolPath: /cpg_vol/sailaja/wrongps1, poolUuid: acae88b9f9213bb1bba37360ba60038b. Exception mesg: An error occurred during host configuration. > 2013-07-27 12:15:06,855 ERROR [vmware.resource.VmwareResource] (DirectAgent-341:10.102.192.19) 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:4104) > 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-07-27 12:15:06,857 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-341:null) Seq 1-1364136442: Response Received: > 2013-07-27 12:15:06,857 DEBUG [agent.transport.Request] (DirectAgent-341:null) Seq 1-1364136442: Processing: { Ans: , MgmtId: 55638679939377, 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-07-27 12:15:06,858 DEBUG [agent.transport.Request] (catalina-exec-22:null) Seq 1-1364136442: Received: { Ans: , MgmtId: 55638679939377, via: 1, Ver: v1, Flags: 10, { Answer } } > 2013-07-27 12:15:06,858 DEBUG [agent.manager.AgentManagerImpl] (catalina-exec-22: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-07-27 12:15:06,858 WARN [apache.cloudstack.alerts] (catalina-exec-22:null) alertType:: 7 // dataCenterId:: 1 // podId:: 1 // clusterId:: null // message:: Unable to attach storage pool2 to the host1 > 2013-07-27 12:15:06,943 WARN [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl] (catalina-exec-22:null) Unable to establish a connection between Host[-1-Routing] and org.apache.cloudstack.storage.datastore.PrimaryDataStoreImpl@473b266 > 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:66) > at com.cloud.storage.StorageManagerImpl.connectHostToSharedPool(StorageManagerImpl.java:861) > at org.apache.cloudstack.storage.datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl.attachCluster(CloudStackPrimaryDataStoreLifeCycleImpl.java:390) > at com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:725) > 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-07-27 12:15:06,952 WARN [datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl] (catalina-exec-22:null) No host can access storage pool org.apache.cloudstack.storage.datastore.PrimaryDataStoreImpl@473b266 on cluster 1 > 2013-07-27 12:15:06,977 DEBUG [cloud.storage.StorageManagerImpl] (catalina-exec-22:null) Failed to add data store > com.cloud.utils.exception.CloudRuntimeException: Failed to access storage pool > at org.apache.cloudstack.storage.datastore.lifecycle.CloudStackPrimaryDataStoreLifeCycleImpl.attachCluster(CloudStackPrimaryDataStoreLifeCycleImpl.java:401) > at com.cloud.storage.StorageManagerImpl.createPool(StorageManagerImpl.java:725) > 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-07-27 12:15:06,995 INFO [cloud.api.ApiServer] (catalina-exec-22:null) null > 2013-07-27 12:15:07,005 DEBUG [cloud.api.ApiServlet] (catalina-exec-22:null) ===END=== 10.104.255.13 -- GET command=createStoragePool&scope=cluster&zoneid=f7c91fbd-7f40-4dec-ac6c-63c22d8b0374&podid=1c8f99d0-68d2-4cab-a5eb-4bff83828c49&clusterid=8f4828bb-2861-4505-9459-b6cb44664038&name=10.102.192.100&url=nfs%3A%2F%2F10.102.192.100%2Fcpg_vol%2Fsailaja%2Fwrongps1&tags=ps1&response=json&sessionkey=FpGQzDVW1TrcX9otTC%2BgTJJzDf4%3D&_=1374907697608 > 2013-07-27 12:15:16,153 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-12:null) SeqA 2-10615: Processing Seq 2-10615: { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n \"connections\": []\n}","wait":0}}] } > 2013-07-27 12:15:16,160 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-12:null) SeqA 2-10615: Sending Seq 2-10615: { Ans: , MgmtId: 55638679939377, via: 2, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] } > 2013-07-27 12:15:17,643 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM > 2013-07-27 12:15:18,387 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Zone 1 is ready to launch console proxy > 2013-07-27 12:15:20,362 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 4 routers to update status. > 2013-07-27 12:15:20,366 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 networks to update RvR status. > 2013-07-27 12:15:20,565 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 4 routers to update status. > 2013-07-27 12:15:20,569 DEBUG [network.router.VirtualNetworkApplianceManagerImpl] (RouterStatusMonitor-1:null) Found 0 networks to update RvR status. > 2013-07-27 12:15:26,006 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager Timer:null) Resetting hosts suitable for reconnect > 2013-07-27 12:15:26,008 DEBUG [host.dao.HostDaoImpl] (ClusteredAgentManager Timer:null) Completed resetting hosts suitable for reconnect -- 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