[
https://issues.apache.org/jira/browse/CLOUDSTACK-8964?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14966769#comment-14966769
]
ASF GitHub Bot commented on CLOUDSTACK-8964:
--------------------------------------------
Github user NuxRo commented on the pull request:
https://github.com/apache/cloudstack/pull/954#issuecomment-149887192
I used ovm3 initially and now I tried with ovm3guru, no luck, both
operations fail (create volume, create template).
> Can't create template or volume from snapshot - "Are you sure you got the
> right type of server?"
> ------------------------------------------------------------------------------------------------
>
> Key: CLOUDSTACK-8964
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-8964
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the
> default.)
> Components: Secondary Storage
> Affects Versions: 4.6.0
> Environment: CentOS 6 HVs & mgmt
> Reporter: Nux
> Priority: Blocker
>
> I have a couple of snapshots left-over from by now deleted instances. Trying
> to turn them into volumes fails with (UI/cloudmonkey shows this):
> "Failed to create templateUnsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?"
> mgmt server logs for when trying to create template:
> "2015-10-18 09:15:58,437 DEBUG [c.c.a.ApiServlet]
> (catalina-exec-5:ctx-84b2a9be) ===START=== 192.168.192.198 -- GET
> command=createTemplate&response=json&snapshotid=da79387b-ecae-4d5c-b414-3942d29ad821&name=testsnap1&displayText=testsnap1&osTypeId=ba03db1c-7359-11e5-b4d0-f2a3ece198a5&isPublic=false&passwordEnabled=false&isdynamicallyscalable=false&_=1445156157698
> 2015-10-18 09:15:58,459 DEBUG [c.c.t.TemplateManagerImpl]
> (catalina-exec-5:ctx-84b2a9be ctx-921b9b20) This template is getting created
> from other template, setting source template Id to: 201
> 2015-10-18 09:15:58,500 INFO [o.a.c.f.j.i.AsyncJobMonitor]
> (API-Job-Executor-33:ctx-f566f6af job-135) Add job-135 into job monitoring
> 2015-10-18 09:15:58,506 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (catalina-exec-5:ctx-84b2a9be ctx-921b9b20) submit async job-135, details:
> AsyncJobVO {id:135, userId: 2, accountId: 2, instanceType: Template,
> instanceId: 207, cmd:
> org.apache.cloudstack.api.command.admin.template.CreateTemplateCmdByAdmin,
> cmdInfo:
> {"cmdEventType":"TEMPLATE.CREATE","ctxUserId":"2","httpmethod":"GET","osTypeId":"ba03db1c-7359-11e5-b4d0-f2a3ece198a5","isPublic":"false","isdynamicallyscalable":"false","response":"json","id":"207","ctxDetails":"{\"interface
>
> com.cloud.template.VirtualMachineTemplate\":\"9c045e56-2463-47f8-a257-840656e1c0bd\",\"interface
>
> com.cloud.storage.Snapshot\":\"da79387b-ecae-4d5c-b414-3942d29ad821\",\"interface
>
> com.cloud.storage.GuestOS\":\"ba03db1c-7359-11e5-b4d0-f2a3ece198a5\"}","displayText":"testsnap1","snapshotid":"da79387b-ecae-4d5c-b414-3942d29ad821","passwordEnabled":"false","name":"testsnap1","_":"1445156157698","uuid":"9c045e56-2463-47f8-a257-840656e1c0bd","ctxAccountId":"2","ctxStartEventId":"253"},
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result:
> null, initMsid: 266785867798693, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: null}
> 2015-10-18 09:15:58,506 DEBUG [c.c.a.ApiServlet]
> (catalina-exec-5:ctx-84b2a9be ctx-921b9b20) ===END=== 192.168.192.198 -- GET
>
> command=createTemplate&response=json&snapshotid=da79387b-ecae-4d5c-b414-3942d29ad821&name=testsnap1&displayText=testsnap1&osTypeId=ba03db1c-7359-11e5-b4d0-f2a3ece198a5&isPublic=false&passwordEnabled=false&isdynamicallyscalable=false&_=1445156157698
> 2015-10-18 09:15:58,507 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Executing AsyncJobVO {id:135,
> userId: 2, accountId: 2, instanceType: Template, instanceId: 207, cmd:
> org.apache.cloudstack.api.command.admin.template.CreateTemplateCmdByAdmin,
> cmdInfo:
> {"cmdEventType":"TEMPLATE.CREATE","ctxUserId":"2","httpmethod":"GET","osTypeId":"ba03db1c-7359-11e5-b4d0-f2a3ece198a5","isPublic":"false","isdynamicallyscalable":"false","response":"json","id":"207","ctxDetails":"{\"interface
>
> com.cloud.template.VirtualMachineTemplate\":\"9c045e56-2463-47f8-a257-840656e1c0bd\",\"interface
>
> com.cloud.storage.Snapshot\":\"da79387b-ecae-4d5c-b414-3942d29ad821\",\"interface
>
> com.cloud.storage.GuestOS\":\"ba03db1c-7359-11e5-b4d0-f2a3ece198a5\"}","displayText":"testsnap1","snapshotid":"da79387b-ecae-4d5c-b414-3942d29ad821","passwordEnabled":"false","name":"testsnap1","_":"1445156157698","uuid":"9c045e56-2463-47f8-a257-840656e1c0bd","ctxAccountId":"2","ctxStartEventId":"253"},
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result:
> null, initMsid: 266785867798693, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: null}
> 2015-10-18 09:15:58,531 DEBUG [o.a.c.s.i.TemplateDataFactoryImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) template 207 is
> already in store:1, type:Image
> 2015-10-18 09:15:58,539 DEBUG [o.a.c.s.m.AncientDataMotionStrategy]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) copyAsync inspecting
> src type SNAPSHOT copyAsync inspecting dest type TEMPLATE
> 2015-10-18 09:15:58,545 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294)
> getCommandHostDelegation: class
> org.apache.cloudstack.storage.command.CopyCommand
> 2015-10-18 09:15:58,545 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) Snapshot to Template:
> org.apache.cloudstack.storage.command.CopyCommand
> 2015-10-18 09:15:58,548 DEBUG [c.c.a.t.Request]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) Seq
> 1-2581969961366860773: Sending { Cmd , MgmtId: 266785867798693, via:
> 1(server1707.cloud.priv), Ver: v1, Flags: 100111,
> [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/2/9/189d64ac-2621-46c6-9e00-f7f1e424bf44","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://192.168.200.67/secondary","_role":"Image"}},"name":"tests1","hypervisorType":"KVM","id":1,"quiescevm":false,"physicalSize":0}},"destTO":{"org.apache.cloudstack.storage.to.TemplateObjectTO":{"path":"template/tmpl/2/207","uuid":"9c045e56-2463-47f8-a257-840656e1c0bd","id":207,"format":"RAW","accountId":2,"hvm":true,"displayText":"testsnap1","imageDataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://192.168.200.67/secondary","_role":"Image"}},"name":"207-2-7e2f5898-46bb-3110-9b17-ee4fa27a3f4a","hypervisorType":"KVM"}},"executeInSequence":true,"options":{},"options2":{},"wait":10800}}]
> }
> 2015-10-18 09:15:58,591 DEBUG [c.c.a.t.Request]
> (AgentManager-Handler-11:null) Seq 1-2581969961366860773: Processing: { Ans:
> , MgmtId: 266785867798693, via: 1, Ver: v1, Flags: 110,
> [{"com.cloud.agent.api.UnsupportedAnswer":{"result":false,"details":"Unsupported
> command issued: org.apache.cloudstack.storage.command.CopyCommand. Are you
> sure you got the right type of server?","wait":0}}] }
> 2015-10-18 09:15:58,591 DEBUG [c.c.a.m.AgentAttache]
> (AgentManager-Handler-11:null) Seq 1-2581969961366860773: No more commands
> found
> 2015-10-18 09:15:58,591 DEBUG [c.c.a.t.Request]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) Seq
> 1-2581969961366860773: Received: { Ans: , MgmtId: 266785867798693, via: 1,
> Ver: v1, Flags: 110, { UnsupportedAnswer } }
> 2015-10-18 09:15:58,591 WARN [c.c.a.m.AgentManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) Unsupported Command:
> Unsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?
> 2015-10-18 09:15:58,600 DEBUG [c.c.t.TemplateManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135 ctx-bd1cf294) Failed to create
> templateUnsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?
> 2015-10-18 09:15:58,614 ERROR [c.c.a.ApiAsyncJobDispatcher]
> (API-Job-Executor-33:ctx-f566f6af job-135) Unexpected exception while
> executing
> org.apache.cloudstack.api.command.admin.template.CreateTemplateCmdByAdmin
> com.cloud.utils.exception.CloudRuntimeException: Failed to create
> templateUnsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?
> at
> com.cloud.template.TemplateManagerImpl.createPrivateTemplate(TemplateManagerImpl.java:1498)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:606)
> at
> org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
> at
> org.apache.cloudstack.network.contrail.management.EventUtils$EventInterceptor.invoke(EventUtils.java:106)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
> at
> com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:51)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
> at
> org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:91)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
> at
> org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
> at com.sun.proxy.$Proxy185.createPrivateTemplate(Unknown Source)
> at
> org.apache.cloudstack.api.command.admin.template.CreateTemplateCmdByAdmin.execute(CreateTemplateCmdByAdmin.java:43)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:150)
> at
> com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:108)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:537)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:494)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> 2015-10-18 09:15:58,615 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Complete async job-135, jobStatus:
> FAILED, resultCode: 530, result:
> org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":530,"errortext":"Failed
> to create templateUnsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?"}
> 2015-10-18 09:15:58,616 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Publish async job-135 complete on
> message bus
> 2015-10-18 09:15:58,616 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Wake up jobs related to job-135
> 2015-10-18 09:15:58,616 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Update db status for job-135
> 2015-10-18 09:15:58,617 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Wake up jobs joined with job-135
> and disjoin all subjobs created from job- 135
> 2015-10-18 09:15:58,622 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-33:ctx-f566f6af job-135) Done executing
> org.apache.cloudstack.api.command.admin.template.CreateTemplateCmdByAdmin for
> job-135
> 2015-10-18 09:15:58,622 INFO [o.a.c.f.j.i.AsyncJobMonitor]
> (API-Job-Executor-33:ctx-f566f6af job-135) Remove job-135 from job monitoring
> 2015-10-18 09:16:00,186 DEBUG [o.a.c.s.SecondaryStorageManagerImpl]
> (secstorage-1:ctx-b1ebd7ae) Zone 1 is ready to launch secondary storage VM
> 2015-10-18 09:16:00,284 DEBUG [c.c.c.ConsoleProxyManagerImpl]
> (consoleproxy-1:ctx-504e558f) Zone 1 is ready to launch console proxy
> 2015-10-18 09:16:00,913 DEBUG [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-10:null) SeqA 3-29514: Processing Seq 3-29514: { Cmd ,
> MgmtId: -1, via: 3, Ver: v1, Flags: 11,
> [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n
> \"connections\": []\n}","wait":0}}] }
> 2015-10-18 09:16:00,918 DEBUG [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-10:null) SeqA 3-29514: Sending Seq 3-29514: { Ans: ,
> MgmtId: 266785867798693, via: 3, Ver: v1, Flags: 100010,
> [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }"
> mgmt server log for when trying to create volume from snapshot:
> "2015-10-18 09:22:54,554 DEBUG [c.c.a.ApiServlet]
> (catalina-exec-25:ctx-a0b2e544 ctx-ed58876f) ===END=== 192.168.192.198 --
> GET command=listZones&available=true&response=json&_=1445156573821
> 2015-10-18 09:22:59,041 DEBUG [c.c.a.ApiServlet]
> (catalina-exec-10:ctx-b4b4be7d) ===START=== 192.168.192.198 -- GET
> command=createVolume&response=json&snapshotid=da79387b-ecae-4d5c-b414-3942d29ad821&name=etetete&_=1445156578325
> 2015-10-18 09:22:59,080 INFO [o.a.c.f.j.i.AsyncJobMonitor]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Add job-137 into job monitoring
> 2015-10-18 09:22:59,086 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (catalina-exec-10:ctx-b4b4be7d ctx-323d5529) submit async job-137, details:
> AsyncJobVO {id:137, userId: 2, accountId: 2, instanceType: Volume,
> instanceId: 13, cmd:
> org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin,
> cmdInfo: {"id":"13","response":"json","ctxDetails":"{\"interface
> com.cloud.storage.Volume\":\"57ef80a3-d160-41ba-ba27-d2858d0499ad\",\"interface
>
> com.cloud.storage.Snapshot\":\"da79387b-ecae-4d5c-b414-3942d29ad821\"}","cmdEventType":"VOLUME.CREATE","ctxUserId":"2","snapshotid":"da79387b-ecae-4d5c-b414-3942d29ad821","name":"etetete","httpmethod":"GET","_":"1445156578325","uuid":"57ef80a3-d160-41ba-ba27-d2858d0499ad","ctxAccountId":"2","ctxStartEventId":"261"},
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result:
> null, initMsid: 266785867798693, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: null}
> 2015-10-18 09:22:59,086 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Executing AsyncJobVO {id:137,
> userId: 2, accountId: 2, instanceType: Volume, instanceId: 13, cmd:
> org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin,
> cmdInfo: {"id":"13","response":"json","ctxDetails":"{\"interface
> com.cloud.storage.Volume\":\"57ef80a3-d160-41ba-ba27-d2858d0499ad\",\"interface
>
> com.cloud.storage.Snapshot\":\"da79387b-ecae-4d5c-b414-3942d29ad821\"}","cmdEventType":"VOLUME.CREATE","ctxUserId":"2","snapshotid":"da79387b-ecae-4d5c-b414-3942d29ad821","name":"etetete","httpmethod":"GET","_":"1445156578325","uuid":"57ef80a3-d160-41ba-ba27-d2858d0499ad","ctxAccountId":"2","ctxStartEventId":"261"},
> cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result:
> null, initMsid: 266785867798693, completeMsid: null, lastUpdated: null,
> lastPolled: null, created: null}
> 2015-10-18 09:22:59,086 DEBUG [c.c.a.ApiServlet]
> (catalina-exec-10:ctx-b4b4be7d ctx-323d5529) ===END=== 192.168.192.198 --
> GET
> command=createVolume&response=json&snapshotid=da79387b-ecae-4d5c-b414-3942d29ad821&name=etetete&_=1445156578325
> 2015-10-18 09:22:59,102 DEBUG [o.a.c.s.a.LocalStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829)
> LocalStoragePoolAllocator trying to find storage pool to fit the vm
> 2015-10-18 09:22:59,102 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829)
> ClusterScopeStoragePoolAllocator looking for storage pool
> 2015-10-18 09:22:59,102 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Looking for pools in
> dc: 1 pod:1 cluster:null. Disabled pools will be ignored.
> 2015-10-18 09:22:59,103 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Found pools matching
> tags: []
> 2015-10-18 09:22:59,103 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) No storage pools
> available for shared volume allocation, returning
> 2015-10-18 09:22:59,103 DEBUG [o.a.c.s.a.ZoneWideStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829)
> ZoneWideStoragePoolAllocator to find storage pool
> 2015-10-18 09:22:59,106 DEBUG [o.a.c.s.a.AbstractStoragePoolAllocator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Checking if storage
> pool is suitable, name: null ,poolId: 2
> 2015-10-18 09:22:59,107 INFO [c.c.s.StorageManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Storage pool null (2)
> does not supply IOPS capacity, assuming enough capacity
> 2015-10-18 09:22:59,108 DEBUG [c.c.s.StorageManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Checking pool 2 for
> storage, totalSize: 249934381056, usedBytes: 132560977920, usedPct:
> 0.5303831244021547, disable threshold: 0.85
> 2015-10-18 09:22:59,112 DEBUG [c.c.s.StorageManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Found storage pool
> pri1nfs of type NetworkFilesystem with overprovisioning factor 2
> 2015-10-18 09:22:59,112 DEBUG [c.c.s.StorageManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Total over
> provisioned capacity calculated is 2 * 249934381056
> 2015-10-18 09:22:59,112 DEBUG [c.c.s.StorageManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Total capacity of the
> pool pri1nfs id: 2 is 499868762112
> 2015-10-18 09:22:59,113 DEBUG [c.c.s.StorageManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Checking pool: 2 for
> volume allocation [Vol[13|vm=null|DATADISK]], maxSize : 499868762112,
> totalAllocatedSize : 317901312, askingSize : 52428800, allocated disable
> threshold: 0.85
> 2015-10-18 09:22:59,113 DEBUG [o.a.c.e.o.VolumeOrchestrator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Found a suitable pool
> for create volume: 2
> 2015-10-18 09:22:59,133 DEBUG [o.a.c.s.m.AncientDataMotionStrategy]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) copyAsync inspecting
> src type SNAPSHOT copyAsync inspecting dest type VOLUME
> 2015-10-18 09:22:59,137 DEBUG [c.c.h.o.r.Ovm3HypervisorGuru]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829)
> getCommandHostDelegation: class
> org.apache.cloudstack.storage.command.CopyCommand
> 2015-10-18 09:22:59,138 DEBUG [c.c.a.t.Request]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Seq
> 1-2581969961366860796: Sending { Cmd , MgmtId: 266785867798693, via:
> 1(server1707.cloud.priv), Ver: v1, Flags: 100111,
> [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.SnapshotObjectTO":{"path":"snapshots/2/9/189d64ac-2621-46c6-9e00-f7f1e424bf44","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://192.168.200.67/secondary","_role":"Image"}},"name":"tests1","hypervisorType":"KVM","id":1,"quiescevm":false,"physicalSize":0}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"57ef80a3-d160-41ba-ba27-d2858d0499ad","volumeType":"DATADISK","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"29d6d3ac-1805-3501-89e4-9287e05f2398","id":2,"poolType":"NetworkFilesystem","host":"192.168.203.67","path":"/primary","port":2049,"url":"NetworkFilesystem://192.168.203.67/primary/?ROLE=Primary&STOREUUID=29d6d3ac-1805-3501-89e4-9287e05f2398"}},"name":"etetete","size":52428800,"volumeId":13,"accountId":2,"format":"QCOW2","provisioningType":"THIN","id":13,"hypervisorType":"KVM"}},"executeInSequence":true,"options":{},"options2":{},"wait":10800}}]
> }
> 2015-10-18 09:22:59,203 DEBUG [c.c.a.t.Request]
> (AgentManager-Handler-14:null) Seq 1-2581969961366860796: Processing: { Ans:
> , MgmtId: 266785867798693, via: 1, Ver: v1, Flags: 110,
> [{"com.cloud.agent.api.UnsupportedAnswer":{"result":false,"details":"Unsupported
> command issued: org.apache.cloudstack.storage.command.CopyCommand. Are you
> sure you got the right type of server?","wait":0}}] }
> 2015-10-18 09:22:59,203 DEBUG [c.c.a.m.AgentAttache]
> (AgentManager-Handler-14:null) Seq 1-2581969961366860796: No more commands
> found
> 2015-10-18 09:22:59,203 DEBUG [c.c.a.t.Request]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Seq
> 1-2581969961366860796: Received: { Ans: , MgmtId: 266785867798693, via: 1,
> Ver: v1, Flags: 110, { UnsupportedAnswer } }
> 2015-10-18 09:22:59,203 WARN [c.c.a.m.AgentManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Unsupported Command:
> Unsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?
> 2015-10-18 09:22:59,209 WARN [o.a.c.s.d.ObjectInDataStoreManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Unsupported data
> object (VOLUME,
> org.apache.cloudstack.storage.datastore.PrimaryDataStoreImpl@10b8a20a), no
> need to delete from object in store ref table
> 2015-10-18 09:22:59,215 WARN [o.a.c.s.d.ObjectInDataStoreManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Snapshot 1 is not
> found on image store 1, so no need to delete
> 2015-10-18 09:22:59,215 DEBUG [o.a.c.e.o.VolumeOrchestrator]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Failed to create
> volume from snapshot:Unsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?
> 2015-10-18 09:22:59,231 DEBUG [c.c.u.AccountManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137 ctx-5a575829) Access granted to
> Acct[cf13e45c-7359-11e5-b4d0-f2a3ece198a5-admin] to Domain:1/ by
> AffinityGroupAccessChecker
> 2015-10-18 09:22:59,243 ERROR [c.c.a.ApiAsyncJobDispatcher]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Unexpected exception while
> executing
> org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin
> com.cloud.utils.exception.CloudRuntimeException: Failed to create volume: 13
> at
> com.cloud.storage.VolumeApiServiceImpl.createVolume(VolumeApiServiceImpl.java:776)
> at
> com.cloud.storage.VolumeApiServiceImpl.createVolume(VolumeApiServiceImpl.java:172)
> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
> at
> sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
> at
> sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
> at java.lang.reflect.Method.invoke(Method.java:606)
> at
> org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150)
> at
> org.apache.cloudstack.network.contrail.management.EventUtils$EventInterceptor.invoke(EventUtils.java:106)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
> at
> com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:51)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
> at
> org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:91)
> at
> org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172)
> at
> org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204)
> at com.sun.proxy.$Proxy195.createVolume(Unknown Source)
> at
> org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin.execute(CreateVolumeCmdByAdmin.java:42)
> at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:150)
> at
> com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:108)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:537)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103)
> at
> org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53)
> at
> org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46)
> at
> org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.java:494)
> at
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
> at java.util.concurrent.FutureTask.run(FutureTask.java:262)
> at
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:745)
> Caused by: com.cloud.utils.exception.CloudRuntimeException: Failed to create
> volume from snapshot:Unsupported command issued:
> org.apache.cloudstack.storage.command.CopyCommand. Are you sure you got the
> right type of server?
> at
> org.apache.cloudstack.engine.orchestration.VolumeOrchestrator.createVolumeFromSnapshot(VolumeOrchestrator.java:402)
> at
> com.cloud.storage.VolumeApiServiceImpl.createVolumeFromSnapshot(VolumeApiServiceImpl.java:798)
> at
> com.cloud.storage.VolumeApiServiceImpl.createVolume(VolumeApiServiceImpl.java:748)
> ... 31 more
> 2015-10-18 09:22:59,244 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Complete async job-137, jobStatus:
> FAILED, resultCode: 530, result:
> org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":530,"errortext":"Failed
> to create volume: 13"}
> 2015-10-18 09:22:59,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Publish async job-137 complete on
> message bus
> 2015-10-18 09:22:59,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Wake up jobs related to job-137
> 2015-10-18 09:22:59,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Update db status for job-137
> 2015-10-18 09:22:59,245 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Wake up jobs joined with job-137
> and disjoin all subjobs created from job- 137
> 2015-10-18 09:22:59,250 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Done executing
> org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin for
> job-137
> 2015-10-18 09:22:59,250 INFO [o.a.c.f.j.i.AsyncJobMonitor]
> (API-Job-Executor-35:ctx-58dc6474 job-137) Remove job-137 from job monitoring
> 2015-10-18 09:23:00,186 DEBUG [o.a.c.s.SecondaryStorageManagerImpl]
> (secstorage-1:ctx-f43244c2) Zone 1 is ready to launch secondary storage VM
> 2015-10-18 09:23:00,284 DEBUG [c.c.c.ConsoleProxyManagerImpl]
> (consoleproxy-1:ctx-49b9abf0) Zone 1 is ready to launch console proxy
> 2015-10-18 09:23:00,941 DEBUG [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-2:null) SeqA 3-29565: Processing Seq 3-29565: { Cmd ,
> MgmtId: -1, via: 3, Ver: v1, Flags: 11,
> [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n
> \"connections\": []\n}","wait":0}}] }
> 2015-10-18 09:23:00,946 DEBUG [c.c.a.m.AgentManagerImpl]
> (AgentManager-Handler-2:null) SeqA 3-29565: Sending Seq 3-29565: { Ans: ,
> MgmtId: 266785867798693, via: 3, Ver: v1, Flags: 100010,
> [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }"
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)
