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

edison su commented on CLOUDSTACK-3237:
---------------------------------------

I think it's due to vmdk disk consolidation. After volume migration, there are 
two vmdk files stored on destination pool: the base vmdk, the root-*.vmdk. 
After taking and backing up snapshot, our code will call remove snapshot, from 
vcenter, I find that, after removing snapshot is issued, another event called, 
disk consolidate, happened, then root-*.vmdk is consolidated into base vmdk. 
So, after that, there is only one base vmdk on the vm folder.
Then, when you migrate the vm again, mgt server will not find Roo-*.vmdk any 
more.
                
> [vmware][SM] Migrate volume is failing when there are snapshots for that 
> volume
> -------------------------------------------------------------------------------
>
>                 Key: CLOUDSTACK-3237
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-3237
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the 
> default.) 
>          Components: Volumes
>    Affects Versions: 4.2.0
>         Environment: vmware, 
>            Reporter: Srikanteswararao Talluri
>            Assignee: Sateesh Chodapuneedi
>            Priority: Blocker
>             Fix For: 4.2.0
>
>         Attachments: mgmt_27.log.zip
>
>
> Steps to reproduce:
> 1. create a VM 
> 2. take snapshot of root volume of VM
> 3. migrate root volume to a suitable storage pool
> ===START===  10.101.255.87 -- GET  
> command=findStoragePoolsForMigration&id=f7c12988-61a8-49dc-a5d3-cd8653744a8e&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333879848
> 2013-06-27 22:46:36,408 DEBUG [storage.allocator.LocalStoragePoolAllocator] 
> (catalina-exec-14:null) LocalStoragePoolAllocator trying to find storage pool 
> to fit the vm
> 2013-06-27 22:46:36,410 DEBUG 
> [storage.allocator.ClusterScopeStoragePoolAllocator] (catalina-exec-14:null) 
> ClusterScopeStoragePoolAllocator looking for storage pool
> 2013-06-27 22:46:36,410 DEBUG 
> [storage.allocator.ClusterScopeStoragePoolAllocator] (catalina-exec-14:null) 
> Looking for pools in dc: 1  pod:1  cluster:1
> 2013-06-27 22:46:36,419 DEBUG 
> [storage.allocator.AbstractStoragePoolAllocator] (catalina-exec-14:null) 
> Checking if storage pool is suitable, name: null ,poolId: 1
> 2013-06-27 22:46:36,419 DEBUG 
> [storage.allocator.AbstractStoragePoolAllocator] (catalina-exec-14:null) 
> StoragePool is in avoid set, skipping this pool
> 2013-06-27 22:46:36,421 DEBUG 
> [storage.allocator.AbstractStoragePoolAllocator] (catalina-exec-14:null) 
> Checking if storage pool is suitable, name: null ,poolId: 3
> 2013-06-27 22:46:36,429 DEBUG [cloud.storage.StorageManagerImpl] 
> (catalina-exec-14:null) Checking pool 3 for storage, totalSize: 
> 5902284800000, usedBytes: 3490243883008, usedPct: 0.5913377617779474, disable 
> threshold: 0.85
> 2013-06-27 22:46:36,461 DEBUG [cloud.storage.StorageManagerImpl] 
> (catalina-exec-14:null) Checking pool: 3 for volume allocation 
> [Vol[4|vm=4|ROOT]], maxSize : 11804569600000, totalAllocatedSize : 
> 23622320128, askingSize : 0, allocated disable threshold: 0.85
> 2013-06-27 22:46:36,464 DEBUG 
> [storage.allocator.AbstractStoragePoolAllocator] (catalina-exec-14:null) 
> Checking if storage pool is suitable, name: null ,poolId: 5
> 2013-06-27 22:46:36,471 DEBUG [cloud.storage.StorageManagerImpl] 
> (catalina-exec-14:null) Checking pool 5 for storage, totalSize: 
> 5902284800000, usedBytes: 3490243883008, usedPct: 0.5913377617779474, disable 
> threshold: 0.85
> 2013-06-27 22:46:36,492 DEBUG [cloud.storage.StorageManagerImpl] 
> (catalina-exec-14:null) Checking pool: 5 for volume allocation 
> [Vol[4|vm=4|ROOT]], maxSize : 11804569600000, totalAllocatedSize : 
> 35433480192, askingSize : 0, allocated disable threshold: 0.85
> 2013-06-27 22:46:36,492 DEBUG 
> [storage.allocator.ClusterScopeStoragePoolAllocator] (catalina-exec-14:null) 
> FirstFitStoragePoolAllocator returning 2 suitable storage pools
> 2013-06-27 22:46:36,506 DEBUG [cloud.api.ApiServlet] (catalina-exec-14:null) 
> ===END===  10.101.255.87 -- GET  
> command=findStoragePoolsForMigration&id=f7c12988-61a8-49dc-a5d3-cd8653744a8e&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333879848
> 2013-06-27 22:46:39,967 DEBUG [agent.manager.AgentManagerImpl] 
> (AgentManager-Handler-9:null) Ping from 4
> 2013-06-27 22:46:40,804 DEBUG [agent.manager.AgentManagerImpl] 
> (AgentManager-Handler-11:null) SeqA 3-10940: Processing Seq 3-10940:  { Cmd , 
> MgmtId: -1, via: 3, Ver: v1, Flags: 11, 
> [{"ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n  
> \"connections\": []\n}","wait":0}}] }
> 2013-06-27 22:46:40,813 DEBUG [agent.manager.AgentManagerImpl] 
> (AgentManager-Handler-11:null) SeqA 3-10940: Sending Seq 3-10940:  { Ans: , 
> MgmtId: 7566222426160, via: 3, Ver: v1, Flags: 100010, 
> [{"AgentControlAnswer":{"result":true,"wait":0}}] }
> 2013-06-27 22:46:41,091 DEBUG [cloud.api.ApiServlet] (catalina-exec-18:null) 
> ===START===  10.101.255.87 -- GET  
> command=migrateVolume&livemigrate=true&storageid=e690ef30-851c-33b0-a1b3-38fd7fa4c40c&volumeid=f7c12988-61a8-49dc-a5d3-cd8653744a8e&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333884566
> 2013-06-27 22:46:41,135 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (catalina-exec-18:null) submit async job-42, details: AsyncJobVO {id:42, 
> 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":"dfd5NAw2qEmBOi3931kcin3eZtQ\u003d","ctxUserId":"2","storageid":"e690ef30-851c-33b0-a1b3-38fd7fa4c40c","livemigrate":"true","httpmethod":"GET","_":"1372333884566","volumeid":"f7c12988-61a8-49dc-a5d3-cd8653744a8e","ctxAccountId":"2","ctxStartEventId":"153"},
>  cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, 
> processStatus: 0, resultCode: 0, result: null, initMsid: 7566222426160, 
> completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2013-06-27 22:46:41,140 DEBUG [cloud.api.ApiServlet] (catalina-exec-18:null) 
> ===END===  10.101.255.87 -- GET  
> command=migrateVolume&livemigrate=true&storageid=e690ef30-851c-33b0-a1b3-38fd7fa4c40c&volumeid=f7c12988-61a8-49dc-a5d3-cd8653744a8e&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333884566
> 2013-06-27 22:46:41,144 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (Job-Executor-30:job-42) Executing 
> org.apache.cloudstack.api.command.user.volume.MigrateVolumeCmd for job-42
> 2013-06-27 22:46:41,216 DEBUG [agent.transport.Request] 
> (Job-Executor-30:job-42) Seq 1-1640432002: Sending  { Cmd , MgmtId: 
> 7566222426160, via: 1, Ver: v1, Flags: 100111, 
> [{"storage.MigrateVolumeCommand":{"volumeId":4,"volumePath":"ROOT-4-4","pool":{"id":5,"uuid":"e690ef30-851c-33b0-a1b3-38fd7fa4c40c","host":"10.147.28.7","path":"/export/home/talluri/finalprim5","port":2049,"type":"NetworkFilesystem"},"wait":0}}]
>  }
> 2013-06-27 22:46:41,217 DEBUG [agent.transport.Request] 
> (Job-Executor-30:job-42) Seq 1-1640432002: Executing:  { Cmd , MgmtId: 
> 7566222426160, via: 1, Ver: v1, Flags: 100111, 
> [{"storage.MigrateVolumeCommand":{"volumeId":4,"volumePath":"ROOT-4-4","pool":{"id":5,"uuid":"e690ef30-851c-33b0-a1b3-38fd7fa4c40c","host":"10.147.28.7","path":"/export/home/talluri/finalprim5","port":2049,"type":"NetworkFilesystem"},"wait":0}}]
>  }
> 2013-06-27 22:46:41,218 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-14:null) Seq 1-1640432002: Executing request
> 2013-06-27 22:46:41,228 INFO  [vmware.resource.VmwareResource] 
> (DirectAgent-14:10.147.40.21) Executing resource MigrateVolumeCommand: 
> {"volumeId":4,"volumePath":"ROOT-4-4","pool":{"id":5,"uuid":"e690ef30-851c-33b0-a1b3-38fd7fa4c40c","host":"10.147.28.7","path":"/export/home/talluri/finalprim5","port":2049,"type":"NetworkFilesystem"},"wait":0}
> 2013-06-27 22:46:42,942 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Look for disk device info from volume : 
> [fff34012-5699-38cc-8222-e42188915231] ROOT-4-4.vmdk
> 2013-06-27 22:46:42,943 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Test against disk device, controller key: 200, 
> unit number: 1
> 2013-06-27 22:46:42,943 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Test against disk backing : 
> [fff34012569938cc8222e42188915231] 
> i-2-4-VM/9d340c61ec3a3bfd8aa1842e6368510d.vmdk
> 2013-06-27 22:46:42,943 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Test against disk device, controller key: 1000, 
> unit number: 0
> 2013-06-27 22:46:42,943 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Test against disk backing : 
> [9ecb2d3637163dd08d1616eddd0e4607] 
> i-2-4-VM/4c30b0ce9a1740bc99fabe46fc0cff97.vmdk
> 2013-06-27 22:46:42,943 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Test against disk device, controller key: 1000, 
> unit number: 1
> 2013-06-27 22:46:42,944 INFO  [vmware.mo.VirtualMachineMO] 
> (DirectAgent-14:10.147.40.21) Test against disk backing : 
> [e690ef30851c33b0a1b338fd7fa4c40c] 
> i-2-4-VM/68384f0e52064a92a02e33c9d7b34e8f.vmdk
> 2013-06-27 22:46:42,944 ERROR [vmware.resource.VmwareResource] 
> (DirectAgent-14:10.147.40.21) Catch Exception java.lang.Exception due to 
> java.lang.Exception: No such disk device: 
> [fff34012-5699-38cc-8222-e42188915231] ROOT-4-4.vmdk
> java.lang.Exception: No such disk device: 
> [fff34012-5699-38cc-8222-e42188915231] ROOT-4-4.vmdk
>       at 
> com.cloud.hypervisor.vmware.resource.VmwareResource.getVirtualDiskInfo(VmwareResource.java:3746)
>       at 
> com.cloud.hypervisor.vmware.resource.VmwareResource.execute(VmwareResource.java:3723)
>       at 
> com.cloud.hypervisor.vmware.resource.VmwareResource.executeRequest(VmwareResource.java:422)
>       at 
> com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
>       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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
>       at 
> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
>       at 
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
>       at 
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
>       at java.lang.Thread.run(Thread.java:679)
> 2013-06-27 22:46:42,950 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-14:null) Seq 1-1640432002: Response Received: 
> 2013-06-27 22:46:42,951 DEBUG [agent.transport.Request] (DirectAgent-14:null) 
> Seq 1-1640432002: Processing:  { Ans: , MgmtId: 7566222426160, via: 1, Ver: 
> v1, Flags: 110, 
> [{"storage.MigrateVolumeAnswer":{"result":false,"details":"Catch Exception 
> java.lang.Exception due to java.lang.Exception: No such disk device: 
> [fff34012-5699-38cc-8222-e42188915231] ROOT-4-4.vmdk","wait":0}}] }
> 2013-06-27 22:46:42,951 DEBUG [agent.transport.Request] 
> (Job-Executor-30:job-42) Seq 1-1640432002: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 1, Ver: v1, Flags: 110, { MigrateVolumeAnswer } }
> 2013-06-27 22:46:42,951 DEBUG [agent.manager.AgentAttache] 
> (DirectAgent-14:null) Seq 1-1640432002: No more commands found
> 2013-06-27 22:46:42,952 DEBUG [storage.motion.AncientDataMotionStrategy] 
> (Job-Executor-30:job-42) copy failed
> com.cloud.utils.exception.CloudRuntimeException: Failed to migrate volume 
> org.apache.cloudstack.storage.volume.VolumeObject@49e7d3cd to storage pool 
> org.apache.cloudstack.storage.datastore.DefaultPrimaryDataStore@13025da3
>       at 
> org.apache.cloudstack.storage.motion.AncientDataMotionStrategy.migrateVolumeToPool(AncientDataMotionStrategy.java:453)
>       at 
> org.apache.cloudstack.storage.motion.AncientDataMotionStrategy.copyAsync(AncientDataMotionStrategy.java:497)
>       at 
> org.apache.cloudstack.storage.motion.DataMotionServiceImpl.copyAsync(DataMotionServiceImpl.java:59)
>       at 
> org.apache.cloudstack.storage.volume.VolumeServiceImpl.migrateVolume(VolumeServiceImpl.java:614)
>       at 
> com.cloud.storage.VolumeManagerImpl.liveMigrateVolume(VolumeManagerImpl.java:2130)
>       at 
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
>       at 
> com.cloud.storage.VolumeManagerImpl.migrateVolume(VolumeManagerImpl.java:2100)
>       at 
> com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125)
>       at 
> org.apache.cloudstack.api.command.user.volume.MigrateVolumeCmd.execute(MigrateVolumeCmd.java:103)
>       at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:155)
>       at 
> com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:437)
>       at 
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
>       at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)
>       at java.util.concurrent.FutureTask.run(FutureTask.java:166)
>       at 
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
>       at 
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
>       at java.lang.Thread.run(Thread.java:679)
> 2013-06-27 22:46:42,966 DEBUG [cloud.storage.VolumeManagerImpl] 
> (Job-Executor-30:job-42) migrate volume 
> failed:com.cloud.utils.exception.CloudRuntimeException: Failed to migrate 
> volume org.apache.cloudstack.storage.volume.VolumeObject@49e7d3cd to storage 
> pool org.apache.cloudstack.storage.datastore.DefaultPrimaryDataStore@13025da3
> 2013-06-27 22:46:42,967 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (Job-Executor-30:job-42) Complete async job-42, jobStatus: 1, resultCode: 0, 
> result: null
> 2013-06-27 22:46:42,978 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (Job-Executor-30:job-42) Done executing 
> org.apache.cloudstack.api.command.user.volume.MigrateVolumeCmd for job-42
> 2013-06-27 22:46:44,239 DEBUG [cloud.api.ApiServlet] (catalina-exec-21:null) 
> ===START===  10.101.255.87 -- GET  
> command=queryAsyncJobResult&jobId=6f41c69f-35ea-4d37-9c8c-3d9d4b9b2c3c&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333887715
> 2013-06-27 22:46:44,259 DEBUG [cloud.async.AsyncJobManagerImpl] 
> (catalina-exec-21:null) Async job-42 completed
> 2013-06-27 22:46:44,268 DEBUG [cloud.api.ApiServlet] (catalina-exec-21:null) 
> ===END===  10.101.255.87 -- GET  
> command=queryAsyncJobResult&jobId=6f41c69f-35ea-4d37-9c8c-3d9d4b9b2c3c&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333887715
> 2013-06-27 22:46:44,340 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) 
> ===START===  10.101.255.87 -- GET  
> command=listVolumes&id=f7c12988-61a8-49dc-a5d3-cd8653744a8e&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333887817
> 2013-06-27 22:46:44,367 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) 
> ===END===  10.101.255.87 -- GET  
> command=listVolumes&id=f7c12988-61a8-49dc-a5d3-cd8653744a8e&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&_=1372333887817
> 2013-06-27 22:46:44,607 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) 
> ===START===  10.101.255.87 -- GET  
> command=listTags&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&resourceId=f7c12988-61a8-49dc-a5d3-cd8653744a8e&resourceType=Volume&listAll=true&_=1372333888085
> 2013-06-27 22:46:44,623 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) 
> ===END===  10.101.255.87 -- GET  
> command=listTags&response=json&sessionkey=dfd5NAw2qEmBOi3931kcin3eZtQ%3D&resourceId=f7c12988-61a8-49dc-a5d3-cd8653744a8e&resourceType=Volume&listAll=true&_=1372333888085
> 2013-06-27 22:46:46,685 DEBUG [cloud.server.StatsCollector] 
> (StatsCollector-2:null) StorageCollector is running...
> 2013-06-27 22:46:46,754 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 4-1143145947: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 4, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-27 22:46:46,768 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-177:null) Seq 1-1640432003: Executing request
> 2013-06-27 22:46:46,823 DEBUG [vmware.resource.VmwareResource] 
> (DirectAgent-177:10.147.40.21) Datastore summary info, storageId: 
> fff34012-5699-38cc-8222-e42188915231, localPath: 
> /export/home/talluri/finalprim, poolType: NetworkFilesystem, capacity: 
> 5902284800000, free: 2412040916992, used: 3490243883008
> 2013-06-27 22:46:46,824 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-177:null) Seq 1-1640432003: Response Received: 
> 2013-06-27 22:46:46,825 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 1-1640432003: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-27 22:46:46,836 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-373:null) Seq 5-969670931: Executing request
> 2013-06-27 22:46:46,866 DEBUG [vmware.resource.VmwareResource] 
> (DirectAgent-373:10.147.40.30) Datastore summary info, storageId: 
> eb4d87cd-a0fb-3b8f-b1c1-82a1488227f5, localPath: 
> /export/home/talluri/finalprim2, poolType: NetworkFilesystem, capacity: 
> 5902284800000, free: 2412036386816, used: 3490248413184
> 2013-06-27 22:46:46,867 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-373:null) Seq 5-969670931: Response Received: 
> 2013-06-27 22:46:46,868 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 5-969670931: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-27 22:46:46,878 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-145:null) Seq 1-1640432004: Executing request
> 2013-06-27 22:46:46,909 DEBUG [vmware.resource.VmwareResource] 
> (DirectAgent-145:10.147.40.21) Datastore summary info, storageId: 
> 9ecb2d36-3716-3dd0-8d16-16eddd0e4607, localPath: 
> /export/home/talluri/finalprim3, poolType: NetworkFilesystem, capacity: 
> 5902284800000, free: 2412040916992, used: 3490243883008
> 2013-06-27 22:46:46,910 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-145:null) Seq 1-1640432004: Response Received: 
> 2013-06-27 22:46:46,911 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 1-1640432004: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-27 22:46:46,922 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-219:null) Seq 5-969670932: Executing request
> 2013-06-27 22:46:47,032 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-386:null) Ping from 5
> 2013-06-27 22:46:47,034 DEBUG [vmware.resource.VmwareResource] 
> (DirectAgent-219:10.147.40.30) Datastore summary info, storageId: 
> 1adf9c6b-5329-3ab1-a5cf-f99f20f11870, localPath: 
> /export/home/talluri/finalprim4, poolType: NetworkFilesystem, capacity: 
> 5902284800000, free: 2412036386816, used: 3490248413184
> 2013-06-27 22:46:47,035 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-219:null) Seq 5-969670932: Response Received: 
> 2013-06-27 22:46:47,035 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 5-969670932: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-27 22:46:47,046 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-86:null) Seq 1-1640432005: Executing request
> 2013-06-27 22:46:47,083 DEBUG [vmware.resource.VmwareResource] 
> (DirectAgent-86:10.147.40.21) Datastore summary info, storageId: 
> e690ef30-851c-33b0-a1b3-38fd7fa4c40c, localPath: 
> /export/home/talluri/finalprim5, poolType: NetworkFilesystem, capacity: 
> 5902284800000, free: 2412040916992, used: 3490243883008
> 2013-06-27 22:46:47,084 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-86:null) Seq 1-1640432005: Response Received: 
> 2013-06-27 22:46:47,085 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 1-1640432005: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> 2013-06-27 22:46:47,096 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-105:null) Seq 5-969670933: Executing request
> 2013-06-27 22:46:47,122 DEBUG [vmware.resource.VmwareResource] 
> (DirectAgent-105:10.147.40.30) Datastore summary info, storageId: 
> a19e5748-02a2-3879-837f-5d56b5f12972, localPath: 
> /export/home/talluri/finalprim6, poolType: NetworkFilesystem, capacity: 
> 5902284800000, free: 2412036386816, used: 3490248413184
> 2013-06-27 22:46:47,123 DEBUG [agent.manager.DirectAgentAttache] 
> (DirectAgent-105:null) Seq 5-969670933: Response Received: 
> 2013-06-27 22:46:47,124 DEBUG [agent.transport.Request] 
> (StatsCollector-2:null) Seq 5-969670933: Received:  { Ans: , MgmtId: 
> 7566222426160, via: 5, Ver: v1, Flags: 10, { GetStorageStatsAnswer } }
> ^C
> [root@ms2 ~]# 

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

Reply via email to