You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "edison su (JIRA)" <ji...@apache.org> on 2013/05/24 19:38:20 UTC

[jira] [Assigned] (CLOUDSTACK-2660) Object_Store_Refactor - Vmware - Not able create snapshot of root volume.

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

edison su reassigned CLOUDSTACK-2660:
-------------------------------------

    Assignee: edison su
    
> Object_Store_Refactor - Vmware - Not able create snapshot of root volume.
> -------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-2660
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2660
>             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
>         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, cmdOriginator: null, cmdInfo: {"id":"2","response":"json","sessionkey":"P+gvqeH5SBRM6P1BzOT3B4mey7A\u003d","ctxUserId":"2","httpmethod":"GET","volumeid":"672d38b3-07e7-4aa8-aeef-4d8f806c4006","_":"1369354270363","ctxAccountId":"2","ctxStartEventId":"517"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 7647994577963, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2013-05-23 17:10:53,253 DEBUG [cloud.api.ApiServlet] (catalina-exec-23:null) ===END===  10.217.252.128 -- GET  command=createSnapshot&volumeid=672d38b3-07e7-4aa8-aeef-4d8f806c4006&response=json&sessionkey=P%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=1369354270363
> 2013-05-23 17:10:53,278 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-91:job-94) Executing org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd for job-94
> 2013-05-23 17:10:53,300 INFO  [user.snapshot.CreateSnapshotCmd] (Job-Executor-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, Ver: v1, Flags: 100011, [{"org.apache.cloudstack.storage.command.CreateObjectCommand":{"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":"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,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id":11},"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}},"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.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.CreateObjectCommand":{"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":"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,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id":11},"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}},"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] (DirectAgent-146:null) Seq 1-1481376195: Executing request
> 2013-05-23 17:10:53,398 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-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.CreateObjectAnswer":{"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, Ver: v1, Flags: 100111, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"8bcf6669-5552-4c26-87de-03ec236a7aee","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":"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":{"uuid":"ed34ab6d-d394-35ee-892c-7fbe3685f300","id":1,"poolType":"NetworkFilesystem","host":"10.223.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}},"destTO":{"org.apache.cloudstack.storage.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":"ROOT-11","size":0,"path":"ROOT-11-11","volumeId":11,"vmName":"i-2-11-VM","accountId":2,"format":"OVA","id":11},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_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:null) ===START===  10.217.252.128 -- GET  command=queryAsyncJobResult&jobId=b6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=json&sessionkey=P%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=1369354273660
> 2013-05-23 17:10:56,299 DEBUG [cloud.api.ApiServlet] (catalina-exec-19:null) ===END===  10.217.252.128 -- GET  command=queryAsyncJobResult&jobId=b6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=json&sessionkey=P%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=1369354273660
> 2013-05-23 17:10:59,265 DEBUG [cloud.api.ApiServlet] (catalina-exec-10:null) ===START===  10.217.252.128 -- GET  command=queryAsyncJobResult&jobId=b6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=json&sessionkey=P%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=1369354276658
> 2013-05-23 17:10:59,298 DEBUG [cloud.api.ApiServlet] (catalina-exec-10:null) ===END===  10.217.252.128 -- GET  command=queryAsyncJobResult&jobId=b6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=json&sessionkey=P%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=1369354276658
> 2013-05-23 17:11:01,353 DEBUG [agent.transport.Request] (AgentManager-Handler-8:null) Seq 3-741736544: Processing:  { Ans: , MgmtId: 7647994577963, via: 3, Ver: v1, Flags: 110, [{"org.apache.cloudstack.storage.command.CopyCmdAnswer":{"result":false,"details":"BackupSnapshotCommand exception: java.lang.NullPointerException\ncom.cloud.storage.resource.VmwareStorageProcessor.exportVolumeToSecondaryStroage(VmwareStorageProcessor.java:607)\ncom.cloud.storage.resource.VmwareStorageProcessor.backupSnapshotToSecondaryStorage(VmwareStorageProcessor.java:650)\ncom.cloud.storage.resource.VmwareStorageProcessor.backupSnasphot(VmwareStorageProcessor.java:723)\ncom.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:84)\ncom.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:49)\ncom.cloud.storage.resource.VmwareSecondaryStorageResourceHandler.executeRequest(VmwareSecondaryStorageResourceHandler.java:98)\ncom.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:56)\ncom.cloud.agent.Agent.processRequest(Agent.java:525)\ncom.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.ThreadPoolExecutor$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 exception: java.lang.NullPointerException
> com.cloud.storage.resource.VmwareStorageProcessor.exportVolumeToSecondaryStroage(VmwareStorageProcessor.java:607)
> com.cloud.storage.resource.VmwareStorageProcessor.backupSnapshotToSecondaryStorage(VmwareStorageProcessor.java:650)
> com.cloud.storage.resource.VmwareStorageProcessor.backupSnasphot(VmwareStorageProcessor.java:723)
> com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.execute(StorageSubsystemCommandHandlerBase.java:84)
> com.cloud.storage.resource.StorageSubsystemCommandHandlerBase.handleStorageCommands(StorageSubsystemCommandHandlerBase.java:49)
> com.cloud.storage.resource.VmwareSecondaryStorageResourceHandler.executeRequest(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.java:615)
> java.lang.Thread.run(Thread.java:679)
>         at org.apache.cloudstack.storage.snapshot.SnapshotServiceImpl.backupSnapshot(SnapshotServiceImpl.java:318)
>         at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.backupSnapshot(XenserverSnapshotStrategy.java:134)
>         at org.apache.cloudstack.storage.snapshot.XenserverSnapshotStrategy.takeSnapshot(XenserverSnapshotStrategy.java:208)
>         at com.cloud.storage.snapshot.SnapshotManagerImpl.takeSnapshot(SnapshotManagerImpl.java:1005)
>         at org.apache.cloudstack.storage.volume.VolumeServiceImpl.takeSnapshot(VolumeServiceImpl.java:1031)
>         at com.cloud.storage.VolumeManagerImpl.takeSnapshot(VolumeManagerImpl.java:2567)
>         at org.apache.cloudstack.api.command.user.snapshot.CreateSnapshotCmd.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(ThreadPoolExecutor.java:1110)
>         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
>         at java.lang.Thread.run(Thread.java:679)
> 2013-05-23 17:11:01,406 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-91:job-94) Complete async job-94, jobStatus: 2, resultCode: 530, result: 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:null) ===START===  10.217.252.128 -- GET  command=queryAsyncJobResult&jobId=b6aeeb03-bbd2-46f8-b70f-3851c38394c0&response=json&sessionkey=P%2BgvqeH5SBRM6P1BzOT3B4mey7A%3D&_=1369354279658
> 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 administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira