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

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

Sangeetha Hariharan created CLOUDSTACK-2660:
-----------------------------------------------

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