You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Venkata Siva Vijayendra Bhamidipati (JIRA)" <ji...@apache.org> on 2013/07/10 00:39:48 UTC
[jira] [Created] (CLOUDSTACK-3430) volume migration on zone wide
primary storage pool failing
Venkata Siva Vijayendra Bhamidipati created CLOUDSTACK-3430:
---------------------------------------------------------------
Summary: volume migration on zone wide primary storage pool failing
Key: CLOUDSTACK-3430
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3430
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: vmware on cloudstack master
Reporter: Venkata Siva Vijayendra Bhamidipati
Create a zone with zone wide primary storage.
Bring up system VMs, create a guest VM.
Add another zone wide primary storage to the zone.
Attempt to migrate the root volume of the guest VM from its current zone wide primary storage to the new zone wide primary storage. The operation fails, and the logs show the following trace:
2013-07-09 08:36:29,943 DEBUG [cloud.api.ApiServlet] (1754543106@qtp-481326697-2:null) ===START=== 10.217.252.54 -- GET command=findStoragePoolsForMigration&id=d0cd5d41-f395-48d9-8bd6-3886f4f76c3e&response=json&sessionkey=PWQxaW5CBGIDG7HYLOQBdAk3RJg%3D&_=1373407310956
2013-07-09 08:36:30,492 DEBUG [storage.allocator.LocalStoragePoolAllocator] (1754543106@qtp-481326697-2:null) LocalStoragePoolAllocator trying to find storage pool to fit the vm
2013-07-09 08:36:30,496 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (1754543106@qtp-481326697-2:null) ClusterScopeStoragePoolAllocator looking for storage pool
2013-07-09 08:36:30,497 DEBUG [storage.allocator.ZoneWideStoragePoolAllocator] (1754543106@qtp-481326697-2:null) ZoneWideStoragePoolAllocator to find storage pool
2013-07-09 08:36:30,660 DEBUG [cloud.storage.StorageManagerImpl] (1754543106@qtp-481326697-2:null) Checking pool 1 for storage, totalSize: 11810778316800, usedBytes: 8451350200320, usedPct: 0.7155625119386544, disable threshold: 0.85
2013-07-09 08:36:30,791 DEBUG [cloud.storage.StorageManagerImpl] (1754543106@qtp-481326697-2:null) Checking pool: 1 for volume allocation [Vol[10|vm=5|ROOT]], maxSize : 23621556633600, totalAllocatedSize : 0, askingSize : 0, allocated disable threshold: 0.85
2013-07-09 08:36:30,842 DEBUG [cloud.storage.StorageManagerImpl] (1754543106@qtp-481326697-2:null) Checking pool 2 for storage, totalSize: 11810778316800, usedBytes: 8451350200320, usedPct: 0.7155625119386544, disable threshold: 0.85
2013-07-09 08:36:30,878 DEBUG [cloud.storage.StorageManagerImpl] (1754543106@qtp-481326697-2:null) Checking pool: 2 for volume allocation [Vol[10|vm=5|ROOT]], maxSize : 23621556633600, totalAllocatedSize : 0, askingSize : 0, allocated disable threshold: 0.85
2013-07-09 08:36:31,204 DEBUG [cloud.api.ApiServlet] (1754543106@qtp-481326697-2:null) ===END=== 10.217.252.54 -- GET command=findStoragePoolsForMigration&id=d0cd5d41-f395-48d9-8bd6-3886f4f76c3e&response=json&sessionkey=PWQxaW5CBGIDG7HYLOQBdAk3RJg%3D&_=1373407310956
2013-07-09 08:36:33,437 DEBUG [agent.manager.DirectAgentAttache] (DirectAgent-29:null) Ping from 1
2013-07-09 08:36:33,671 DEBUG [cloud.api.ApiServlet] (1754543106@qtp-481326697-2:null) ===START=== 10.217.252.54 -- GET command=migrateVolume&livemigrate=true&storageid=d867446f-73d6-365c-bf50-27fdde7e2a6b&volumeid=d0cd5d41-f395-48d9-8bd6-3886f4f76c3e&response=json&sessionkey=PWQxaW5CBGIDG7HYLOQBdAk3RJg%3D&_=1373407314785
2013-07-09 08:36:33,906 DEBUG [cloud.async.AsyncJobManagerImpl] (1754543106@qtp-481326697-2:null) submit async job-24, details: AsyncJobVO {id:24, userId: 2, accountId: 2, sessionKey: null, instanceType: None, instanceId: null, cmd: org.apache.cloudstack.api.command.user.volume.MigrateVolumeCmd, cmdOriginator: null, cmdInfo: {"response":"json","sessionkey":"PWQxaW5CBGIDG7HYLOQBdAk3RJg\u003d","cmdEventType":"VOLUME.MIGRATE","ctxUserId":"2","storageid":"d867446f-73d6-365c-bf50-27fdde7e2a6b","livemigrate":"true","httpmethod":"GET","volumeid":"d0cd5d41-f395-48d9-8bd6-3886f4f76c3e","_":"1373407314785","ctxAccountId":"2","ctxStartEventId":"92"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 52241838869, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2013-07-09 08:36:33,937 DEBUG [cloud.api.ApiServlet] (1754543106@qtp-481326697-2:null) ===END=== 10.217.252.54 -- GET command=migrateVolume&livemigrate=true&storageid=d867446f-73d6-365c-bf50-27fdde7e2a6b&volumeid=d0cd5d41-f395-48d9-8bd6-3886f4f76c3e&response=json&sessionkey=PWQxaW5CBGIDG7HYLOQBdAk3RJg%3D&_=1373407314785
2013-07-09 08:36:34,045 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-4:job-24) Executing org.apache.cloudstack.api.command.user.volume.MigrateVolumeCmd for job-24
2013-07-09 08:36:34,681 DEBUG [storage.motion.AncientDataMotionStrategy] (Job-Executor-4:job-24) copyAsync inspecting src type VOLUME copyAsync inspecting dest type VOLUME
2013-07-09 08:36:34,692 DEBUG [cache.allocator.StorageCacheRandomAllocator] (Job-Executor-4:job-24) Can't find cache storage in zone: 1
2013-07-09 08:36:34,885 DEBUG [agent.transport.Request] (Job-Executor-4:job-24) Seq 3-1074790423: Sending { Cmd , MgmtId: 52241838869, via: 3, Ver: v1, Flags: 100111, [{"org.apache.cloudstack.storage.command.CopyCommand":{"srcTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"d0cd5d41-f395-48d9-8bd6-3886f4f76c3e","volumeType":"ROOT","dataStore":{"org.apache.cloudstack.storage.to.PrimaryDataStoreTO":{"uuid":"12062dc7-8666-3961-a146-07db07c3af21","id":1,"poolType":"NetworkFilesystem","host":"10.223.110.231","path":"/export/home/vijay/vmware/primary1","port":2049}},"name":"ROOT-5","size":0,"path":"ROOT-5-10","volumeId":10,"vmName":"i-2-5-VM","accountId":2,"format":"OVA","id":10}},"destTO":{"org.apache.cloudstack.storage.to.VolumeObjectTO":{"uuid":"d0cd5d41-f395-48d9-8bd6-3886f4f76c3e","volumeType":"ROOT","dataStore":{"com.cloud.agent.api.to.NfsTO":{"_url":"nfs://10.223.110.232/export/home/vijay/vmware/secondary2/","_role":"Image"}},"name":"ROOT-5","size":0,"path":"volumes/2/10","volumeId":10,"vmName":"i-2-5-VM","accountId":2,"format":"OVA","id":10}},"wait":10800}}] }
2013-07-09 08:36:34,933 DEBUG [agent.transport.Request] (AgentManager-Handler-6:null) Seq 3-1074790423: Processing: { Ans: , MgmtId: 52241838869, via: 3, Ver: v1, Flags: 110, [{"com.cloud.agent.api.Answer":{"result":false,"details":"java.lang.NullPointerException\n\tat com.cloud.storage.resource.VmwareSecondaryStorageResourceHandler.executeRequest(VmwareSecondaryStorageResourceHandler.java:103)\n\tat com.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:56)\n\tat com.cloud.agent.Agent.processRequest(Agent.java:525)\n\tat com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)\n\tat com.cloud.utils.nio.Task.run(Task.java:83)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)\n\tat java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)\n\tat java.lang.Thread.run(Thread.java:662)\n","wait":0}}] }
2013-07-09 08:36:34,933 DEBUG [agent.manager.AgentAttache] (AgentManager-Handler-6:null) Seq 3-1074790423: No more commands found
2013-07-09 08:36:34,933 DEBUG [agent.transport.Request] (Job-Executor-4:job-24) Seq 3-1074790423: Received: { Ans: , MgmtId: 52241838869, via: 3, Ver: v1, Flags: 110, { Answer } }
2013-07-09 08:36:34,934 DEBUG [storage.motion.AncientDataMotionStrategy] (Job-Executor-4:job-24) copy to image store failed: java.lang.NullPointerException
at com.cloud.storage.resource.VmwareSecondaryStorageResourceHandler.executeRequest(VmwareSecondaryStorageResourceHandler.java:103)
at com.cloud.storage.resource.PremiumSecondaryStorageResource.executeRequest(PremiumSecondaryStorageResource.java:56)
at com.cloud.agent.Agent.processRequest(Agent.java:525)
at com.cloud.agent.Agent$AgentRequestHandler.doTask(Agent.java:852)
at com.cloud.utils.nio.Task.run(Task.java:83)
at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
at java.lang.Thread.run(Thread.java:662)
--
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