|
Welcome,
Guest
|
Cloudstack 3.0 "Can't Deploy/Start proxyvm"
(1 viewing) (1) Guest
|
TOPIC: Cloudstack 3.0 "Can't Deploy/Start proxyvm"
Cloudstack 3.0 "Can't Deploy/Start proxyvm" 3 months ago #9044
|
I've installed cloudstack 3.0 beta yesterday, and every thing seems to be working fine.
I've 1 managment node and the same node serve as KVM host too. the seconde storage vm booted without any problem and I was able to create new instances and access them, but I can't access the VNC for the instances as there is an error while the managment server try to deploy the proxyvm here is the log :
2012-02-15 14:08:59,271 DEBUG [cloud.cluster.ClusterManagerImpl] (Cluster-Heartbeat-1:null) Detected management node left, id:1, nodeIP:169.254.0.1
2012-02-15 14:08:59,271 DEBUG [cloud.cluster.ClusterServiceServletImpl] (Cluster-Heartbeat-1:null) Ping at http://169.254.0.1:9090/clusterservice
2012-02-15 14:08:59,273 DEBUG [cloud.cluster.ClusterServiceServletHttpHandler] (Cluster-Listener-1:null) Handle ping request from 279278805451165
2012-02-15 14:08:59,274 DEBUG [cloud.cluster.ClusterServiceServletImpl] (Cluster-Heartbeat-1:null) POST http://169.254.0.1:9090/clusterservice response :true, responding time: 2 ms
2012-02-15 14:08:59,274 INFO [cloud.cluster.ClusterManagerImpl] (Cluster-Heartbeat-1:null) Management node 1 is detected inactive by timestamp but is pingable
2012-02-15 14:09:00,547 DEBUG [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 is ready to launch secondary storage VM
2012-02-15 14:09:00,659 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Zone 1 is ready to launch console proxy
2012-02-15 14:09:00,659 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Expand console proxy standby capacity for zone Zony
2012-02-15 14:09:00,663 INFO [cloud.consoleproxy.ConsoleProxyManagerImpl] (consoleproxy-1:null) Found a stopped console proxy, bring it up to running pool. proxy vm id : 2
2012-02-15 14:09:00,673 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) 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-02-15 14:09:00,673 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Successfully transitioned to start state for VM[ConsoleProxy|v-2-VM] reservation id = 985abe20-9dc6-496a-a5ef-ca0e4220e17a
2012-02-15 14:09:00,676 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Trying to deploy VM, vm has dcId: 1 and podId: 1
2012-02-15 14:09:00,676 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Deploy avoids pods: null, clusters: null, hosts: null
2012-02-15 14:09:00,679 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) DeploymentPlanner allocation algorithm: random
2012-02-15 14:09:00,679 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Trying to allocate a host and storage pools from dc:1, pod:1,cluster:null, requested cpu: 500, requested ram: 1073741824
2012-02-15 14:09:00,679 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Is ROOT volume READY (pool already allocated)?: No
2012-02-15 14:09:00,679 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Searching resources only under specified Pod: 1
2012-02-15 14:09:00,681 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Listing clusters in order of aggregate capacity, that have (atleast one host with) enough CPU and RAM capacity under this Pod: 1
2012-02-15 14:09:00,682 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) CPUOverprovisioningFactor considered: 1.0
2012-02-15 14:09:00,693 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Checking resources in Cluster: 1 under Pod: 1
2012-02-15 14:09:00,693 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Calling HostAllocators to find suitable hosts
2012-02-15 14:09:00,693 DEBUG [allocator.impl.FirstFitAllocator] (consoleproxy-1:FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1
2012-02-15 14:09:00,695 DEBUG [allocator.impl.FirstFitAllocator] (consoleproxy-1:FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for allocation: [Host[-1-Routing]]
2012-02-15 14:09:00,698 DEBUG [allocator.impl.FirstFitAllocator] (consoleproxy-1:FirstFitRoutingAllocator) Found 1 hosts for allocation after prioritization: [Host[-1-Routing]]
2012-02-15 14:09:00,698 DEBUG [allocator.impl.FirstFitAllocator] (consoleproxy-1:FirstFitRoutingAllocator) Looking for speed=500Mhz, Ram=1024
2012-02-15 14:09:00,700 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) Checking if host: 1 has enough capacity for requested CPU: 500 and requested RAM: 1073741824 , cpuOverprovisioningFactor: 1.0
2012-02-15 14:09:00,703 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) Hosts's actual total CPU: 67056 and CPU after applying overprovisioning: 67056
2012-02-15 14:09:00,703 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) Free CPU: 62556 , Requested CPU: 500
2012-02-15 14:09:00,703 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) Free RAM: 12550328320 , Requested RAM: 1073741824
2012-02-15 14:09:00,703 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) Host has enough CPU and RAM available
2012-02-15 14:09:00,703 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1, used: 4500, reserved: 0, actual total: 67056, total with overprovisioning: 67056; requested cpu:500,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-02-15 14:09:00,703 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1, used: 4160749568, reserved: 0, total: 16711077888; requested mem: 1073741824,alloc_from_last_host?:false ,considerReservedCapacity?: true
2012-02-15 14:09:00,703 DEBUG [allocator.impl.FirstFitAllocator] (consoleproxy-1:FirstFitRoutingAllocator) Found a suitable host, adding to list: 1
2012-02-15 14:09:00,703 DEBUG [allocator.impl.FirstFitAllocator] (consoleproxy-1:FirstFitRoutingAllocator) Host Allocator returning 1 suitable hosts
2012-02-15 14:09:00,705 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Checking suitable pools for volume (Id, Type): (2,ROOT)
2012-02-15 14:09:00,705 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) We need to allocate new storagepool for this volume
2012-02-15 14:09:00,706 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Calling StoragePoolAllocators to find suitable pools
2012-02-15 14:09:00,707 DEBUG [storage.allocator.FirstFitStoragePoolAllocator] (consoleproxy-1:null) Looking for pools in dc: 1 pod:1 cluster:1
2012-02-15 14:09:00,709 DEBUG [storage.allocator.FirstFitStoragePoolAllocator] (consoleproxy-1:null) FirstFitStoragePoolAllocator has 1 pools to check for allocation
2012-02-15 14:09:00,709 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (consoleproxy-1:null) Checking if storage pool is suitable, name: cloudstore ,poolId: 201
2012-02-15 14:09:00,709 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (consoleproxy-1:null) Is localStorageAllocationNeeded? false
2012-02-15 14:09:00,709 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (consoleproxy-1:null) Is storage pool shared? true
2012-02-15 14:09:00,710 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (consoleproxy-1:null) Attempting to look for pool 201 for storage, totalSize: 517407244288, usedBytes: 6003097600, usedPct: 0.011602268167429342, disable threshold: 0.85
2012-02-15 14:09:00,712 DEBUG [storage.allocator.AbstractStoragePoolAllocator] (consoleproxy-1:null) Attempting to look for pool 201 for storage, maxSize : 1.03481449E12, totalSize : 21475950592, askingSize : 0, allocated disable threshold: 0.85
2012-02-15 14:09:00,712 DEBUG [storage.allocator.FirstFitStoragePoolAllocator] (consoleproxy-1:null) FirstFitStoragePoolAllocator returning 1 suitable storage pools
2012-02-15 14:09:00,713 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Trying to find a potenial host and associated storage pools from the suitable host/pool lists for this VM
2012-02-15 14:09:00,713 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Checking if host: 1 can access any suitable storage pool for volume: ROOT
2012-02-15 14:09:00,714 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Host: 1 can access pool: 201
2012-02-15 14:09:00,714 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Found a potential host id: 1 name: hv1.exaservers.com and associated storage pools for this VM
2012-02-15 14:09:00,716 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) Returning Deployment Destination: Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(1)-Storage(Volume(2|ROOT-->Pool(201))]
2012-02-15 14:09:00,716 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Deployment found - P0=VM[ConsoleProxy|v-2-VM], P0=Dest[Zone(Id)-Pod(Id)-Cluster(Id)-Host(Id)-Storage(Volume(Id|Type-->Pool(Id))] : Dest[Zone(1)-Pod(1)-Cluster(1)-Host(1)-Storage(Volume(2|ROOT-->Pool(201))]
2012-02-15 14:09:00,719 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) VM state transitted from :Starting to Starting with event: OperationRetryvm's original host id: null new host id: 1 host id before state transition: null
2012-02-15 14:09:00,727 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) Hosts's actual total CPU: 67056 and CPU after applying overprovisioning: 67056
2012-02-15 14:09:00,727 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) We are allocating VM, increasing the used capacity of this host:1
2012-02-15 14:09:00,727 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) Current Used CPU: 4500 , Free CPU:62556 ,Requested CPU: 500
2012-02-15 14:09:00,727 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) Current Used RAM: 4160749568 , Free RAM:12550328320 ,Requested RAM: 1073741824
2012-02-15 14:09:00,727 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) CPU STATS after allocation: for host: 1, old used: 4500, old reserved: 0, actual total: 67056, total with overprovisioning: 67056; new used:5000, reserved:0; requested cpu:500,alloc_from_last:false
2012-02-15 14:09:00,727 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) RAM STATS after allocation: for host: 1, old used: 4160749568, old reserved: 0, total: 16711077888; new used: 5234491392, reserved: 0; requested mem: 1073741824,alloc_from_last:false
2012-02-15 14:09:00,729 DEBUG [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) VM is being started in podId: 1
2012-02-15 14:09:00,733 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Network id=205 is already implemented
2012-02-15 14:09:00,746 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Service SecurityGroup is not supported in the network id=205
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking JuniperSRX to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking Netscaler to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking F5BigIp to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking VirtualRouter to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking Ovs to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking ExternalDhcpServer to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking BareMetal to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,754 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking ElasticLoadBalancerVm to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,755 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking SecurityGroupProvider to prepare for Nic[5-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-93.189.97.91]
2012-02-15 14:09:00,756 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Service SecurityGroup is not supported in the network id=205
2012-02-15 14:09:00,757 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Network id=202 is already implemented
2012-02-15 14:09:00,771 DEBUG [cloud.cluster.ClusterManagerImpl] (Cluster-Heartbeat-1:null) Detected management node left, id:1, nodeIP:169.254.0.1
2012-02-15 14:09:00,772 DEBUG [cloud.cluster.ClusterServiceServletImpl] (Cluster-Heartbeat-1:null) Ping at http://169.254.0.1:9090/clusterservice
2012-02-15 14:09:00,773 DEBUG [cloud.cluster.ClusterServiceServletHttpHandler] (Cluster-Listener-1:null) Handle ping request from 279278805451165
2012-02-15 14:09:00,774 DEBUG [cloud.cluster.ClusterServiceServletImpl] (Cluster-Heartbeat-1:null) POST http://169.254.0.1:9090/clusterservice response :true, responding time: 2 ms
2012-02-15 14:09:00,774 INFO [cloud.cluster.ClusterManagerImpl] (Cluster-Heartbeat-1:null) Management node 1 is detected inactive by timestamp but is pingable
2012-02-15 14:09:00,775 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking JuniperSRX to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking Netscaler to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking F5BigIp to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking VirtualRouter to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking Ovs to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking ExternalDhcpServer to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking BareMetal to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking ElasticLoadBalancerVm to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,776 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Asking SecurityGroupProvider to prepare for Nic[6-2-985abe20-9dc6-496a-a5ef-ca0e4220e17a-169.254.3.70]
2012-02-15 14:09:00,778 DEBUG [cloud.network.NetworkManagerImpl] (consoleproxy-1:null) Network id=201 is already implemented
2012-02-15 14:09:00,793 DEBUG [db.Transaction.Transaction] (consoleproxy-1:null) Rolling back the transaction: Time = 1 Name = -SystemVmLoadScanner$1.run:73-Executors$RunnableAdapter.call:471-FutureTask$Sync.innerRunAndReset:351-FutureTask.runAndReset:178-ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201:165-ScheduledThreadPoolExecutor$ScheduledFutureTask.run:267-ThreadPoolExecutor.runWorker:1110-ThreadPoolExecutor$Worker.run:603-Thread.run:679; called by -Transaction.rollback:842-DataCenterIpAddressDaoImpl.takeIpAddress:58-DatabaseCallback.intercept:35-DataCenterDaoImpl.allocatePrivateIpAddress:230-DatabaseCallback.intercept:35-PodBasedNetworkGuru.reserve:129-NetworkManagerImpl.prepare:1773-VirtualMachineManagerImpl.advanceStart:746-VirtualMachineManagerImpl.start:466-VirtualMachineManagerImpl.start:459-ConsoleProxyManagerImpl.startProxy:446-ConsoleProxyManagerImpl.allocCapacity:941
2012-02-15 14:09:00,793 INFO [cloud.vm.VirtualMachineManagerImpl] (consoleproxy-1:null) Insufficient capacity
com.cloud.exception.InsufficientAddressCapacityException: Unable to get a management ip addressScope=interface com.cloud.dc.Pod; id=1
at com.cloud.network.guru.PodBasedNetworkGuru.reserve(PodBasedNetworkGuru.java:131)
at com.cloud.network.NetworkManagerImpl.prepare(NetworkManagerImpl.java:1773)
at com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:746)
at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:466)
at com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:459)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:446)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:941)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1677)
at com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:160)
at com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:115)
at com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:36)
at com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:85)
at com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:75)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:165)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:267)
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)
The Host have enough ram and CPU to handle the proxy vm, but still can't get it work ! |
|
|
Re: Cloudstack 3.0 "Can't Deploy/Start proxyvm" 3 months ago #9053
|
Hi,
It seems this is because of Insufficient capacity. com.cloud.exception.InsufficientAddressCapacityException: Unable to get a management ip addressScope=interface com.cloud.dc.Pod; id=1
at com.cloud.network.guru.PodBasedNetworkGuru.reserve(PodBasedNetworkGuru.java:131)
AFAIK, when you make sure the proxy VM can get a public ip, it will work. You can add more public ip's in the webinterface. |
|
The following user(s) said Thank You: ke4qqq
|
|
Time to create page: 0.45 seconds
Forums