[ https://issues.apache.org/jira/browse/CLOUDSTACK-6802?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14013458#comment-14013458 ]
ASF subversion and git services commented on CLOUDSTACK-6802: ------------------------------------------------------------- Commit 7c2b1deb34c0210f812409b6b0f07b04e0142238 in cloudstack's branch refs/heads/master from [~devdeep] [ https://git-wip-us.apache.org/repos/asf?p=cloudstack.git;h=7c2b1de ] CLOUDSTACK-6810: Fix storage migration of a vm with volume on local was failing. When a plan with hostid included was passed to the local storage pool allocator, it returned all the local storage pools in the cluster, instead of just the local pool on the given host in the plan. This was happening the search at a host level was happening only for data disk. Fixed this. Additionally, the query to list the storage pools on a host was failing if the pool did have tags. Fixed the query too. CLOUDSTACK-6802: Fix for not being able to attach data disk on local. This issue gets fixed with the above issue too. The query to list pools on a host was failing if there were no tags on the storage pool. > 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)