>From the log: ========= There is no enough capacity for the hosts in the zone for the console proxy to create and start so its failing.
"com.cloud.exception.InsufficientServerCapacityException: Unable to create a deployment for VM[ConsoleProxy|v-2-VM]Scope=interface com.cloud.dc.DataCenter; id=1 " "(consoleproxy-1:null) CPUOverprovisioningFactor considered: 1.0 2013-03-22 14:52:47,352 DEBUG [cloud.deploy.FirstFitPlanner] (consoleproxy-1:null) No clusters found having a host with enough capacity, returning. 2013-03-22 14:52:47,378 DEBUG [cloud.capacity.CapacityManagerImpl] (consoleproxy-1:null) 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 " Thanks Rajesh Battala > -----Original Message----- > From: ykruchko ykruchko [mailto:ykruc...@gmail.com] > Sent: Friday, March 22, 2013 7:03 PM > To: cloudstack-...@incubator.apache.org > Subject: Console Proxy VM no startup > > 1) in apache cloud stack 4.0.1 (acs) don`t work russian language because > project > have no > /usr/share/cloud/management/webapps/client/css/cloudstack3.ru_RU.css > > 2) installation guide have url to broken binary file on vhd-util and in xen > cloud > platform vhd-util is installed. Path to binary file /usr/sbin/vhd-util > > 3) I have a problem with Console Proxy VM > > It path of /var/log/cloud/management/management-server.log. If you can you > help me with this problem ? > > 2013-03-22 14:52:33,856 DEBUG [cloud.server.StatsCollector] > (StatsCollector-1:null) HostStatsCollector is running... > 2013-03-22 14:52:33,864 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-158:null) Seq 1-1235353817: Executing request > 2013-03-22 14:52:34,165 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-158:null) Seq 1-1235353817: Response Received: > 2013-03-22 14:52:34,165 DEBUG [agent.transport.Request] > (StatsCollector-1:null) Seq 1-1235353817: Received: { Ans: , MgmtId: > 8796763611955, via: 1, Ver: v1, Flags: 10, { GetHostStatsAnswer } } > 2013-03-22 14:52:47,164 DEBUG > [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 > is ready to launch secondary storage VM > 2013-03-22 14:52:47,297 DEBUG > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Zone 1 is ready to launch console proxy > 2013-03-22 14:52:47,297 DEBUG > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Expand console proxy standby capacity for zone zone1 > 2013-03-22 14:52:47,300 INFO > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Found a stopped console proxy, bring it up to running > pool. > proxy vm id : 2 > 2013-03-22 14:52:47,306 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 > 2013-03-22 14:52:47,306 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (consoleproxy-1:null) Successfully transitioned to start state for > VM[ConsoleProxy|v-2-VM] reservation id = > 8283eee5-c124-4299-a8e9-33846db43253 > 2013-03-22 14:52:47,344 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (consoleproxy-1:null) Trying to deploy VM, vm has dcId: 1 and podId: null > 2013-03-22 14:52:47,344 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (consoleproxy-1:null) Deploy avoids pods: null, clusters: null, hosts: null > 2013-03-22 14:52:47,347 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) DeploymentPlanner allocation algorithm: random > 2013-03-22 14:52:47,347 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) Trying to allocate a host and storage pools from dc:1, > pod:null,cluster:null, requested cpu: 500, requested ram: 1073741824 > 2013-03-22 14:52:47,347 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) Is ROOT volume READY (pool already allocated)?: No > 2013-03-22 14:52:47,348 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) Searching all possible resources under this Zone: 1 > 2013-03-22 14:52:47,349 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 Zone: 1 > 2013-03-22 14:52:47,350 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) CPUOverprovisioningFactor considered: 1.0 > 2013-03-22 14:52:47,352 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) No clusters found having a host with enough capacity, > returning. > 2013-03-22 14:52:47,378 DEBUG [cloud.capacity.CapacityManagerImpl] > (consoleproxy-1:null) 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 > 2013-03-22 14:52:47,380 WARN > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Exception while trying to start console proxy > com.cloud.exception.InsufficientServerCapacityException: Unable to create a > deployment for VM[ConsoleProxy|v-2-VM]Scope=interface > com.cloud.dc.DataCenter; id=1 > at > com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManag > erImpl.java:734) > at > com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.j > ava:472) > at > com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.j > ava:465) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyM > anagerImpl.java:627) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProx > yManagerImpl.java:1164) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxy > ManagerImpl.java:1981) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxy > ManagerImpl.java:173) > at > com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:11 > 3) > at > com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java: > 34) > at > com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java: > 83) > at > com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:73) > 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(Sc > heduledThreadPoolExecutor.java:267) > at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1 > 146) > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java: > 615) > at java.lang.Thread.run(Thread.java:679) > 2013-03-22 14:52:47,737 DEBUG [storage.snapshot.SnapshotSchedulerImpl] > (SnapshotPollTask:null) Snapshot scheduler.poll is being called at > 2013-03-22 12:52:47 GMT > 2013-03-22 14:52:47,738 DEBUG [storage.snapshot.SnapshotSchedulerImpl] > (SnapshotPollTask:null) Got 0 snapshots to be executed at 2013-03-22 > 12:52:47 GMT > 2013-03-22 14:52:47,898 DEBUG > [cloud.network.ExternalLoadBalancerUsageManagerImpl] > (ExternalNetworkMonitor-1:null) External load balancer devices stats > collector is > running... > 2013-03-22 14:52:47,970 DEBUG > [network.router.VirtualNetworkApplianceManagerImpl] (RouterMonitor-1:null) > Found 0 running routers. > 2013-03-22 14:52:47,975 DEBUG > [network.router.VirtualNetworkApplianceManagerImpl] > (RouterStatusMonitor-1:null) Found 0 routers. > 2013-03-22 14:52:54,894 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-206:null) Ping from 1 > 2013-03-22 14:52:56,188 DEBUG [cloud.server.StatsCollector] > (StatsCollector-1:null) StorageCollector is running... > 2013-03-22 14:52:56,191 DEBUG [cloud.server.StatsCollector] > (StatsCollector-1:null) There is no secondary storage VM for secondary storage > host nfs://10.10.10.254/export/secondary > 2013-03-22 14:52:56,196 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-57:null) Seq 1-1235353818: Executing request > 2013-03-22 14:52:56,822 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-57:null) Seq 1-1235353818: Response Received: > 2013-03-22 14:52:56,822 DEBUG [agent.transport.Request] > (StatsCollector-1:null) Seq 1-1235353818: Received: { Ans: , MgmtId: > 8796763611955, via: 1, Ver: v1, Flags: 10, { GetStorageStatsAnswer } } > 2013-03-22 14:53:02,087 DEBUG [cloud.server.StatsCollector] > (StatsCollector-3:null) VmStatsCollector is running... > 2013-03-22 14:53:09,140 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-170:null) Seq 1-1235353604: Executing request > 2013-03-22 14:53:09,403 DEBUG [agent.manager.DirectAgentAttache] > (DirectAgent-170:null) Seq 1-1235353604: Response Received: > 2013-03-22 14:53:09,404 DEBUG [agent.transport.Request] > (DirectAgent-170:null) Seq 1-1235353604: Processing: { Ans: , MgmtId: > 8796763611955, via: 1, Ver: v1, Flags: 10, > [{"ClusterSyncAnswer":{"_clusterId":1,"_newStates":{},"_isExecuted":false,"resu > lt":true,"wait":0}}] > } > 2013-03-22 14:53:17,163 DEBUG > [storage.secondary.SecondaryStorageManagerImpl] (secstorage-1:null) Zone 1 > is ready to launch secondary storage VM > 2013-03-22 14:53:17,294 DEBUG > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Zone 1 is ready to launch console proxy > 2013-03-22 14:53:17,295 DEBUG > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Expand console proxy standby capacity for zone zone1 > 2013-03-22 14:53:17,297 INFO > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Found a stopped console proxy, bring it up to running > pool. > proxy vm id : 2 > 2013-03-22 14:53:17,303 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 > 2013-03-22 14:53:17,303 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (consoleproxy-1:null) Successfully transitioned to start state for > VM[ConsoleProxy|v-2-VM] reservation id = > 0a1b3493-bbef-42d5-b397-8bab06b89be5 > 2013-03-22 14:53:17,421 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (consoleproxy-1:null) Trying to deploy VM, vm has dcId: 1 and podId: null > 2013-03-22 14:53:17,422 DEBUG [cloud.vm.VirtualMachineManagerImpl] > (consoleproxy-1:null) Deploy avoids pods: null, clusters: null, hosts: null > 2013-03-22 14:53:17,424 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) DeploymentPlanner allocation algorithm: random > 2013-03-22 14:53:17,424 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) Trying to allocate a host and storage pools from dc:1, > pod:null,cluster:null, requested cpu: 500, requested ram: 1073741824 > 2013-03-22 14:53:17,424 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) Is ROOT volume READY (pool already allocated)?: No > 2013-03-22 14:53:17,424 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) Searching all possible resources under this Zone: 1 > 2013-03-22 14:53:17,427 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 Zone: 1 > 2013-03-22 14:53:17,428 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) CPUOverprovisioningFactor considered: 1.0 > 2013-03-22 14:53:17,430 DEBUG [cloud.deploy.FirstFitPlanner] > (consoleproxy-1:null) No clusters found having a host with enough capacity, > returning. > 2013-03-22 14:53:17,705 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Running Capacity Checker ... > 2013-03-22 14:53:17,705 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) recalculating system capacity > 2013-03-22 14:53:17,705 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Executing cpu/ram capacity update > 2013-03-22 14:53:17,710 DEBUG [cloud.capacity.CapacityManagerImpl] > (CapacityChecker:null) Found 1 VMs on host 1 > 2013-03-22 14:53:17,711 DEBUG [cloud.capacity.CapacityManagerImpl] > (CapacityChecker:null) Found 0 VM, not running on host 1 > 2013-03-22 14:53:17,714 DEBUG [cloud.capacity.CapacityManagerImpl] > (CapacityChecker:null) No need to calibrate cpu capacity, host:1 usedCpu: > 500 reservedCpu: 0 > 2013-03-22 14:53:17,714 DEBUG [cloud.capacity.CapacityManagerImpl] > (CapacityChecker:null) No need to calibrate memory capacity, host:1 > usedMem: 268435456 reservedMem: 0 > 2013-03-22 14:53:17,714 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Done executing cpu/ram capacity update > 2013-03-22 14:53:17,714 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Executing storage capacity update > 2013-03-22 14:53:17,772 DEBUG [cloud.capacity.CapacityManagerImpl] > (consoleproxy-1:null) 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 > 2013-03-22 14:53:17,774 WARN > [cloud.consoleproxy.ConsoleProxyManagerImpl] > (consoleproxy-1:null) Exception while trying to start console proxy > com.cloud.exception.InsufficientServerCapacityException: Unable to create a > deployment for VM[ConsoleProxy|v-2-VM]Scope=interface > com.cloud.dc.DataCenter; id=1 > at > com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManag > erImpl.java:734) > at > com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.j > ava:472) > at > com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.j > ava:465) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyM > anagerImpl.java:627) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProx > yManagerImpl.java:1164) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxy > ManagerImpl.java:1981) > at > com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxy > ManagerImpl.java:173) > at > com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:11 > 3) > at > com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java: > 34) > at > com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java: > 83) > at > com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:73) > 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(Sc > heduledThreadPoolExecutor.java:267) > at > java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1 > 146) > at > java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java: > 615) > at java.lang.Thread.run(Thread.java:679) > 2013-03-22 14:53:17,975 DEBUG > [network.router.VirtualNetworkApplianceManagerImpl] > (RouterStatusMonitor-1:null) Found 0 routers. > 2013-03-22 14:53:18,056 DEBUG [cloud.storage.StorageManagerImpl] > (CapacityChecker:null) Successfully set Capacity - 1078032596992 for capacity > type - 3 , DataCenterId - 1, HostOrPoolId - 200, PodId 1 > 2013-03-22 14:53:18,056 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Done executing storage capacity update > 2013-03-22 14:53:18,056 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Executing capacity updates for public ip and Vlans > 2013-03-22 14:53:18,062 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Done capacity updates for public ip and Vlans > 2013-03-22 14:53:18,062 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Executing capacity updates for private ip > 2013-03-22 14:53:18,068 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Done executing capacity updates for private ip > 2013-03-22 14:53:18,068 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Done recalculating system capacity > 2013-03-22 14:53:18,083 DEBUG [cloud.alert.AlertManagerImpl] > (CapacityChecker:null) Done running Capacity Checker ...
