Hello Derek, Looks like the VM deployment failed due to "No Storage Pools available" to service your request. If you are planning to use the local storage on XenServer as your primary storage, you need to use the corresponding Service Offering that uses a local storage to deploy a VM. May I know whether the service offering that you used to deploy this VM uses shared or local storage,
Thank you, Chandan. -----Original Message----- From: Derek Cole [mailto:derek.c...@gmail.com] Sent: Thursday, January 23, 2014 11:04 AM To: users@cloudstack.apache.org Subject: Unable to deploy instance from ISO to xenserver Hello, I am trying to setup a cloudstack managed xenserver. I had a fresh xenserver 6.2 install, and I was able to upload my ISO. Whenever I try to create an instance, I get the error that I have pasted below in this email. In my setup, the cloudstack-management box is hosting an NFS share for the secondary storage, and when I set up the zone, I made it use local storage on the xenserver host. That drive is 100% free. What is going wrong here? Thanks 2014-01-23 13:50:22,737 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 3-39: Processing Seq 3-39: { Cmd , MgmtId: -1, via: 3, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":2,"_loadInfo":"{\n \"connections\": []\n}","wait":0}}] } 2014-01-23 13:50:22,741 DEBUG [agent.manager.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 3-39: Sending Seq 3-39: { Ans: , MgmtId: 218269705676436, via: 3, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] } 2014-01-23 13:50:22,891 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) ===START=== 10.20.0.18 -- GET command=deployVirtualMachine&zoneId=68a397f1-b141-4818-8999-7eb9d2cf39fc&templateId=ad6163bf-b4b2-4d68-a9eb-fece57c975ce&hypervisor=XenServer&serviceOfferingId=0e564524-751a-41a3-aed6-dc2344045e2d&diskOfferingId=636ab890-4f91-43b3-a50d-0af1e6e40352&networkIds=0e1c8d43-7714-4de1-99d5-8344a33affb7&response=json&sessionkey=MZcKlC%2BbG5N5o1F9aUej178nY%2F0%3D&_=1390503666841 2014-01-23 13:50:22,899 DEBUG [cloud.api.ApiDispatcher] (catalina-exec-3:null) InfrastructureEntity name is:com.cloud.offering.ServiceOffering 2014-01-23 13:50:22,903 DEBUG [cloud.api.ApiDispatcher] (catalina-exec-3:null) ControlledEntity name is:com.cloud.template.VirtualMachineTemplate 2014-01-23 13:50:22,907 DEBUG [cloud.api.ApiDispatcher] (catalina-exec-3:null) ControlledEntity name is:com.cloud.network.Network 2014-01-23 13:50:22,911 DEBUG [cloud.api.ApiDispatcher] (catalina-exec-3:null) InfrastructureEntity name is:com.cloud.offering.DiskOffering 2014-01-23 13:50:22,926 DEBUG [cloud.network.NetworkModelImpl] (catalina-exec-3:null) Service SecurityGroup is not supported in the network id=204 2014-01-23 13:50:22,938 DEBUG [cloud.vm.UserVmManagerImpl] (catalina-exec-3:null) Allocating in the DB for vm 2014-01-23 13:50:22,950 DEBUG [cloud.vm.VirtualMachineManagerImpl] (catalina-exec-3:null) Allocating entries for VM: VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] 2014-01-23 13:50:22,951 DEBUG [cloud.vm.VirtualMachineManagerImpl] (catalina-exec-3:null) Allocating nics for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] 2014-01-23 13:50:22,952 DEBUG [cloud.network.NetworkManagerImpl] (catalina-exec-3:null) Allocating nic for vm VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] in network Ntwk[204|Guest|8] with requested profile NicProfile[0-0-null-null-null 2014-01-23 13:50:22,968 DEBUG [cloud.network.NetworkModelImpl] (catalina-exec-3:null) Service SecurityGroup is not supported in the network id=204 2014-01-23 13:50:22,970 DEBUG [cloud.vm.VirtualMachineManagerImpl] (catalina-exec-3:null) Allocating disks for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] 2014-01-23 13:50:22,981 DEBUG [cloud.vm.VirtualMachineManagerImpl] (catalina-exec-3:null) Allocation completed for VM: VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] 2014-01-23 13:50:22,981 DEBUG [cloud.vm.UserVmManagerImpl] (catalina-exec-3:null) Successfully allocated DB entry for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] 2014-01-23 13:50:23,009 DEBUG [cloud.network.NetworkModelImpl] (catalina-exec-3:null) Service SecurityGroup is not supported in the network id=204 2014-01-23 13:50:23,014 DEBUG [cloud.network.NetworkModelImpl] (catalina-exec-3:null) Service SecurityGroup is not supported in the network id=204 2014-01-23 13:50:23,030 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-3:null) submit async job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ], details: AsyncJobVO {id:43, userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine, instanceId: 11, cmd: org.apache.cloudstack.api.command.user.vm.DeployVMCmd, cmdOriginator: null, cmdInfo: {"sessionkey":"MZcKlC+bG5N5o1F9aUej178nY/0\u003d","cmdEventType":"VM.CREATE","ctxUserId":"2","serviceOfferingId":"0e564524-751a-41a3-aed6-dc2344045e2d","httpmethod":"GET","zoneId":"68a397f1-b141-4818-8999-7eb9d2cf39fc","templateId":"ad6163bf-b4b2-4d68-a9eb-fece57c975ce","response":"json","id":"11","networkIds":"0e1c8d43-7714-4de1-99d5-8344a33affb7","hypervisor":"XenServer","diskOfferingId":"636ab890-4f91-43b3-a50d-0af1e6e40352","_":"1390503666841","ctxAccountId":"2","ctxStartEventId":"137"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 218269705676436, completeMsid: null, lastUpdated: null, lastPolled: null, created: null} 2014-01-23 13:50:23,032 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Executing org.apache.cloudstack.api.command.user.vm.DeployVMCmd for job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] 2014-01-23 13:50:23,034 DEBUG [cloud.api.ApiServlet] (catalina-exec-3:null) ===END=== 10.20.0.18 -- GET command=deployVirtualMachine&zoneId=68a397f1-b141-4818-8999-7eb9d2cf39fc&templateId=ad6163bf-b4b2-4d68-a9eb-fece57c975ce&hypervisor=XenServer&serviceOfferingId=0e564524-751a-41a3-aed6-dc2344045e2d&diskOfferingId=636ab890-4f91-43b3-a50d-0af1e6e40352&networkIds=0e1c8d43-7714-4de1-99d5-8344a33affb7&response=json&sessionkey=MZcKlC%2BbG5N5o1F9aUej178nY%2F0%3D&_=1390503666841 2014-01-23 13:50:23,038 DEBUG [cloud.api.ApiDispatcher] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) InfrastructureEntity name is:com.cloud.offering.ServiceOffering 2014-01-23 13:50:23,040 DEBUG [cloud.api.ApiDispatcher] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) ControlledEntity name is:com.cloud.template.VirtualMachineTemplate 2014-01-23 13:50:23,044 DEBUG [cloud.api.ApiDispatcher] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) ControlledEntity name is:com.cloud.network.Network 2014-01-23 13:50:23,047 DEBUG [cloud.api.ApiDispatcher] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) InfrastructureEntity name is:com.cloud.offering.DiskOffering 2014-01-23 13:50:23,076 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Service SecurityGroup is not supported in the network id=204 2014-01-23 13:50:23,081 DEBUG [cloud.network.NetworkModelImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Service SecurityGroup is not supported in the network id=204 2014-01-23 13:50:23,102 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Deploy avoids pods: [], clusters: [], hosts: [] 2014-01-23 13:50:23,105 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) DeploymentPlanner allocation algorithm: com.cloud.deploy.FirstFitPlanner_EnhancerByCloudStack_913f7ef8@275369c0 2014-01-23 13:50:23,105 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 1000, requested ram: 1073741824 2014-01-23 13:50:23,105 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Is ROOT volume READY (pool already allocated)?: No 2014-01-23 13:50:23,106 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Searching all possible resources under this Zone: 1 2014-01-23 13:50:23,107 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1 2014-01-23 13:50:23,111 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Removing from the clusterId list these clusters from avoid set: [] 2014-01-23 13:50:23,119 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Checking resources in Cluster: 1 under Pod: 1 2014-01-23 13:50:23,121 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1 2014-01-23 13:50:23,126 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-2-Routing]] 2014-01-23 13:50:23,129 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-2-Routing]] 2014-01-23 13:50:23,129 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Looking for speed=1000Mhz, Ram=1024 2014-01-23 13:50:23,135 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Checking if host: 2 has enough capacity for requested CPU: 1000 and requested RAM: 1073741824 , cpuOverprovisioningFactor: 1.0 2014-01-23 13:50:23,138 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Hosts's actual total CPU: 42656 and CPU after applying overprovisioning: 42656 2014-01-23 13:50:23,138 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Free CPU: 41656 , Requested CPU: 1000 2014-01-23 13:50:23,138 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Free RAM: 146498420736 , Requested RAM: 1073741824 2014-01-23 13:50:23,138 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Host has enough CPU and RAM available 2014-01-23 13:50:23,138 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 2, used: 1000, reserved: 0, actual total: 42656, total with overprovisioning: 42656; requested cpu:1000,alloc_from_last_host?:false ,considerReservedCapacity?: true 2014-01-23 13:50:23,138 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 2, used: 1342177280, reserved: 0, total: 147840598016; requested mem: 1073741824,alloc_from_last_host?:false ,considerReservedCapacity?: true 2014-01-23 13:50:23,139 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Found a suitable host, adding to list: 2 2014-01-23 13:50:23,139 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] FirstFitRoutingAllocator) Host Allocator returning 1 suitable hosts 2014-01-23 13:50:23,140 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Checking suitable pools for volume (Id, Type): (11,ROOT) 2014-01-23 13:50:23,141 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) We need to allocate new storagepool for this volume 2014-01-23 13:50:23,142 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Calling StoragePoolAllocators to find suitable pools 2014-01-23 13:50:23,142 DEBUG [storage.allocator.LocalStoragePoolAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) LocalStoragePoolAllocator trying to find storage pool to fit the vm 2014-01-23 13:50:23,142 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) ClusterScopeStoragePoolAllocator looking for storage pool 2014-01-23 13:50:23,143 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Looking for pools in dc: 1 pod:1 cluster:1 2014-01-23 13:50:23,145 DEBUG [storage.allocator.ClusterScopeStoragePoolAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) No storage pools available for shared volume allocation, returning 2014-01-23 13:50:23,145 DEBUG [storage.allocator.ZoneWideStoragePoolAllocator] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) ZoneWideStoragePoolAllocator to find storage pool 2014-01-23 13:50:23,150 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) No suitable pools found for volume: Vol[11|vm=11|ROOT] under cluster: 1 2014-01-23 13:50:23,150 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) No suitable pools found 2014-01-23 13:50:23,150 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) No suitable storagePools found under this Cluster: 1 2014-01-23 13:50:23,153 DEBUG [cloud.deploy.DeploymentPlanningManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Could not find suitable Deployment Destination for this VM under any clusters, returning. 2014-01-23 13:50:23,153 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Searching all possible resources under this Zone: 1 2014-01-23 13:50:23,154 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1 2014-01-23 13:50:23,158 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Removing from the clusterId list these clusters from avoid set: [1] 2014-01-23 13:50:23,161 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) No clusters found after removing disabled clusters and clusters in avoid list, returning. 2014-01-23 13:50:23,164 DEBUG [cloud.vm.UserVmManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Destroying vm VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] as it failed to create on Host with Id:null 2014-01-23 13:50:23,174 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) VM state transitted from :Stopped to Error with event: OperationFailedToErrorvm's original host id: null new host id: null host id before state transition: null 2014-01-23 13:50:23,183 WARN [apache.cloudstack.alerts] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) alertType:: 8 // dataCenterId:: 1 // podId:: null // clusterId:: null // message:: Failed to deploy Vm with Id: 11, on Host with Id: null 2014-01-23 13:50:23,210 INFO [user.vm.DeployVMCmd] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d]Scope=interface com.cloud.dc.DataCenter; id=1 2014-01-23 13:50:23,210 INFO [user.vm.DeployVMCmd] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Unable to create a deployment for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d]Scope=interface com.cloud.dc.DataCenter; id=1 at org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.reserveVirtualMachine(VMEntityManagerImpl.java:209) at org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.reserve(VirtualMachineEntityImpl.java:198) at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:3405) at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2966) at com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:2952) at com.cloud.utils.component.ComponentInstantiationPostProcessor$InterceptorDispatcher.intercept(ComponentInstantiationPostProcessor.java:125) at org.apache.cloudstack.api.command.user.vm.DeployVMCmd.execute(DeployVMCmd.java:420) at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:158) at com.cloud.async.AsyncJobManagerImpl$1.run(AsyncJobManagerImpl.java:531) 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:1146) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615) at java.lang.Thread.run(Thread.java:701) 2014-01-23 13:50:23,212 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-12:job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ]) Complete async job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ], jobStatus: 2, resultCode: 530, result: Error Code: 533 Error text: Unable to create a deployment for VM[User|78138d6d-d15a-42c9-b406-a229c04d065d] 2014-01-23 13:50:26,154 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null) ===START=== 10.20.0.18 -- GET command=queryAsyncJobResult&jobId=ab3b4b08-3667-4044-b061-ae7721482e94&response=json&sessionkey=MZcKlC%2BbG5N5o1F9aUej178nY%2F0%3D&_=1390503670174 2014-01-23 13:50:26,168 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-2:null) Async job-43 = [ ab3b4b08-3667-4044-b061-ae7721482e94 ] completed 2014-01-23 13:50:26,173 DEBUG [cloud.api.ApiServlet] (catalina-exec-2:null) ===END=== 10.20.0.18 -- GET command=queryAsyncJobResult&jobId=ab3b4b08-3667-4044-b061-ae7721482e94&response=json&sessionkey=MZcKlC%2BbG5N5o1F9aUej178nY%2F0%3D&_=1390503670174 2014-01-23 13:50:26,190 DEBUG [cloud.api.ApiServlet] (catalina-exec-4:null) ===START=== 10.20.0.18 -- GET command=listVirtualMachines&id=78138d6d-d15a-42c9-b406-a229c04d065d&response=json&sessionkey=MZcKlC%2BbG5N5o1F9aUej178nY%2F0%3D&_=1390503670204
