You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@cloudstack.apache.org by Trevor Francis <tr...@tgrahamcapital.com> on 2012/12/09 23:45:29 UTC
CS4 unable to spin up VMs
Cloudstack is telling me that I have plenty of CPU, memory, and storage space...but is refusing to spin up a VM:
Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
Why is CPU Freq giving me fits? It does this now for every VM I attempt to spin up? Is there something I am missing here?
2012-12-09 16:36:29,138 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-11:null) submit async job-29, details: AsyncJobVO {id:29, userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine, instanceId: 13, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator: null, cmdInfo: {"sessionkey":"Ayb+u4SuRQVi16dT5ri1Hgc1Bno\u003d","ctxUserId":"2","serviceOfferingId":"9102960d-6867-4523-82e0-30a2afa89bd2","zoneId":"acf8eea5-45f5-48dc-8271-e8a0fdd889df","templateId":"a4a6c3ae-6156-4c39-b487-36023d7319fe","response":"json","id":"13","networkIds":"853f00f8-e8da-4d20-9123-5788f88e28ca,a23f10ff-5702-43e6-b96a-ba204fb75ad1","hypervisor":"KVM","name":"couchdb1","diskOfferingId":"25f7815a-41fb-46bb-9dd6-bb469b137985","_":"1355092583441","ctxAccountId":"2","ctxStartEventId":"150","displayname":"couchdb1"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 207379522204, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2012-12-09 16:36:29,139 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Executing com.cloud.api.commands.DeployVMCmd for job-29
2012-12-09 16:36:29,168 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
2012-12-09 16:36:29,178 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
2012-12-09 16:36:29,181 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
2012-12-09 16:36:29,183 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
2012-12-09 16:36:29,188 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: null new host id: null host id before state transition: null
2012-12-09 16:36:29,188 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Successfully transitioned to start state for VM[User|couchdb1] reservation id = 9dd541c9-d802-4b02-b176-c3ec65386cac
2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Trying to deploy VM, vm has dcId: 1 and podId: null
2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Deploy avoids pods: null, clusters: null, hosts: null
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) DeploymentPlanner allocation algorithm: random
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 20800, requested ram: 16777216000
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Is ROOT volume READY (pool already allocated)?: No
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Searching all possible resources under this Zone: 1
2012-12-09 16:36:29,193 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1
2012-12-09 16:36:29,194 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) CPUOverprovisioningFactor considered: 5.0
2012-12-09 16:36:29,200 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Checking resources in Cluster: 1 under Pod: 1
2012-12-09 16:36:29,201 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Calling HostAllocators to find suitable hosts
2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1
2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts having tag specified on SvcOffering:cb1
2012-12-09 16:36:29,202 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts with tag 'cb1' are:[Host[-1-Routing]]
2012-12-09 16:36:29,203 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-1-Routing]]
2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-1-Routing]]
2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for speed=20800Mhz, Ram=16000
2012-12-09 16:36:29,207 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Checking if host: 1 has enough capacity for requested CPU: 20800 and requested RAM: 16777216000 , cpuOverprovisioningFactor: 5.0
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts's actual total CPU: 41584 and CPU after applying overprovisioning: 207920
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free CPU: 206920 , Requested CPU: 20800
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free RAM: 67266064384 , Requested RAM: 16777216000
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host has enough CPU and RAM available
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1, used: 1000, reserved: 0, actual total: 41584, total with overprovisioning: 207920; requested cpu:20800,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1, used: 268435456, reserved: 0, total: 67534499840; requested mem: 16777216000,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found under this Cluster: 1
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Could not find suitable Deployment Destination for this VM under any clusters, returning.
2012-12-09 16:36:29,214 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
2012-12-09 16:36:29,217 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: null
2012-12-09 16:36:29,221 DEBUG [cloud.vm.UserVmManagerImpl] (Job-Executor-3:job-29) Destroying vm VM[User|couchdb1] as it failed to create
2012-12-09 16:36:29,227 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) 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
2012-12-09 16:36:29,250 INFO [api.commands.DeployVMCmd] (Job-Executor-3:job-29) com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|couchdb1]Scope=interface com.cloud.dc.DataCenter; id=1
2012-12-09 16:36:29,250 WARN [cloud.api.ApiDispatcher] (Job-Executor-3:job-29) class com.cloud.api.ServerApiException : Unable to create a deployment for VM[User|couchdb1]
2012-12-09 16:36:29,251 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Complete async job-29, jobStatus: 2, resultCode: 530, result: Error Code: 533 Error text: Unable to create a deployment for VM[User|couchdb1]
Trevor Francis
Partner
46 Labs | PeerEdge Cloud Switch (PeCS)
http://www.46labs.com | http://www.peeredge.net
720-214-3643- Voice
trevor@46labs.com
Solutions Provider for the Telecom Industry
RE: CS4 unable to spin up VMs
Posted by Edison Su <Ed...@citrix.com>.
What's the cpu freq are u using in service offering? The cpu freq you requested must be <= the actual cpu freq of hypervisor host, otherwise, you will get this error.
From: Trevor Francis [mailto:trevor.francis@tgrahamcapital.com]
Sent: Sunday, December 09, 2012 2:45 PM
To: cloudstack-users@incubator.apache.org
Subject: CS4 unable to spin up VMs
Cloudstack is telling me that I have plenty of CPU, memory, and storage space...but is refusing to spin up a VM:
Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
Why is CPU Freq giving me fits? It does this now for every VM I attempt to spin up? Is there something I am missing here?
2012-12-09 16:36:29,138 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-11:null) submit async job-29, details: AsyncJobVO {id:29, userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine, instanceId: 13, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator: null, cmdInfo: {"sessionkey":"Ayb+u4SuRQVi16dT5ri1Hgc1Bno\u003d","ctxUserId":"2","serviceOfferingId":"9102960d-6867-4523-82e0-30a2afa89bd2","zoneId":"acf8eea5-45f5-48dc-8271-e8a0fdd889df","templateId":"a4a6c3ae-6156-4c39-b487-36023d7319fe","response":"json","id":"13","networkIds":"853f00f8-e8da-4d20-9123-5788f88e28ca,a23f10ff-5702-43e6-b96a-ba204fb75ad1","hypervisor":"KVM","name":"couchdb1","diskOfferingId":"25f7815a-41fb-46bb-9dd6-bb469b137985","_":"1355092583441","ctxAccountId":"2","ctxStartEventId":"150","displayname":"couchdb1"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 207379522204, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2012-12-09 16:36:29,139 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Executing com.cloud.api.commands.DeployVMCmd for job-29
2012-12-09 16:36:29,168 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
2012-12-09 16:36:29,178 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
2012-12-09 16:36:29,181 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
2012-12-09 16:36:29,183 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
2012-12-09 16:36:29,188 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: null new host id: null host id before state transition: null
2012-12-09 16:36:29,188 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Successfully transitioned to start state for VM[User|couchdb1] reservation id = 9dd541c9-d802-4b02-b176-c3ec65386cac
2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Trying to deploy VM, vm has dcId: 1 and podId: null
2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Deploy avoids pods: null, clusters: null, hosts: null
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) DeploymentPlanner allocation algorithm: random
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 20800, requested ram: 16777216000
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Is ROOT volume READY (pool already allocated)?: No
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Searching all possible resources under this Zone: 1
2012-12-09 16:36:29,193 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1
2012-12-09 16:36:29,194 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) CPUOverprovisioningFactor considered: 5.0
2012-12-09 16:36:29,200 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Checking resources in Cluster: 1 under Pod: 1
2012-12-09 16:36:29,201 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Calling HostAllocators to find suitable hosts
2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1
2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts having tag specified on SvcOffering:cb1
2012-12-09 16:36:29,202 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts with tag 'cb1' are:[Host[-1-Routing]]
2012-12-09 16:36:29,203 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-1-Routing]]
2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-1-Routing]]
2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for speed=20800Mhz, Ram=16000
2012-12-09 16:36:29,207 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Checking if host: 1 has enough capacity for requested CPU: 20800 and requested RAM: 16777216000 , cpuOverprovisioningFactor: 5.0
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts's actual total CPU: 41584 and CPU after applying overprovisioning: 207920
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free CPU: 206920 , Requested CPU: 20800
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free RAM: 67266064384 , Requested RAM: 16777216000
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host has enough CPU and RAM available
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1, used: 1000, reserved: 0, actual total: 41584, total with overprovisioning: 207920; requested cpu:20800,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1, used: 268435456, reserved: 0, total: 67534499840; requested mem: 16777216000,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found under this Cluster: 1
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Could not find suitable Deployment Destination for this VM under any clusters, returning.
2012-12-09 16:36:29,214 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
2012-12-09 16:36:29,217 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: null
2012-12-09 16:36:29,221 DEBUG [cloud.vm.UserVmManagerImpl] (Job-Executor-3:job-29) Destroying vm VM[User|couchdb1] as it failed to create
2012-12-09 16:36:29,227 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) 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
2012-12-09 16:36:29,250 INFO [api.commands.DeployVMCmd] (Job-Executor-3:job-29) com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|couchdb1]Scope=interface com.cloud.dc.DataCenter; id=1
2012-12-09 16:36:29,250 WARN [cloud.api.ApiDispatcher] (Job-Executor-3:job-29) class com.cloud.api.ServerApiException : Unable to create a deployment for VM[User|couchdb1]
2012-12-09 16:36:29,251 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Complete async job-29, jobStatus: 2, resultCode: 530, result: Error Code: 533 Error text: Unable to create a deployment for VM[User|couchdb1]
Trevor Francis
Partner
46 Labs | PeerEdge Cloud Switch (PeCS)
http://www.46labs.com | http://www.peeredge.net
720-214-3643- Voice
trevor@46labs.com<ma...@46labs.com>
Solutions Provider for the Telecom Industry
[cid:image001.jpg@01CDD62E.D3F8A5A0] [cid:image002.jpg@01CDD62E.D3F8A5A0]
Re: CS4 unable to spin up VMs
Posted by Trevor Francis <tr...@tgrahamcapital.com>.
Resolved by removing and re-adding hosts with a management server restart.
Trevor Francis
Partner
46 Labs | PeerEdge Cloud Switch (PeCS)
http://www.46labs.com | http://www.peeredge.net
720-214-3643- Voice
trevor@46labs.com
Solutions Provider for the Telecom Industry
On Dec 9, 2012, at 7:02 PM, "Musayev, Ilya" <im...@webmd.net> wrote:
> Hi Trevor
>
> I''ve seen this in past and though now clearly stated there are many reasons why this can occur. Please confirm your router vm and secondary storage vm are accessible via ssh from your CS host.
>
> -ilya (aka serverchief on IRC)
>
> Trevor Francis <tr...@tgrahamcapital.com> wrote:
> Cloudstack is telling me that I have plenty of CPU, memory, and storage space...but is refusing to spin up a VM:
>
> Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
>
> Why is CPU Freq giving me fits? It does this now for every VM I attempt to spin up? Is there something I am missing here?
>
> 2012-12-09 16:36:29,138 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-11:null) submit async job-29, details: AsyncJobVO {id:29, userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine, instanceId: 13, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator: null, cmdInfo: {"sessionkey":"Ayb+u4SuRQVi16dT5ri1Hgc1Bno\u003d","ctxUserId":"2","serviceOfferingId":"9102960d-6867-4523-82e0-30a2afa89bd2","zoneId":"acf8eea5-45f5-48dc-8271-e8a0fdd889df","templateId":"a4a6c3ae-6156-4c39-b487-36023d7319fe","response":"json","id":"13","networkIds":"853f00f8-e8da-4d20-9123-5788f88e28ca,a23f10ff-5702-43e6-b96a-ba204fb75ad1","hypervisor":"KVM","name":"couchdb1","diskOfferingId":"25f7815a-41fb-46bb-9dd6-bb469b137985","_":"1355092583441","ctxAccountId":"2","ctxStartEventId":"150","displayname":"couchdb1"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 207379522204, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
> 2012-12-09 16:36:29,139 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Executing com.cloud.api.commands.DeployVMCmd for job-29
> 2012-12-09 16:36:29,168 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
> 2012-12-09 16:36:29,178 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
> 2012-12-09 16:36:29,181 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
> 2012-12-09 16:36:29,183 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
> 2012-12-09 16:36:29,188 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: null new host id: null host id before state transition: null
> 2012-12-09 16:36:29,188 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Successfully transitioned to start state for VM[User|couchdb1] reservation id = 9dd541c9-d802-4b02-b176-c3ec65386cac
> 2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Trying to deploy VM, vm has dcId: 1 and podId: null
> 2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Deploy avoids pods: null, clusters: null, hosts: null
> 2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) DeploymentPlanner allocation algorithm: random
> 2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 20800, requested ram: 16777216000
> 2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Is ROOT volume READY (pool already allocated)?: No
> 2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Searching all possible resources under this Zone: 1
> 2012-12-09 16:36:29,193 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1
> 2012-12-09 16:36:29,194 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) CPUOverprovisioningFactor considered: 5.0
> 2012-12-09 16:36:29,200 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Checking resources in Cluster: 1 under Pod: 1
> 2012-12-09 16:36:29,201 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Calling HostAllocators to find suitable hosts
> 2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1
> 2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts having tag specified on SvcOffering:cb1
> 2012-12-09 16:36:29,202 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts with tag 'cb1' are:[Host[-1-Routing]]
> 2012-12-09 16:36:29,203 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-1-Routing]]
> 2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-1-Routing]]
> 2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for speed=20800Mhz, Ram=16000
> 2012-12-09 16:36:29,207 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Checking if host: 1 has enough capacity for requested CPU: 20800 and requested RAM: 16777216000 , cpuOverprovisioningFactor: 5.0
> 2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts's actual total CPU: 41584 and CPU after applying overprovisioning: 207920
> 2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free CPU: 206920 , Requested CPU: 20800
> 2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free RAM: 67266064384 , Requested RAM: 16777216000
> 2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host has enough CPU and RAM available
> 2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1, used: 1000, reserved: 0, actual total: 41584, total with overprovisioning: 207920; requested cpu:20800,alloc_from_last_host?:false ,considerReservedCapacity?: true
> 2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1, used: 268435456, reserved: 0, total: 67534499840; requested mem: 16777216000,alloc_from_last_host?:false ,considerReservedCapacity?: true
> 2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
> 2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
> 2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found
> 2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found under this Cluster: 1
> 2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Could not find suitable Deployment Destination for this VM under any clusters, returning.
> 2012-12-09 16:36:29,214 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
> 2012-12-09 16:36:29,217 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: null
> 2012-12-09 16:36:29,221 DEBUG [cloud.vm.UserVmManagerImpl] (Job-Executor-3:job-29) Destroying vm VM[User|couchdb1] as it failed to create
> 2012-12-09 16:36:29,227 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) 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
> 2012-12-09 16:36:29,250 INFO [api.commands.DeployVMCmd] (Job-Executor-3:job-29) com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|couchdb1]Scope=interface com.cloud.dc.DataCenter; id=1
> 2012-12-09 16:36:29,250 WARN [cloud.api.ApiDispatcher] (Job-Executor-3:job-29) class com.cloud.api.ServerApiException : Unable to create a deployment for VM[User|couchdb1]
> 2012-12-09 16:36:29,251 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Complete async job-29, jobStatus: 2, resultCode: 530, result: Error Code: 533 Error text: Unable to create a deployment for VM[User|couchdb1]
>
>
>
>
> Trevor Francis
> Partner
> 46 Labs | PeerEdge Cloud Switch (PeCS)
> http://www.46labs.com | http://www.peeredge.net
> 720-214-3643- Voice
> trevor@46labs.com
>
> Solutions Provider for the Telecom Industry
>
>
>
RE: CS4 unable to spin up VMs
Posted by "Musayev, Ilya" <im...@webmd.net>.
Hi Trevor
I''ve seen this in past and though now clearly stated there are many reasons why this can occur. Please confirm your router vm and secondary storage vm are accessible via ssh from your CS host.
-ilya (aka serverchief on IRC)
Trevor Francis <tr...@tgrahamcapital.com> wrote:
Cloudstack is telling me that I have plenty of CPU, memory, and storage space...but is refusing to spin up a VM:
Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
Why is CPU Freq giving me fits? It does this now for every VM I attempt to spin up? Is there something I am missing here?
2012-12-09 16:36:29,138 DEBUG [cloud.async.AsyncJobManagerImpl] (catalina-exec-11:null) submit async job-29, details: AsyncJobVO {id:29, userId: 2, accountId: 2, sessionKey: null, instanceType: VirtualMachine, instanceId: 13, cmd: com.cloud.api.commands.DeployVMCmd, cmdOriginator: null, cmdInfo: {"sessionkey":"Ayb+u4SuRQVi16dT5ri1Hgc1Bno\u003d","ctxUserId":"2","serviceOfferingId":"9102960d-6867-4523-82e0-30a2afa89bd2","zoneId":"acf8eea5-45f5-48dc-8271-e8a0fdd889df","templateId":"a4a6c3ae-6156-4c39-b487-36023d7319fe","response":"json","id":"13","networkIds":"853f00f8-e8da-4d20-9123-5788f88e28ca,a23f10ff-5702-43e6-b96a-ba204fb75ad1","hypervisor":"KVM","name":"couchdb1","diskOfferingId":"25f7815a-41fb-46bb-9dd6-bb469b137985","_":"1355092583441","ctxAccountId":"2","ctxStartEventId":"150","displayname":"couchdb1"}, cmdVersion: 0, callbackType: 0, callbackAddress: null, status: 0, processStatus: 0, resultCode: 0, result: null, initMsid: 207379522204, completeMsid: null, lastUpdated: null, lastPolled: null, created: null}
2012-12-09 16:36:29,139 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Executing com.cloud.api.commands.DeployVMCmd for job-29
2012-12-09 16:36:29,168 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
2012-12-09 16:36:29,178 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
2012-12-09 16:36:29,181 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=204
2012-12-09 16:36:29,183 DEBUG [cloud.network.NetworkManagerImpl] (Job-Executor-3:job-29) Service SecurityGroup is not supported in the network id=205
2012-12-09 16:36:29,188 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Stopped to Starting with event: StartRequestedvm's original host id: null new host id: null host id before state transition: null
2012-12-09 16:36:29,188 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Successfully transitioned to start state for VM[User|couchdb1] reservation id = 9dd541c9-d802-4b02-b176-c3ec65386cac
2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Trying to deploy VM, vm has dcId: 1 and podId: null
2012-12-09 16:36:29,190 DEBUG [cloud.vm.VirtualMachineManagerImpl] (Job-Executor-3:job-29) Deploy avoids pods: null, clusters: null, hosts: null
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) DeploymentPlanner allocation algorithm: random
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Trying to allocate a host and storage pools from dc:1, pod:null,cluster:null, requested cpu: 20800, requested ram: 16777216000
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Is ROOT volume READY (pool already allocated)?: No
2012-12-09 16:36:29,192 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Searching all possible resources under this Zone: 1
2012-12-09 16:36:29,193 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Zone: 1
2012-12-09 16:36:29,194 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) CPUOverprovisioningFactor considered: 5.0
2012-12-09 16:36:29,200 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Checking resources in Cluster: 1 under Pod: 1
2012-12-09 16:36:29,201 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Calling HostAllocators to find suitable hosts
2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1
2012-12-09 16:36:29,201 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for hosts having tag specified on SvcOffering:cb1
2012-12-09 16:36:29,202 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts with tag 'cb1' are:[Host[-1-Routing]]
2012-12-09 16:36:29,203 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-1-Routing]]
2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-1-Routing]]
2012-12-09 16:36:29,205 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Looking for speed=20800Mhz, Ram=16000
2012-12-09 16:36:29,207 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Checking if host: 1 has enough capacity for requested CPU: 20800 and requested RAM: 16777216000 , cpuOverprovisioningFactor: 5.0
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Hosts's actual total CPU: 41584 and CPU after applying overprovisioning: 207920
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free CPU: 206920 , Requested CPU: 20800
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Free RAM: 67266064384 , Requested RAM: 16777216000
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host has enough CPU and RAM available
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1, used: 1000, reserved: 0, actual total: 41584, total with overprovisioning: 207920; requested cpu:20800,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-12-09 16:36:29,210 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29 FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1, used: 268435456, reserved: 0, total: 67534499840; requested mem: 16777216000,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Not using host 1; numCpusGood: true; cpuFreqGood: false, host has capacity?true
2012-12-09 16:36:29,210 DEBUG [allocator.impl.FirstFitAllocator] (Job-Executor-3:job-29 FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) No suitable hosts found under this Cluster: 1
2012-12-09 16:36:29,210 DEBUG [cloud.deploy.FirstFitPlanner] (Job-Executor-3:job-29) Could not find suitable Deployment Destination for this VM under any clusters, returning.
2012-12-09 16:36:29,214 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
2012-12-09 16:36:29,217 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) VM state transitted from :Starting to Stopped with event: OperationFailedvm's original host id: null new host id: null host id before state transition: null
2012-12-09 16:36:29,221 DEBUG [cloud.vm.UserVmManagerImpl] (Job-Executor-3:job-29) Destroying vm VM[User|couchdb1] as it failed to create
2012-12-09 16:36:29,227 DEBUG [cloud.capacity.CapacityManagerImpl] (Job-Executor-3:job-29) 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
2012-12-09 16:36:29,250 INFO [api.commands.DeployVMCmd] (Job-Executor-3:job-29) com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[User|couchdb1]Scope=interface com.cloud.dc.DataCenter; id=1
2012-12-09 16:36:29,250 WARN [cloud.api.ApiDispatcher] (Job-Executor-3:job-29) class com.cloud.api.ServerApiException : Unable to create a deployment for VM[User|couchdb1]
2012-12-09 16:36:29,251 DEBUG [cloud.async.AsyncJobManagerImpl] (Job-Executor-3:job-29) Complete async job-29, jobStatus: 2, resultCode: 530, result: Error Code: 533 Error text: Unable to create a deployment for VM[User|couchdb1]
Trevor Francis
Partner
46 Labs | PeerEdge Cloud Switch (PeCS)
http://www.46labs.com | http://www.peeredge.net
720-214-3643- Voice
trevor@46labs.com<ma...@46labs.com>
Solutions Provider for the Telecom Industry
[cid:image001.jpg@01CD7EB2.A839EF60] [cid:image002.jpg@01CD7EB2.A839EF60]