HI
Here is the management server logs.
013-08-05 21:01:59,936 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(secstorage-1:null) Destroying vm VM[SecondaryStorageVm|s-5731-VM]
2013-08-05 21:01:59,936 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(secstorage-1:null) Cleaning up NICS
2013-08-05 21:01:59,936 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Cleaning network for vm: 5731
2013-08-05 21:01:59,941 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-08-05 21:01:59,941 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(consoleproxy-1:null) Successfully transitioned to start state for
VM[ConsoleProxy|v-5504-VM] reservation id = b05abcfa-9aba-474b-9146-00b5e521ff02
2013-08-05 21:01:59,950 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(consoleproxy-1:null) Trying to deploy VM, vm has dcId: 1 and podId: null
2013-08-05 21:01:59,950 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(consoleproxy-1:null) Deploy avoids pods: null, clusters: null, hosts: null
2013-08-05 21:01:59,951 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Service SecurityGroup is not supported in the network id=204
2013-08-05 21:01:59,953 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) DeploymentPlanner allocation algorithm: random
2013-08-05 21:01:59,953 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-08-05 21:01:59,953 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Is ROOT volume READY (pool already allocated)?: No
2013-08-05 21:01:59,953 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Searching all possible resources under this Zone: 1
2013-08-05 21:01:59,955 DEBUG [network.guru.DirectNetworkGuru]
(secstorage-1:null) Deallocate network: networkId: 204, ip: null
2013-08-05 21:01:59,956 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-08-05 21:01:59,957 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) CPUOverprovisioningFactor considered: 1.0
2013-08-05 21:01:59,961 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Removed nic id=22907
2013-08-05 21:01:59,970 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Checking resources in Cluster: 1 under Pod: 1
2013-08-05 21:01:59,970 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Calling HostAllocators to find suitable hosts
2013-08-05 21:01:59,970 DEBUG [allocator.impl.FirstFitAllocator]
(consoleproxy-1:FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1
cluster:1
2013-08-05 21:01:59,974 DEBUG [allocator.impl.FirstFitAllocator]
(consoleproxy-1:FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to
check for allocation: [Host[-1-Routing]]
2013-08-05 21:01:59,978 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Removed nic id=22908
2013-08-05 21:01:59,979 DEBUG [allocator.impl.FirstFitAllocator]
(consoleproxy-1:FirstFitRoutingAllocator) Found 1 hosts for allocation after
prioritization: [Host[-1-Routing]]
2013-08-05 21:01:59,979 DEBUG [allocator.impl.FirstFitAllocator]
(consoleproxy-1:FirstFitRoutingAllocator) Looking for speed=500Mhz, Ram=1024
2013-08-05 21:01:59,982 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
2013-08-05 21:01:59,987 DEBUG [cloud.capacity.CapacityManagerImpl]
(consoleproxy-1:FirstFitRoutingAllocator) Hosts's actual total CPU: 31984 and
CPU after applying overprovisioning: 31984
2013-08-05 21:01:59,987 DEBUG [cloud.capacity.CapacityManagerImpl]
(consoleproxy-1:FirstFitRoutingAllocator) Free CPU: 31984 , Requested CPU: 500
2013-08-05 21:01:59,987 DEBUG [cloud.capacity.CapacityManagerImpl]
(consoleproxy-1:FirstFitRoutingAllocator) Free RAM: 34312003584 , Requested
RAM: 1073741824
2013-08-05 21:01:59,987 DEBUG [cloud.capacity.CapacityManagerImpl]
(consoleproxy-1:FirstFitRoutingAllocator) Host has enough CPU and RAM available
2013-08-05 21:01:59,987 DEBUG [cloud.capacity.CapacityManagerImpl]
(consoleproxy-1:FirstFitRoutingAllocator) STATS: Can alloc CPU from host: 1,
used: 0, reserved: 0, actual total: 31984, total with overprovisioning: 31984;
requested cpu:500,alloc_from_last_host?:false ,considerReservedCapacity?: true
2013-08-05 21:01:59,987 DEBUG [cloud.capacity.CapacityManagerImpl]
(consoleproxy-1:FirstFitRoutingAllocator) STATS: Can alloc MEM from host: 1,
used: 0, reserved: 0, total: 34312003584; requested mem:
1073741824,alloc_from_last_host?:false ,considerReservedCapacity?: true
2013-08-05 21:01:59,987 DEBUG [allocator.impl.FirstFitAllocator]
(consoleproxy-1:FirstFitRoutingAllocator) Found a suitable host, adding to
list: 1
2013-08-05 21:01:59,987 DEBUG [allocator.impl.FirstFitAllocator]
(consoleproxy-1:FirstFitRoutingAllocator) Host Allocator returning 1 suitable
hosts
2013-08-05 21:01:59,989 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Checking suitable pools for volume (Id, Type): (5505,ROOT)
2013-08-05 21:01:59,989 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) We need to allocate new storagepool for this volume
2013-08-05 21:01:59,989 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Calling StoragePoolAllocators to find suitable pools
2013-08-05 21:01:59,990 DEBUG [storage.allocator.LocalStoragePoolAllocator]
(consoleproxy-1:null) LocalStoragePoolAllocator trying to find storage pool to
fit the vm
2013-08-05 21:01:59,990 DEBUG [storage.allocator.FirstFitStoragePoolAllocator]
(consoleproxy-1:null) Looking for pools in dc: 1 pod:1 cluster:1
2013-08-05 21:01:59,992 DEBUG [storage.allocator.FirstFitStoragePoolAllocator]
(consoleproxy-1:null) FirstFitStoragePoolAllocator has 1 pools to check for
allocation
2013-08-05 21:01:59,992 DEBUG [storage.allocator.AbstractStoragePoolAllocator]
(consoleproxy-1:null) Checking if storage pool is suitable, name: Primary
Storage ,poolId: 201
2013-08-05 21:01:59,992 DEBUG [storage.allocator.AbstractStoragePoolAllocator]
(consoleproxy-1:null) Is localStorageAllocationNeeded? true
2013-08-05 21:01:59,992 DEBUG [storage.allocator.AbstractStoragePoolAllocator]
(consoleproxy-1:null) Is storage pool shared? true
2013-08-05 21:01:59,992 DEBUG [storage.allocator.AbstractStoragePoolAllocator]
(consoleproxy-1:null) StoragePool is not of correct type, skipping this pool
2013-08-05 21:01:59,992 DEBUG [storage.allocator.FirstFitStoragePoolAllocator]
(consoleproxy-1:null) FirstFitStoragePoolAllocator returning 0 suitable storage
pools
2013-08-05 21:01:59,992 DEBUG [storage.allocator.LocalStoragePoolAllocator]
(consoleproxy-1:null) LocalStoragePoolAllocator returning 0 suitable storage
pools
2013-08-05 21:01:59,992 DEBUG [storage.allocator.LocalStoragePoolAllocator]
(consoleproxy-1:null) Unable to find storage pool to fit the vm
2013-08-05 21:01:59,992 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) No suitable pools found for volume:
Vol[5505|vm=5504|ROOT] under cluster: 1
2013-08-05 21:01:59,992 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) No suitable pools found
2013-08-05 21:01:59,992 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) No suitable storagePools found under this Cluster: 1
2013-08-05 21:01:59,992 DEBUG [cloud.deploy.FirstFitPlanner]
(consoleproxy-1:null) Could not find suitable Deployment Destination for this
VM under any clusters, returning.
2013-08-05 21:01:59,995 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Removed nic id=22909
2013-08-05 21:02:00,004 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-08-05 21:02:00,007 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-5504-VM]Scope=interface
com.cloud.dc.DataCenter; id=1
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:734)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:472)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:465)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:627)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1164)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1981)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:173)
at
com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:113)
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(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)
2013-08-05 21:02:00,011 DEBUG [cloud.network.NetworkManagerImpl]
(secstorage-1:null) Removed nic id=22910
2013-08-05 21:02:00,011 DEBUG [cloud.storage.StorageManagerImpl]
(secstorage-1:null) Cleaning storage for vm: 5731
2013-08-05 21:02:00,021 DEBUG [cloud.storage.StorageManagerImpl]
(secstorage-1:null) Expunging Vol[5732|vm=5731|ROOT]
2013-08-05 21:02:00,025 DEBUG [cloud.storage.StorageManagerImpl]
(secstorage-1:null) Marking volume that was never created as destroyed:
Vol[5732|vm=5731|ROOT]
2013-08-05 21:02:00,034 DEBUG [cloud.vm.VirtualMachineManagerImpl]
(secstorage-1:null) Expunged VM[SecondaryStorageVm|s-5731-VM]
2013-08-05 21:02:00,042 INFO
[cloud.secstorage.PremiumSecondaryStorageManagerImpl] (secstorage-1:null)
Primary secondary storage is not even started, wait until next turn
2013-08-05 21:02:00,423 DEBUG
[network.router.VirtualNetworkApplianceManagerImpl]
(RouterStatusMonitor-1:null) Found 0 routers.
2013-08-05 21:02:03,086 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-65:null) Ping from 1
2013-08-05 21:02:11,184 DEBUG [cloud.server.StatsCollector]
(StatsCollector-3:null) StorageCollector is running...
2013-08-05 21:02:11,198 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-68:null) Seq 1-1768161448: Executing request
2013-08-05 21:02:12,079 DEBUG [vmware.resource.VmwareResource]
(DirectAgent-68:10.211.30.203) Datastore summary info, storageId:
4c44bd1b-21ff-3b56-937f-ca8957703f1c, localPath:
/CLDSTACKDC/ESXTEMP01_SAN_DATASTORE01, poolType: VMFS, capacity: 536602476544,
free: 535582212096, used: 1020264448
2013-08-05 21:02:12,080 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-68:null) Seq 1-1768161448: Response Received:
2013-08-05 21:02:12,080 DEBUG [agent.transport.Request] (StatsCollector-3:null)
Seq 1-1768161448: Received: { Ans: , MgmtId: 345051433032, via: 1, Ver: v1,
Flags: 10, { GetStorageStatsAnswer } }
[root@INFSGDCCLDSTACK01 ~]#
-----Original Message-----
From: Sanjay Tripathi [mailto:[email protected]]
Sent: Monday, August 05, 2013 8:34 PM
To: [email protected]
Subject: RE: Unable to start the system VM's
Hi Chitra,
Please provide the management server logs.
--Sanjay
From: Chitra Manjunath [mailto:[email protected]]
Sent: Monday, August 05, 2013 6:45 PM
To: [email protected]
Subject: Unable to start the system VM's
Hi All,
I have below configurations
Cloudstack 4.0.2 on centos 6.3
Vshere 5.1 host
VMFS Primary storage
NFS share Secondary storage
The system VM’s created but not running.
Please anyone help me in resolving this issue.
Thanks & Regards
Chitra.M
**************** CAUTION - Disclaimer *****************
This e-mail contains PRIVILEGED AND CONFIDENTIAL INFORMATION intended solely
for the use of the addressee(s). If you are not the intended recipient, please
notify the sender by e-mail and delete the original message. Further, you are
not
to copy, disclose, or distribute this e-mail or its contents to any other
person and
any such actions are unlawful. This e-mail may contain viruses. Infosys has
taken
every reasonable precaution to minimize this risk, but is not liable for any
damage
you may sustain as a result of any virus in this e-mail. You should carry out
your
own virus checks before opening the e-mail or attachment. Infosys reserves the
right to monitor and review the content of all messages sent to or from this
e-mail
address. Messages sent to or from this e-mail address may be stored on the
Infosys e-mail system.
***INFOSYS******** End of Disclaimer ********INFOSYS***
