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 C802ED409 for ; Fri, 24 May 2013 17:38:20 +0000 (UTC) Received: (qmail 21062 invoked by uid 500); 24 May 2013 17:38:20 -0000 Delivered-To: apmail-cloudstack-issues-archive@cloudstack.apache.org Received: (qmail 21043 invoked by uid 500); 24 May 2013 17:38:20 -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 21023 invoked by uid 500); 24 May 2013 17:38:20 -0000 Delivered-To: apmail-incubator-cloudstack-issues@incubator.apache.org Received: (qmail 21018 invoked by uid 99); 24 May 2013 17:38:20 -0000 Received: from arcas.apache.org (HELO arcas.apache.org) (140.211.11.28) by apache.org (qpsmtpd/0.29) with ESMTP; Fri, 24 May 2013 17:38:20 +0000 Date: Fri, 24 May 2013 17:38:20 +0000 (UTC) From: "edison su (JIRA)" To: cloudstack-issues@incubator.apache.org Message-ID: In-Reply-To: References: Subject: [jira] [Assigned] (CLOUDSTACK-2660) Object_Store_Refactor - Vmware - Not able create snapshot of root volume. MIME-Version: 1.0 Content-Type: text/plain; charset=utf-8 Content-Transfer-Encoding: quoted-printable X-JIRA-FingerPrint: 30527f35849b9dde25b450d4833f0394 [ https://issues.apache.org/jira/browse/CLOUDSTACK-2660?page=3Dcom.atl= assian.jira.plugin.system.issuetabpanels:all-tabpanel ] edison su reassigned CLOUDSTACK-2660: ------------------------------------- Assignee: edison su =20 > Object_Store_Refactor - Vmware - Not able create snapshot of root volume. > ------------------------------------------------------------------------- > > Key: CLOUDSTACK-2660 > URL: https://issues.apache.org/jira/browse/CLOUDSTACK-266= 0 > Project: CloudStack > Issue Type: Bug > Security Level: Public(Anyone can view this level - this is the defa= ult.)=20 > Components: Management Server > Affects Versions: 4.2.0 > Environment: Build from object_store > Reporter: Sangeetha Hariharan > Assignee: edison su > Priority: Blocker > Fix For: 4.2.0 > > > Object_Store_Refactor - Vmware - Not able create snapshot of root volume. > Steps to reprodude the problem: > Deploy a Vm. > Take a snaphot of the root Volume. > Following error message is presented to the user: > "Failed to create snapshot due to an internal error creating snapshot for= volume 11" > 2013-05-23 17:10:53,251 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina= -exec-23:null) submit async job-94, details: AsyncJobVO {id:94, userId: 2, = accountId: 2, sessionKey: null, instanceType: Snapshot, instanceId: 2, cmd:= org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd, cmdOrig= inator: null, cmdInfo: {"id":"2","response":"json","sessionkey":"P+gvqeH5SB= RM6P1BzOT3B4mey7A\u003d","ctxUserId":"2","httpmethod":"GET","volumeid":"672= d38b3-07e7-4aa8-aeef-4d8f806c4006","_":"1369354270363","ctxAccountId":"2","= ctxStartEventId":"517"}, cmdVersion: 0, callbackType: 0, callbackAddress: n= ull, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 76= 47994577963, completeMsid: null, lastUpdated: null, lastPolled: null, creat= ed: null} > 2013-05-23 17:10:53,253 DEBUG [cloud.api.ApiServlet] (catalina-exec-23:nu= ll) =3D=3D=3DEND=3D=3D=3D 10.217.252.128 -- GET command=3DcreateSnapshot&= volumeid=3D672d38b3-07e7-4aa8-aeef-4d8f806c4006&response=3Djson&sessionkey= =3DP%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=3D1369354270363 > 2013-05-23 17:10:53,278 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Exec= utor-91:job-94) Executing org.apache.cloudstack.api.command.user.snapshot.C= reateSnapshotCmd for job-94 > 2013-05-23 17:10:53,300 INFO [user.snapshot.CreateSnapshotCmd] (Job-Exec= utor-91:job-94) VOLSS: createSnapshotCmd starts:1369354253300 > 2013-05-23 17:10:53,396 DEBUG [agent.transport.Request] (Job-Executor-91:= job-94) Seq 1-1481376195: Sending { Cmd , MgmtId: 7647994577963, via: 1, V= er: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateObjec= tCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"vo= lume":{"uuid":"672d38b3-07e7-4aa8-aeef-4d8f806c4006","volumeType":"ROOT","d= ataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"e= d34ab6d-d394-35ee-892c-7fbe3685f300","id":1,"poolType":"NetworkFilesystem",= "host":"10.223.110.232","path":"/export/home/sangeetha/vmware-42/primary","= port":2049}},"name":"ROOT-11","size":0,"path":"ROOT-11-11","volumeId":11,"v= mName":"i-2-11-VM","accountId":2,"format":"OVA","id":11},"dataStore":{"org.= apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"ed34ab6d-d394-35e= e-892c-7fbe3685f300","id":1,"poolType":"NetworkFilesystem","host":"10.223.1= 10.232","path":"/export/home/sangeetha/vmware-42/primary","port":2049}},"vm= Name":"i-2-11-VM","name":"new_ROOT-11_20130524001053","hypervisorType":"VMw= are","id":2}},"wait":0}}] } > 2013-05-23 17:10:53,397 DEBUG [agent.transport.Request] (Job-Executor-91:= job-94) Seq 1-1481376195: Executing: { Cmd , MgmtId: 7647994577963, via: 1= , Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateOb= jectCommand":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{= "volume":{"uuid":"672d38b3-07e7-4aa8-aeef-4d8f806c4006","volumeType":"ROOT"= ,"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid"= :"ed34ab6d-d394-35ee-892c-7fbe3685f300","id":1,"poolType":"NetworkFilesyste= m","host":"10.223.110.232","path":"/export/home/sangeetha/vmware-42/primary= ","port":2049}},"name":"ROOT-11","size":0,"path":"ROOT-11-11","volumeId":11= ,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id":11},"dataStore":{"o= rg.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"ed34ab6d-d394-= 35ee-892c-7fbe3685f300","id":1,"poolType":"NetworkFilesystem","host":"10.22= 3.110.232","path":"/export/home/sangeetha/vmware-42/primary","port":2049}},= "vmName":"i-2-11-VM","name":"new_ROOT-11_20130524001053","hypervisorType":"= VMware","id":2}},"wait":0}}] } > 2013-05-23 17:10:53,397 DEBUG [agent.manager.DirectAgentAttache] (DirectA= gent-146:null) Seq 1-1481376195: Executing request > 2013-05-23 17:10:53,398 DEBUG [agent.manager.DirectAgentAttache] (DirectA= gent-146:null) Seq 1-1481376195: Response Received: > 2013-05-23 17:10:53,398 DEBUG [agent.transport.Request] (DirectAgent-146:= null) Seq 1-1481376195: Processing: { Ans: , MgmtId: 7647994577963, via: 1= , Ver: v1, Flags: 10, [{"org.apache.cloudstack.storage.command.CreateObject= Answer":{"data":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path= ":"8bcf6669-5552-4c26-87de-03ec236a7aee","id":0}},"result":true,"wait":0}}]= } > 2013-05-23 17:10:53,406 DEBUG [agent.transport.Request] (Job-Executor-91:= job-94) Seq 1-1481376195: Received: { Ans: , MgmtId: 7647994577963, via: 1= , Ver: v1, Flags: 10, { CreateObjectAnswer } } > 2013-05-23 17:10:53,648 DEBUG [agent.transport.Request] (Job-Executor-91:= job-94) Seq 3-741736544: Sending { Cmd , MgmtId: 7647994577963, via: 3, Ve= r: v1, Flags: 100111, [{"org.apache.cloudstack.storage.command.CopyCommand"= :{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"8bc= f6669-5552-4c26-87de-03ec236a7aee","volume":{"uuid":"672d38b3-07e7-4aa8-aee= f-4d8f806c4006","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.sto= rage.to.PrimaryDataStoreTO":{"uuid":"ed34ab6d-d394-35ee-892c-7fbe3685f300",= "id":1,"poolType":"NetworkFilesystem","host":"10.223.110.232","path":"/expo= rt/home/sangeetha/vmware-42/primary","port":2049}},"name":"ROOT-11","size":= 0,"path":"ROOT-11 > -11","volumeId":11,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id"= :11},"dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"u= uid":"ed34ab6d-d394-35ee-892c-7fbe3685f300","id":1,"poolType":"NetworkFiles= ystem","host":"10.223.110.232","path":"/export/home/sangeetha/vmware-42/pri= mary","port":2049}},"vmName":"i-2-11-VM","name":"new_ROOT-11_20130524001053= ","hypervisorType":"VMware","id":2}},"destTO":{"org.apache.cloudstack.stora= ge.to.SnapshotObjectTO":{"path":"snapshots/2/11","volume":{"uuid":"672d38b3= -07e7-4aa8-aeef-4d8f806c4006","volumeType":"ROOT","dataStore":{"org.apache.= cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"ed34ab6d-d394-35ee-892c-= 7fbe3685f300","id":1,"poolType":"NetworkFilesystem","host":"10.223.110.232"= ,"path":"/export/home/sangeetha/vmware-42/primary","port":2049}},"name":"RO= OT-11","size":0,"path":"ROOT-11-11","volumeId":11,"vmName":"i-2-11-VM","acc= ountId":2,"format":"OVA","id":11},"dataStore":{"com.cloud.agent.api.to.NfsT= O":{"_url":"nfs://10.223.110.232/export/home/sangeetha/vmware-42/secondary"= ,"_role":"Image"}},"vmName":"i-2-11-VM","name":"new_ROOT-11_20130524001053"= ,"hypervisorType":"VMware","id":2}},"wait":21600}}] } > 2013-05-23 17:10:56,268 DEBUG [cloud.api.ApiServlet] (catalina-exec-19:nu= ll) =3D=3D=3DSTART=3D=3D=3D 10.217.252.128 -- GET command=3DqueryAsyncJob= Result&jobId=3Db6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=3Djson&session= key=3DP%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=3D1369354273660 > 2013-05-23 17:10:56,299 DEBUG [cloud.api.ApiServlet] (catalina-exec-19:nu= ll) =3D=3D=3DEND=3D=3D=3D 10.217.252.128 -- GET command=3DqueryAsyncJobRe= sult&jobId=3Db6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=3Djson&sessionke= y=3DP%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=3D1369354273660 > 2013-05-23 17:10:59,265 DEBUG [cloud.api.ApiServlet] (catalina-exec-10:nu= ll) =3D=3D=3DSTART=3D=3D=3D 10.217.252.128 -- GET command=3DqueryAsyncJob= Result&jobId=3Db6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=3Djson&session= key=3DP%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=3D1369354276658 > 2013-05-23 17:10:59,298 DEBUG [cloud.api.ApiServlet] (catalina-exec-10:nu= ll) =3D=3D=3DEND=3D=3D=3D 10.217.252.128 -- GET command=3DqueryAsyncJobRe= sult&jobId=3Db6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=3Djson&sessionke= y=3DP%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=3D1369354276658 > 2013-05-23 17:11:01,353 DEBUG [agent.transport.Request] (AgentManager-Han= dler-8:null) Seq 3-741736544: Processing: { Ans: , MgmtId: 7647994577963, = via: 3, Ver: v1, Flags: 110, [{"org.apache.cloudstack.storage.command.CopyC= mdAnswer":{"result":false,"details":"BackupSnapshotCommand exception: java.= lang.NullPointerException\ncom.cloud.storage.resource.VmwareStorageProcesso= r.exportVolumeToSecondaryStroage(VmwareStorageProcessor.java:607)\ncom.clou= d.storage.resource.VmwareStorageProcessor.backupSnapshotToSecondaryStorage(= VmwareStorageProcessor.java:650)\ncom.cloud.storage.resource.VmwareStorageP= rocessor.backupSnasphot(VmwareStorageProcessor.java:723)\ncom.cloud.storage= .resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemComman= dHandlerBase.java:84)\ncom.cloud.storage.resource.StorageSubsystemCommandHa= ndlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:49)= \ncom.cloud.storage.resource.VmwareSecondaryStorageResourceHandler.executeR= equest(VmwareSecondaryStorageResourceHandler.java:98)\ncom.cloud.storage.re= source.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStora= geResource.java:56)\ncom.cloud.agent.Agent.processRequest(Agent.java:525)\n= com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)\ncom.cloud= .utils.nio.Task.run(Task.java:83)\njava.util.concurrent.ThreadPoolExecutor.= runWorker(ThreadPoolExecutor.java:1146)\njava.util.concurrent.ThreadPoolExe= cutor$Worker.run(ThreadPoolExecutor.java:615)\njava.lang.Thread.run(Thread.= java:679)\n","wait":0}}] } > 2013-05-23 17:11:01,354 DEBUG [agent.transport.Request] (Job-Executor-91:= job-94) Seq 3-741736544: Received: { Ans: , MgmtId: 7647994577963, via: 3,= Ver: v1, Flags: 110, { CopyCmdAnswer } } > 2013-05-23 17:11:01,380 DEBUG [agent.manager.AgentAttache] (AgentManager-= Handler-8:null) Seq 3-741736544: No more commands found > 2013-05-23 17:11:01,393 DEBUG [storage.snapshot.SnapshotManagerImpl] (Job= -Executor-91:job-94) Failed to create snapshot > com.cloud.utils.exception.CloudRuntimeException: BackupSnapshotCommand ex= ception: java.lang.NullPointerException > com.cloud.storage.resource.VmwareStorageProcessor.exportVolumeToSecondary= Stroage(VmwareStorageProcessor.java:607) > com.cloud.storage.resource.VmwareStorageProcessor.backupSnapshotToSeconda= ryStorage(VmwareStorageProcessor.java:650) > com.cloud.storage.resource.VmwareStorageProcessor.backupSnasphot(VmwareSt= orageProcessor.java:723) > com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(Sto= rageSubsystemCommandHandlerBase.java:84) > com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStora= geCommands(StorageSubsystemCommandHandlerBase.java:49) > com.cloud.storage.resource.VmwareSecondaryStorageResourceHandler.executeR= equest(VmwareSecondaryStorageResourceHandler.java:98) > com.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest= (PremiumSecondaryStorageResource.java:56) > com.cloud.agent.Agent.processRequest(Agent.java:525) > com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852) > com.cloud.utils.nio.Task.run(Task.java:83) > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java= :1146) > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.jav= a:615) > java.lang.Thread.run(Thread.java:679) > at org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.bac= kupSnapshot(SnapshotServiceImpl.java:318) > at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrate= gy.backupSnapshot(XenserverSnapshotStrategy.java:134) > at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrate= gy.takeSnapshot(XenserverSnapshotStrategy.java:208) > at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(Sn= apshotManagerImpl.java:1005) > at org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSna= pshot(VolumeServiceImpl.java:1031) > at com.cloud.storage.VolumeManagerImpl.takeSnapshot(VolumeManager= Impl.java:2567) > at org.apache.cloudstack.api.command.user.snapshot.CreateSnapshot= Cmd.execute(CreateSnapshotCmd.java:170) > at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155) > at com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.= java:437) > 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.ThreadPoolExecutor.runWorker(ThreadPoolEx= ecutor.java:1110) > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolE= xecutor.java:603) > at java.lang.Thread.run(Thread.java:679) > 2013-05-23 17:11:01,406 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Exec= utor-91:job-94) Complete async job-94, jobStatus: 2, resultCode: 530, resul= t: Error Code: 530 Error text: Failed to create snapshot due to an internal= error creating snapshot for volume 11 > 2013-05-23 17:11:02,266 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:nul= l) =3D=3D=3DSTART=3D=3D=3D 10.217.252.128 -- GET command=3DqueryAsyncJobR= esult&jobId=3Db6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=3Djson&sessionk= ey=3DP%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=3D1369354279658 > 2013-05-23 17:11:02,275 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina= -exec-3:null) Async job-94 completed -- This message is automatically generated by JIRA. If you think it was sent incorrectly, please contact your JIRA administrato= rs For more information on JIRA, see: http://www.atlassian.com/software/jira