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/15 23:23:16 UTC

[jira] [Commented] (CLOUDSTACK-2482) Object_Store_Refactor - Snapshots - Not able to create volume from snapshot.

    [ https://issues.apache.org/jira/browse/CLOUDSTACK-2482?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13658837#comment-13658837 ] 

Sangeetha Hariharan commented on CLOUDSTACK-2482:
-------------------------------------------------

Using the latest build from 5/15:

2013-05-15 12:25:50,476 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) ===START===  10.217.252.128 -- GET  command=createVolume&response=json&sessionkey=71qVeiluDEOL7wvsmcgtqt8I1NM%3D&snapshotid=4d6a8843-707a-4b25-9f1e-1224d44cf5ae&name=vol-from-snap&_=1368649370726
2013-05-15 12:25:50,484 DEBUG [cloud.user.AccountManagerImpl] (catalina-exec-3:null) Access to Acct[3-sangee] granted to Acct[3-sangee] by DomainChecker_EnhancerByCloudStack_9de4226a
2013-05-15 12:25:50,487 DEBUG [cloud.user.AccountManagerImpl] (catalina-exec-3:null) Access to Acct[3-sangee] granted to Acct[3-sangee] by DomainChecker_EnhancerByCloudStack_9de4226a
2013-05-15 12:25:50,496 DEBUG [cloud.user.AccountManagerImpl] (catalina-exec-3:null) Access to com.cloud.storage.SnapshotVO$$EnhancerByCGLIB$$5c480a47@587b8a9a granted to Acct[3-sangee] by DomainChecker_EnhancerByCloudStack_9de4226a
2013-05-15 12:25:50,546 ERROR [cloud.api.ApiServer] (catalina-exec-3:null) unhandled exception executing api command: createVolume
java.lang.NullPointerException
        at com.cloud.storage.VolumeManagerImpl.allocVolume(VolumeManagerImpl.java:979)
        at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
        at com.cloud.storage.VolumeManagerImpl.allocVolume(VolumeManagerImpl.java:183)
        at org.apache.cloudstack.api.command.user.volume.CreateVolumeCmd.create(CreateVolumeCmd.java:162)
        at com.cloud.api.ApiDispatcher.dispatchCreateCmd(ApiDispatcher.java:101)
        at com.cloud.api.ApiServer.queueCommand(ApiServer.java:466)
        at com.cloud.api.ApiServer.handleRequest(ApiServer.java:369)
        at com.cloud.api.ApiServlet.processRequest(ApiServlet.java:304)
        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-05-15 12:25:50,549 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) ===END===  10.217.252.128 -- GET  command=createVolume&response=json&sessionkey=71qVeiluDEOL7wvsmcgtqt8I1NM%3D&snapshotid=4d6a8843-707a-4b25-9f1e-1224d44cf5ae&name=vol-from-snap&_=1368649370726

                
> Object_Store_Refactor - Snapshots - Not able to create volume from snapshot. 
> -----------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-2482
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2482
>             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: Critical
>             Fix For: 4.2.0
>
>
> Steps to reproduce the problem:
> Deploy Vm.
> Create a snapshot of the root volume.
> Create a volume from snapshot.
> This fails.
> Following exception seen in management server logs:
> 2013-05-14 09:55:53,384 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) ===START===  10.217.252.128 -- GET  command=createVolume&response=json&s                   essionkey=X%2FK09rgZ%2BYIUuGYkv7UGa0FoBEc%3D&snapshotid=c7bc851c-a7aa-4125-8d8e-f3d70b807e2c&name=Volume123&_=1368553972160
> 2013-05-14 09:55:53,474 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-9:null) submit async job-19, details: AsyncJobVO {id:19, userId: 2, a                   ccountId: 2, sessionKey: null, instanceType: Volume, instanceId: 7, cmd: org.apache.cloudstack.api.command.user.volume.CreateVolumeCmd, cmdOriginato                   r: null, cmdInfo: {"id":"7","response":"json","sessionkey":"X/K09rgZ+YIUuGYkv7UGa0FoBEc\u003d","ctxUserId":"2","snapshotid":"c7bc851c-a7aa-4125-8d8e                   -f3d70b807e2c","name":"Volume123","httpmethod":"GET","_":"1368553972160","ctxAccountId":"2","ctxStartEventId":"65"}, cmdVersion: 0, callbackType: 0,                    callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 206915885079359, completeMsid: null, lastUpdated: null,                    lastPolled: null, created: null}
> 2013-05-14 09:55:53,476 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-21:job-19) Executing org.apache.cloudstack.api.command.user.volume.Cre                   ateVolumeCmd for job-19
> 2013-05-14 09:55:53,477 DEBUG [cloud.api.ApiServlet] (catalina-exec-9:null) ===END===  10.217.252.128 -- GET  command=createVolume&response=json&ses                   sionkey=X%2FK09rgZ%2BYIUuGYkv7UGa0FoBEc%3D&snapshotid=c7bc851c-a7aa-4125-8d8e-f3d70b807e2c&name=Volume123&_=1368553972160
> 2013-05-14 09:55:53,505 DEBUG [cloud.storage.StorageManagerImpl] (Job-Executor-21:job-19) Checking pool 1 for storage, totalSize: 11810778316800, us                   edBytes: 8603883175936, usedPct: 0.7284772387690642, disable threshold: 0.85
> 2013-05-14 09:55:53,535 DEBUG [cloud.storage.StorageManagerImpl] (Job-Executor-21:job-19) Checking pool: 1 for volume allocation [Vol[7|vm=null|DATA                   DISK]], maxSize : 23621556633600, totalAllocatedSize : 23471325184, askingSize : 8589934592, allocated disable threshold: 0.85
> 2013-05-14 09:55:53,538 DEBUG [allocator.impl.UserConcentratedAllocator] (Job-Executor-21:job-19) There are no pods with enough memory/CPU capacity                    in zone zone1
> 2013-05-14 09:55:53,577 DEBUG [agent.transport.Request] (Job-Executor-21:job-19) Seq 1-738331999: Sending  { Cmd , MgmtId: 206915885079359, via: 1,                    Ver: v1, Flags: 100111, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":                   "snapshots/2/2/76979672-c725-4b20-a517-eb8410205ef6","volume":{"uuid":"5d0bd6d7-4ebe-4fb6-98ad-5df52850e739","volumeType":"ROOT","dataStore":{"org.a                   pache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"e97b5727-d157-3dc1-b32c-065b99806623","id":1,"poolType":"NetworkFilesystem","host":"10.223.                   110.232","path":"/export/home/sangeetha/campo-systemp-1/primary","port":2049}},"name":"ROOT-5","size":8589934592,"path":"86b8d3a8-44c9-4bb0-b4fb-1ba                   98d3e4f75","volumeId":5,"vmName":"i-2-5-VM","accountId":2,"id":5},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.223.110.232/export/h                   ome/sangeetha/campo-systemp-1/secondary","_role":"Image"}},"vmName":"i-2-5-VM","name":"test-2_ROOT-5_20130514162437","hypervisorType":"XenServer","i                   d":2}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"d9bade32-54ff-41d9-bb09-2b6388884f94","volumeType":"DATADISK","dataStore                   ":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"e97b5727-d157-3dc1-b32c-065b99806623","id":1,"poolType":"NetworkFilesystem","host"                   :"10.223.110.232","path":"/export/home/sangeetha/campo-systemp-1/primary","port":2049}},"name":"Volume123","size":8589934592,"volumeId":7,"accountId                   ":2,"id":7}},"wait":10800}}] }
> 2013-05-14 09:55:53,578 DEBUG [agent.transport.Request] (Job-Executor-21:job-19) Seq 1-738331999: Executing:  { Cmd , MgmtId: 206915885079359, via:                    1, Ver: v1, Flags: 100111, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"pat                   h":"snapshots/2/2/76979672-c725-4b20-a517-eb8410205ef6","volume":{"uuid":"5d0bd6d7-4ebe-4fb6-98ad-5df52850e739","volumeType":"ROOT","dataStore":{"or                   g.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"e97b5727-d157-3dc1-b32c-065b99806623","id":1,"poolType":"NetworkFilesystem","host":"10.2                   23.110.232","path":"/export/home/sangeetha/campo-systemp-1/primary","port":2049}},"name":"ROOT-5","size":8589934592,"path":"86b8d3a8-44c9-4bb0-b4fb-                   1ba98d3e4f75","volumeId":5,"vmName":"i-2-5-VM","accountId":2,"id":5},"dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.223.110.232/expor                   t/home/sangeetha/campo-systemp-1/secondary","_role":"Image"}},"vmName":"i-2-5-VM","name":"test-2_ROOT-5_20130514162437","hypervisorType":"XenServer"                   ,"id":2}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"d9bade32-54ff-41d9-bb09-2b6388884f94","volumeType":"DATADISK","dataSt                   ore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"e97b5727-d157-3dc1-b32c-065b99806623","id":1,"poolType":"NetworkFilesystem","ho                   st":"10.223.110.232","path":"/export/home/sangeetha/campo-systemp-1/primary","port":2049}},"name":"Volume123","size":8589934592,"volumeId":7,"accoun                   tId":2,"id":7}},"wait":10800}}] }
> 2013-05-14 09:55:53,578 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-62:null) Seq 1-738331999: Executing request
> 2013-05-14 09:55:53,578 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-62:null) Seq 1-738331999: Response Received:
> 2013-05-14 09:55:53,578 DEBUG [agent.transport.Request] (DirectAgent-62:null) Seq 1-738331999: Processing:  { Ans: , MgmtId: 206915885079359, via: 1                   , Ver: v1, Flags: 110, [{"com.cloud.agent.api.Answer":{"result":false,"details":"not implemented yet","wait":0}}] }
> 2013-05-14 09:55:53,579 DEBUG [agent.manager.AgentAttache] (DirectAgent-62:null) Seq 1-738331999: No more commands found
> 2013-05-14 09:55:53,579 DEBUG [agent.transport.Request] (Job-Executor-21:job-19) Seq 1-738331999: Received:  { Ans: , MgmtId: 206915885079359, via:                    1, Ver: v1, Flags: 110, { Answer } }
> 2013-05-14 09:55:53,590 DEBUG [cloud.storage.VolumeManagerImpl] (Job-Executor-21:job-19) Failed to create volume from snapshot:not implemented yet
> 2013-05-14 09:55:53,590 DEBUG [cloud.storage.VolumeManagerImpl] (Job-Executor-21:job-19) Failed to create volume: 7
> com.cloud.utils.exception.CloudRuntimeException: Failed to create volume from snapshot:not implemented yet
>         at com.cloud.storage.VolumeManagerImpl.createVolumeFromSnapshot(VolumeManagerImpl.java:544)
>         at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:12                   5)
>         at com.cloud.storage.VolumeManagerImpl.createVolumeFromSnapshot(VolumeManagerImpl.java:589)
>         at com.cloud.storage.VolumeManagerImpl.createVolume(VolumeManagerImpl.java:1006)
>         at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:12                   5)
>         at com.cloud.storage.VolumeManagerImpl.createVolume(VolumeManagerImpl.java:181)
>         at org.apache.cloudstack.api.command.user.volume.CreateVolumeCmd.execute(CreateVolumeCmd.java:168)
>         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-14 09:55:53,616 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-21:job-19) Complete async job-19, jobStatus: 2, resultCode: 530, resul                   t: Error Code: 530 Error text: Failed to create a volume

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