You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Abhinav Roy (JIRA)" <ji...@apache.org> on 2014/06/02 10:23:02 UTC

[jira] [Closed] (CLOUDSTACK-6802) Attaching a data disk created on local storage to a VM is failing

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

Abhinav Roy closed CLOUDSTACK-6802.
-----------------------------------


Closing the issue after fix validation

> Attaching a data disk created on local storage to a VM is failing
> -----------------------------------------------------------------
>
>                 Key: CLOUDSTACK-6802
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-6802
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: Management Server, Storage Controller
>    Affects Versions: 4.4.0
>            Reporter: Abhinav Roy
>            Assignee: Devdeep Singh
>            Priority: Critical
>              Labels: hyper-V,, hyper-v, hyperv
>             Fix For: 4.4.0
>
>
> Steps :
> =========================
> 1. Deploy a CS advanced zone setup with both local storage and shared storage enabled.
> 2. Deploy  VMs. ( both on shared and local storage)
> 3. create a disk offering with local storage
> 4. Create a data disk with local storage disk offering.
> 5. attach the datadisk created on step 4 to VM created on step 2
> Expected result :
> =======================
> Volume should be attached successfully.
> Observed result :
> ======================
> volume attach fails with following error.
> 2014-05-29 13:02:45,410 DEBUG [c.c.a.ApiServlet] (catalina-exec-16:ctx-87ef4f22) ===START===  10.101.254.225 -- GET  command=createVolume&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&name=data-local2&zoneId=242c701a-43e8-4790-84f3-9112ca0b5db7&diskOfferingId=8cf4d614-08b8-455c-a99f-814f4b109d24&_=1401348494217
> 2014-05-29 13:02:45,466 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (catalina-exec-16:ctx-87ef4f22 ctx-bf1bb5b6) submit async job-64, details: AsyncJobVO {id:64, userId: 2, accountId: 2, instanceType: Volume, instanceId: 18, cmd: org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin, cmdInfo: {"id":"18","response":"json","sessionkey":"YYidBdJcBJV64kdZ8c+KOeSqY14\u003d","ctxDetails":"{\"com.cloud.storage.Volume\":18,\"Volume\":\"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d\",\"com.cloud.dc.DataCenter\":1,\"com.cloud.offering.DiskOffering\":14}","cmdEventType":"VOLUME.CREATE","ctxUserId":"2","name":"data-local2","diskOfferingId":"8cf4d614-08b8-455c-a99f-814f4b109d24","httpmethod":"GET","_":"1401348494217","uuid":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","ctxAccountId":"2","ctxStartEventId":"125","zoneId":"242c701a-43e8-4790-84f3-9112ca0b5db7"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2014-05-29 13:02:45,467 DEBUG [c.c.a.ApiServlet] (catalina-exec-16:ctx-87ef4f22 ctx-bf1bb5b6) ===END===  10.101.254.225 -- GET  command=createVolume&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&name=data-local2&zoneId=242c701a-43e8-4790-84f3-9112ca0b5db7&diskOfferingId=8cf4d614-08b8-455c-a99f-814f4b109d24&_=1401348494217
> 2014-05-29 13:02:45,470 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-14:ctx-23711cb3 job-64) Add job-64 into job monitoring
> 2014-05-29 13:02:45,470 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-14:ctx-23711cb3 job-64) Executing AsyncJobVO {id:64, userId: 2, accountId: 2, instanceType: Volume, instanceId: 18, cmd: org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin, cmdInfo: {"id":"18","response":"json","sessionkey":"YYidBdJcBJV64kdZ8c+KOeSqY14\u003d","ctxDetails":"{\"com.cloud.storage.Volume\":18,\"Volume\":\"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d\",\"com.cloud.dc.DataCenter\":1,\"com.cloud.offering.DiskOffering\":14}","cmdEventType":"VOLUME.CREATE","ctxUserId":"2","name":"data-local2","diskOfferingId":"8cf4d614-08b8-455c-a99f-814f4b109d24","httpmethod":"GET","_":"1401348494217","uuid":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","ctxAccountId":"2","ctxStartEventId":"125","zoneId":"242c701a-43e8-4790-84f3-9112ca0b5db7"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2014-05-29 13:02:45,475 WARN  [c.c.a.d.ParamGenericValidationWorker] (API-Job-Executor-14:ctx-23711cb3 job-64 ctx-5e5a2bf1) Received unknown parameters for command createVolume. Unknown parameters : ctxdetails
> 2014-05-29 13:02:45,501 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-14:ctx-23711cb3 job-64 ctx-5e5a2bf1) Complete async job-64, jobStatus: SUCCEEDED, resultCode: 0, result: org.apache.cloudstack.api.response.VolumeResponse/volume/{"id":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","name":"data-local2","zoneid":"242c701a-43e8-4790-84f3-9112ca0b5db7","zonename":"hyperv","type":"DATADISK","size":3221225472,"created":"2014-05-29T13:02:45+0530","state":"Allocated","account":"admin","domainid":"c190bda2-e497-11e3-8557-c264afd952f5","domain":"ROOT","storagetype":"local","hypervisor":"None","diskofferingid":"8cf4d614-08b8-455c-a99f-814f4b109d24","diskofferingname":"local","diskofferingdisplaytext":"local","destroyed":false,"isextractable":true,"tags":[],"displayvolume":true,"quiescevm":false,"jobid":"109c52a3-4163-44db-b438-258e5e4964af","jobstatus":0}
> 2014-05-29 13:02:45,507 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-14:ctx-23711cb3 job-64) Done executing org.apache.cloudstack.api.command.admin.volume.CreateVolumeCmdByAdmin for job-64
> 2014-05-29 13:02:45,510 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-14:ctx-23711cb3 job-64) Remove job-64 from job monitoring
> 2014-05-29 13:02:48,085 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-1:null) SeqA 3-57302: Processing Seq 3-57302:  { Cmd , MgmtId: -1, via: 3, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n  \"connections\": []\n}","wait":0}}] }
> 2014-05-29 13:02:48,088 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-1:null) SeqA 3-57302: Sending Seq 3-57302:  { Ans: , MgmtId: 213737702773493, via: 3, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
> 2014-05-29 13:02:48,589 DEBUG [c.c.a.ApiServlet] (catalina-exec-13:ctx-d271c568) ===START===  10.101.254.225 -- GET  command=queryAsyncJobResult&jobId=109c52a3-4163-44db-b438-258e5e4964af&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&_=1401348497515
> 2014-05-29 13:02:48,607 DEBUG [c.c.a.ApiServlet] (catalina-exec-13:ctx-d271c568 ctx-fb9bf614) ===END===  10.101.254.225 -- GET  command=queryAsyncJobResult&jobId=109c52a3-4163-44db-b438-258e5e4964af&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&_=1401348497515
> 2014-05-29 13:02:49,898 DEBUG [c.c.a.ApiServlet] (catalina-exec-6:ctx-a1b32fd9) ===START===  10.101.254.225 -- GET  command=listVolumes&id=dd5d8d32-03b4-4afd-80ca-58586c7c9e8d&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&_=1401348498800
> 2014-05-29 13:02:49,914 DEBUG [c.c.a.ApiServlet] (catalina-exec-6:ctx-a1b32fd9 ctx-da942c63) ===END===  10.101.254.225 -- GET  command=listVolumes&id=dd5d8d32-03b4-4afd-80ca-58586c7c9e8d&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&_=1401348498800
> 2014-05-29 13:02:51,929 DEBUG [c.c.a.ApiServlet] (catalina-exec-21:ctx-d170c74c) ===START===  10.101.254.225 -- GET  command=listVirtualMachines&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&zoneid=242c701a-43e8-4790-84f3-9112ca0b5db7&domainid=c190bda2-e497-11e3-8557-c264afd952f5&account=admin&state=Running&_=1401348500887
> 2014-05-29 13:02:51,939 DEBUG [c.c.u.AccountManagerImpl] (catalina-exec-21:ctx-d170c74c ctx-1d221a22) Access granted to Acct[f3f99282-e497-11e3-8557-c264afd952f5-admin] to Domain:1/ by AffinityGroupAccessChecker
> 2014-05-29 13:02:51,993 DEBUG [c.c.a.ApiServlet] (catalina-exec-21:ctx-d170c74c ctx-1d221a22) ===END===  10.101.254.225 -- GET  command=listVirtualMachines&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&zoneid=242c701a-43e8-4790-84f3-9112ca0b5db7&domainid=c190bda2-e497-11e3-8557-c264afd952f5&account=admin&state=Running&_=1401348500887
> 2014-05-29 13:02:52,079 DEBUG [c.c.a.ApiServlet] (catalina-exec-11:ctx-55eeb5f4) ===START===  10.101.254.225 -- GET  command=listVirtualMachines&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&zoneid=242c701a-43e8-4790-84f3-9112ca0b5db7&domainid=c190bda2-e497-11e3-8557-c264afd952f5&account=admin&state=Stopped&_=1401348501034
> 2014-05-29 13:02:52,088 DEBUG [c.c.u.AccountManagerImpl] (catalina-exec-11:ctx-55eeb5f4 ctx-db0754d3) Access granted to Acct[f3f99282-e497-11e3-8557-c264afd952f5-admin] to Domain:1/ by AffinityGroupAccessChecker
> 2014-05-29 13:02:52,100 DEBUG [c.c.a.ApiServlet] (catalina-exec-11:ctx-55eeb5f4 ctx-db0754d3) ===END===  10.101.254.225 -- GET  command=listVirtualMachines&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&zoneid=242c701a-43e8-4790-84f3-9112ca0b5db7&domainid=c190bda2-e497-11e3-8557-c264afd952f5&account=admin&state=Stopped&_=1401348501034
> 2014-05-29 13:02:53,089 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 3-57303: Processing Seq 3-57303:  { Cmd , MgmtId: -1, via: 3, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n  \"connections\": []\n}","wait":0}}] }
> 2014-05-29 13:02:53,093 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 3-57303: Sending Seq 3-57303:  { Ans: , MgmtId: 213737702773493, via: 3, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
> 2014-05-29 13:02:53,659 DEBUG [c.c.a.ApiServlet] (catalina-exec-14:ctx-f26e23d2) ===START===  10.101.254.225 -- GET  command=attachVolume&id=dd5d8d32-03b4-4afd-80ca-58586c7c9e8d&virtualMachineId=83b71999-cf87-49c8-8634-57829534fa46&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&_=1401348502533
> 2014-05-29 13:02:53,700 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (catalina-exec-14:ctx-f26e23d2 ctx-4696969d) submit async job-65, details: AsyncJobVO {id:65, userId: 2, accountId: 2, instanceType: Volume, instanceId: 18, cmd: org.apache.cloudstack.api.command.admin.volume.AttachVolumeCmdByAdmin, cmdInfo: {"response":"json","id":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","sessionkey":"YYidBdJcBJV64kdZ8c+KOeSqY14\u003d","ctxDetails":"{\"com.cloud.storage.Volume\":18,\"Volume\":\"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d\",\"com.cloud.vm.VirtualMachine\":10}","cmdEventType":"VOLUME.ATTACH","ctxUserId":"2","virtualMachineId":"83b71999-cf87-49c8-8634-57829534fa46","httpmethod":"GET","_":"1401348502533","uuid":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","ctxAccountId":"2","ctxStartEventId":"129"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2014-05-29 13:02:53,701 DEBUG [c.c.a.ApiServlet] (catalina-exec-14:ctx-f26e23d2 ctx-4696969d) ===END===  10.101.254.225 -- GET  command=attachVolume&id=dd5d8d32-03b4-4afd-80ca-58586c7c9e8d&virtualMachineId=83b71999-cf87-49c8-8634-57829534fa46&response=json&sessionkey=YYidBdJcBJV64kdZ8c%2BKOeSqY14%3D&_=1401348502533
> 2014-05-29 13:02:53,702 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (API-Job-Executor-15:ctx-cbdb1b18 job-65) Add job-65 into job monitoring
> 2014-05-29 13:02:53,702 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-15:ctx-cbdb1b18 job-65) Executing AsyncJobVO {id:65, userId: 2, accountId: 2, instanceType: Volume, instanceId: 18, cmd: org.apache.cloudstack.api.command.admin.volume.AttachVolumeCmdByAdmin, cmdInfo: {"response":"json","id":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","sessionkey":"YYidBdJcBJV64kdZ8c+KOeSqY14\u003d","ctxDetails":"{\"com.cloud.storage.Volume\":18,\"Volume\":\"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d\",\"com.cloud.vm.VirtualMachine\":10}","cmdEventType":"VOLUME.ATTACH","ctxUserId":"2","virtualMachineId":"83b71999-cf87-49c8-8634-57829534fa46","httpmethod":"GET","_":"1401348502533","uuid":"dd5d8d32-03b4-4afd-80ca-58586c7c9e8d","ctxAccountId":"2","ctxStartEventId":"129"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2014-05-29 13:02:53,712 WARN  [c.c.a.d.ParamGenericValidationWorker] (API-Job-Executor-15:ctx-cbdb1b18 job-65 ctx-0cee308d) Received unknown parameters for command attachVolume. Unknown parameters : ctxdetails
> 2014-05-29 13:02:53,724 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-15:ctx-cbdb1b18 job-65 ctx-0cee308d) Sync job-66 execution on object VmWorkJobQueue.10
> 2014-05-29 13:02:53,727 DEBUG [c.c.s.VolumeApiServiceImpl] (API-Job-Executor-15:ctx-cbdb1b18 job-65 ctx-0cee308d) New job 66, result field: null
> 2014-05-29 13:02:53,727 WARN  [c.c.u.d.Merovingian2] (API-Job-Executor-15:ctx-cbdb1b18 job-65 ctx-0cee308d) Was unable to find lock for the key vm_instance10 and thread id 1410233040
> 2014-05-29 13:02:54,454 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-8739672c) Execute sync-queue item: SyncQueueItemVO {id:23, queueId: 17, contentType: AsyncJob, contentId: 66, lastProcessMsid: null, lastprocessNumber: null, lastProcessTime: null, created: Thu May 29 13:02:53 IST 2014}
> 2014-05-29 13:02:54,456 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-8739672c) Schedule queued job-66
> 2014-05-29 13:02:54,477 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Add job-66 into job monitoring
> 2014-05-29 13:02:54,477 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Executing AsyncJobVO {id:66, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.storage.VmWorkAttachVolume, cmdInfo: rO0ABXNyACRjb20uY2xvdWQuc3RvcmFnZS5WbVdvcmtBdHRhY2hWb2x1bWUHra_5YYfiHAIAAkwACGRldmljZUlkdAAQTGphdmEvbGFuZy9Mb25nO0wACHZvbHVtZUlkcQB-AAF4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1ldAASTGphdmEvbGFuZy9TdHJpbmc7eHAAAAAAAAAAAgAAAAAAAAACAAAAAAAAAAp0ABRWb2x1bWVBcGlTZXJ2aWNlSW1wbHBzcgAOamF2YS5sYW5nLkxvbmc7i-SQzI8j3wIAAUoABXZhbHVleHIAEGphdmEubGFuZy5OdW1iZXKGrJUdC5TgiwIAAHhwAAAAAAAAABI, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: null, lastUpdated: null, lastPolled: null, created: Thu May 29 13:02:53 IST 2014}
> 2014-05-29 13:02:54,477 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Run VM work job: com.cloud.storage.VmWorkAttachVolume for VM 10, job origin: 65
> 2014-05-29 13:02:54,479 DEBUG [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) Execute VM work job: com.cloud.storage.VmWorkAttachVolume{"volumeId":18,"userId":2,"accountId":2,"vmId":10,"handlerName":"VolumeApiServiceImpl"}
> 2014-05-29 13:02:54,501 DEBUG [o.a.c.s.a.LocalStoragePoolAllocator] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) LocalStoragePoolAllocator trying to find storage pool to fit the vm
> 2014-05-29 13:02:54,503 DEBUG [o.a.c.s.a.LocalStoragePoolAllocator] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) LocalStoragePoolAllocator returning 0 suitable storage pools
> 2014-05-29 13:02:54,504 DEBUG [o.a.c.s.a.ClusterScopeStoragePoolAllocator] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) ClusterScopeStoragePoolAllocator looking for storage pool
> 2014-05-29 13:02:54,504 DEBUG [o.a.c.s.a.ZoneWideStoragePoolAllocator] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) ZoneWideStoragePoolAllocator to find storage pool
> 2014-05-29 13:02:54,504 WARN  [o.a.c.e.o.VolumeOrchestrator] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) Unable to find suitable primary storage when creating volume data-local2
> 2014-05-29 13:02:54,504 ERROR [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) Invocation exception, caused by: com.cloud.utils.exception.CloudRuntimeException: Unable to find suitable primary storage when creating volume data-local2
> 2014-05-29 13:02:54,504 INFO  [c.c.v.VmWorkJobHandlerProxy] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66 ctx-8e2aeba5) Rethrow exception com.cloud.utils.exception.CloudRuntimeException: Unable to find suitable primary storage when creating volume data-local2
> 2014-05-29 13:02:54,504 DEBUG [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Done with run of VM work job: com.cloud.storage.VmWorkAttachVolume for VM 10, job origin: 65
> 2014-05-29 13:02:54,505 ERROR [c.c.v.VmWorkJobDispatcher] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Unable to complete AsyncJobVO {id:66, userId: 2, accountId: 2, instanceType: null, instanceId: null, cmd: com.cloud.storage.VmWorkAttachVolume, cmdInfo: rO0ABXNyACRjb20uY2xvdWQuc3RvcmFnZS5WbVdvcmtBdHRhY2hWb2x1bWUHra_5YYfiHAIAAkwACGRldmljZUlkdAAQTGphdmEvbGFuZy9Mb25nO0wACHZvbHVtZUlkcQB-AAF4cgATY29tLmNsb3VkLnZtLlZtV29ya5-ZtlbwJWdrAgAESgAJYWNjb3VudElkSgAGdXNlcklkSgAEdm1JZEwAC2hhbmRsZXJOYW1ldAASTGphdmEvbGFuZy9TdHJpbmc7eHAAAAAAAAAAAgAAAAAAAAACAAAAAAAAAAp0ABRWb2x1bWVBcGlTZXJ2aWNlSW1wbHBzcgAOamF2YS5sYW5nLkxvbmc7i-SQzI8j3wIAAUoABXZhbHVleHIAEGphdmEubGFuZy5OdW1iZXKGrJUdC5TgiwIAAHhwAAAAAAAAABI, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: null, lastUpdated: null, lastPolled: null, created: Thu May 29 13:02:53 IST 2014}, job origin:65
> com.cloud.utils.exception.CloudRuntimeException: Unable to find suitable primary storage when creating volume data-local2
>         at org.apache.cloudstack.engine.orchestration.VolumeOrchestrator.createVolume(VolumeOrchestrator.java:447)
>         at org.apache.cloudstack.engine.orchestration.VolumeOrchestrator.createVolumeOnPrimaryStorage(VolumeOrchestrator.java:734)
>         at com.cloud.storage.VolumeApiServiceImpl.attachVolumeToVM(VolumeApiServiceImpl.java:1186)
>         at com.cloud.storage.VolumeApiServiceImpl.orchestrateAttachVolumeToVM(VolumeApiServiceImpl.java:1054)
>         at com.cloud.storage.VolumeApiServiceImpl.orchestrateAttachVolumeToVM(VolumeApiServiceImpl.java:2475)
>         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:601)
>         at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
>         at com.cloud.storage.VolumeApiServiceImpl.handleVmWorkJob(VolumeApiServiceImpl.java:2510)
>         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:601)
>         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.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 $Proxy181.handleVmWorkJob(Unknown Source)
>         at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102)
>         at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
>         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:460)
>         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:722)
> 2014-05-29 13:02:54,525 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Complete async job-66, jobStatus: FAILED, resultCode: 0, result: rO0ABXNyABpqYXZhLmxhbmcuUnVudGltZUV4Y2VwdGlvbp5fBkcKNIPlAgAAeHIAE2phdmEubGFuZy5FeGNlcHRpb27Q_R8-GjscxAIAAHhyABNqYXZhLmxhbmcuVGhyb3dhYmxl1cY1Jzl3uMsDAARMAAVjYXVzZXQAFUxqYXZhL2xhbmcvVGhyb3dhYmxlO0wADWRldGFpbE1lc3NhZ2V0ABJMamF2YS9sYW5nL1N0cmluZztbAApzdGFja1RyYWNldAAeW0xqYXZhL2xhbmcvU3RhY2tUcmFjZUVsZW1lbnQ7TAAUc3VwcHJlc3NlZEV4Y2VwdGlvbnN0ABBMamF2YS91dGlsL0xpc3Q7eHBxAH4AB3QAZEpvYiBmYWlsZWQgZHVlIHRvIGV4Y2VwdGlvbiBVbmFibGUgdG8gZmluZCBzdWl0YWJsZSBwcmltYXJ5IHN0b3JhZ2Ugd2hlbiBjcmVhdGluZyB2b2x1bWUgZGF0YS1sb2NhbDJ1cgAeW0xqYXZhLmxhbmcuU3RhY2tUcmFjZUVsZW1lbnQ7AkYqPDz9IjkCAAB4cAAAAA5zcgAbamF2YS5sYW5nLlN0YWNrVHJhY2VFbGVtZW50YQnFmiY23YUCAARJAApsaW5lTnVtYmVyTAAOZGVjbGFyaW5nQ2xhc3NxAH4ABEwACGZpbGVOYW1lcQB-AARMAAptZXRob2ROYW1lcQB-AAR4cAAAAHJ0ACBjb20uY2xvdWQudm0uVm1Xb3JrSm9iRGlzcGF0Y2hlcnQAGFZtV29ya0pvYkRpc3BhdGNoZXIuamF2YXQABnJ1bkpvYnNxAH4ACwAAAfd0AD9vcmcuYXBhY2hlLmNsb3Vkc3RhY2suZnJhbWV3b3JrLmpvYnMuaW1wbC5Bc3luY0pvYk1hbmFnZXJJbXBsJDV0ABhBc3luY0pvYk1hbmFnZXJJbXBsLmphdmF0AAxydW5JbkNvbnRleHRzcQB-AAsAAAAxdAA-b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlJDF0ABtNYW5hZ2VkQ29udGV4dFJ1bm5hYmxlLmphdmF0AANydW5zcQB-AAsAAAA4dABCb3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5pbXBsLkRlZmF1bHRNYW5hZ2VkQ29udGV4dCQxdAAaRGVmYXVsdE1hbmFnZWRDb250ZXh0LmphdmF0AARjYWxsc3EAfgALAAAAZ3QAQG9yZy5hcGFjaGUuY2xvdWRzdGFjay5tYW5hZ2VkLmNvbnRleHQuaW1wbC5EZWZhdWx0TWFuYWdlZENvbnRleHRxAH4AGnQAD2NhbGxXaXRoQ29udGV4dHNxAH4ACwAAADVxAH4AHXEAfgAadAAOcnVuV2l0aENvbnRleHRzcQB-AAsAAAAudAA8b3JnLmFwYWNoZS5jbG91ZHN0YWNrLm1hbmFnZWQuY29udGV4dC5NYW5hZ2VkQ29udGV4dFJ1bm5hYmxlcQB-ABZxAH4AF3NxAH4ACwAAAcxxAH4AEXEAfgAScQB-ABdzcQB-AAsAAAHXdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuRXhlY3V0b3JzJFJ1bm5hYmxlQWRhcHRlcnQADkV4ZWN1dG9ycy5qYXZhcQB-ABtzcQB-AAsAAAFOdAAkamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFzayRTeW5jdAAPRnV0dXJlVGFzay5qYXZhdAAIaW5uZXJSdW5zcQB-AAsAAACmdAAfamF2YS51dGlsLmNvbmN1cnJlbnQuRnV0dXJlVGFza3EAfgApcQB-ABdzcQB-AAsAAARWdAAnamF2YS51dGlsLmNvbmN1cnJlbnQuVGhyZWFkUG9vbEV4ZWN1dG9ydAAXVGhyZWFkUG9vbEV4ZWN1dG9yLmphdmF0AAlydW5Xb3JrZXJzcQB-AAsAAAJbdAAuamF2YS51dGlsLmNvbmN1cnJlbnQuVGhyZWFkUG9vbEV4ZWN1dG9yJFdvcmtlcnEAfgAvcQB-ABdzcQB-AAsAAALSdAAQamF2YS5sYW5nLlRocmVhZHQAC1RocmVhZC5qYXZhcQB-ABdzcgAmamF2YS51dGlsLkNvbGxlY3Rpb25zJFVubW9kaWZpYWJsZUxpc3T8DyUxteyOEAIAAUwABGxpc3RxAH4ABnhyACxqYXZhLnV0aWwuQ29sbGVjdGlvbnMkVW5tb2RpZmlhYmxlQ29sbGVjdGlvbhlCAIDLXvceAgABTAABY3QAFkxqYXZhL3V0aWwvQ29sbGVjdGlvbjt4cHNyABNqYXZhLnV0aWwuQXJyYXlMaXN0eIHSHZnHYZ0DAAFJAARzaXpleHAAAAAAdwQAAAAAeHEAfgA7eA
> 2014-05-29 13:02:54,534 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Work-Job-Executor-15:ctx-3c499195 job-65/job-66) Done executing com.cloud.storage.VmWorkAttachVolume for job-66
> 2014-05-29 13:02:54,552 ERROR [c.c.a.ApiAsyncJobDispatcher] (API-Job-Executor-15:ctx-cbdb1b18 job-65) Unexpected exception while executing org.apache.cloudstack.api.command.admin.volume.AttachVolumeCmdByAdmin
> java.lang.RuntimeException: Unexpected exception
>         at com.cloud.storage.VolumeApiServiceImpl.attachVolumeToVM(VolumeApiServiceImpl.java:1044)
>         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:601)
>         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.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 $Proxy181.attachVolumeToVM(Unknown Source)
>         at org.apache.cloudstack.api.command.admin.volume.AttachVolumeCmdByAdmin.execute(AttachVolumeCmdByAdmin.java:38)
>         at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:141)
>         at com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:108)
>         at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503)
>         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:460)
>         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:722)
> Caused by: java.lang.RuntimeException: Job failed due to exception Unable to find suitable primary storage when creating volume data-local2
>         ... 27 more
> 2014-05-29 13:02:54,556 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (API-Job-Executor-15:ctx-cbdb1b18 job-65) Complete async job-65, jobStatus: FAILED, resultCode: 530, result: org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"errorcode":530,"errortext":"Unexpected exception"}



--
This message was sent by Atlassian JIRA
(v6.2#6252)