But from XS hosts i can mount primary NFS shares and write to it. But
management-server.log says,
2013-08-26 13:17:06,548 DEBUG [cloud.storage.
StorageManagerImpl] (consoleproxy-1:null) Unable to create volume
Vol[1408|vm=1369|ROOT]
2013-08-26 13:17:06,551 INFO [cloud.vm.VirtualMachineManagerImpl]
(consoleproxy-1:null) Unable to contact resource.
com.cloud.exception.StorageUnavailableException: Resource [StoragePool:210]
is unreachable: Unable to create Vol[1408|vm=1369|ROOT]
at
com.cloud.storage.StorageManagerImpl.prepare(StorageManagerImpl.java:3488)
at
com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:748)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:471)
at
com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:464)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:632)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1166)
Any hints please??
Thanks
Leeno
On Mon, Aug 26, 2013 at 11:11 PM, Leeno Jose.P.A <leeno...@gmail.com> wrote:
> Some more logs,
>
> 2013-08-26 13:17:06,422 DEBUG [cloud.storage.StorageManagerImpl]
> (consoleproxy-1:null) Creating volume: Vol[1408|vm=1369|ROOT]
> 2013-08-26 13:17:06,422 DEBUG [cloud.storage.StorageManagerImpl]
> (consoleproxy-1:null) Trying to create in Pool[210|NetworkFilesystem]
> 2013-08-26 13:17:06,428 DEBUG [cloud.template.TemplateManagerImpl]
> (consoleproxy-1:null) Template 1 has already been downloaded to pool 210
> 2013-08-26 13:17:06,432 DEBUG [agent.transport.Request]
> (consoleproxy-1:null) Seq 47-349962293: Sending { Cmd , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 100111,
> [{"storage.CreateCommand":{"volId":1408,"pool":{"id":210,"uuid":"be695799-ec7e-390b-b600-09ad8f8db048","host":"192.168.10.252","path":"/cstagzb-pds01","port":2049,"type":"NetworkFilesystem"},"diskCharacteristics":{"size":565240320,"tags":[],"type":"ROOT","name":"ROOT-1369","useLocalStorage":false,"recreatable":true,"diskOfferingId":8,"volumeId":1408,"hyperType":"XenServer"},"templateUrl":"331e6a93-cccf-44ef-98f5-b7ef6c4a8e51","wait":0}}]
> }
> 2013-08-26 13:17:06,433 DEBUG [agent.transport.Request]
> (consoleproxy-1:null) Seq 47-349962293: Executing: { Cmd , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 100111,
> [{"storage.CreateCommand":{"volId":1408,"pool":{"id":210,"uuid":"be695799-ec7e-390b-b600-09ad8f8db048","host":"192.168.10.252","path":"/cstagzb-pds01","port":2049,"type":"NetworkFilesystem"},"diskCharacteristics":{"size":565240320,"tags":[],"type":"ROOT","name":"ROOT-1369","useLocalStorage":false,"recreatable":true,"diskOfferingId":8,"volumeId":1408,"hyperType":"XenServer"},"templateUrl":"331e6a93-cccf-44ef-98f5-b7ef6c4a8e51","wait":0}}]
> }
> 2013-08-26 13:17:06,433 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-57:null) Seq 47-349962293: Executing request
> 2013-08-26 13:17:06,519 DEBUG [xen.resource.CitrixResourceBase]
> (DirectAgent-57:null) SR retrieved for be695799-ec7e-390b-b600-09ad8f8db048
> 2013-08-26 13:17:06,530 DEBUG [xen.resource.CitrixResourceBase]
> (DirectAgent-57:null) Checking be695799-ec7e-390b-b600-09ad8f8db048 or SR
> 3e19cca0-08f2-a27b-6e07-5db234ed903c on
> XS[1b4825c9-82d5-434b-afe8-191694a7313e-192.168.10.11]
> 2013-08-26 13:17:06,546 DEBUG [xen.resource.CitrixResourceBase]
> (DirectAgent-57:null) Catch Exception
> com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
> 331e6a93-cccf-44ef-98f5-b7ef6c4a8e51 failed due to The uuid you supplied
> was invalid.
> 2013-08-26 13:17:06,546 WARN [xen.resource.CitrixResourceBase]
> (DirectAgent-57:null) Unable to create volume;
> Pool=Pool[210|192.168.10.252:2049|/cstagzb-pds01]; Disk:
> DskChr[ROOT|565240320|]
> com.cloud.utils.exception.CloudRuntimeException: Catch Exception
> com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
> 331e6a93-cccf-44ef-98f5-b7ef6c4a8e51 failed due to The uuid you supplied
> was invalid.
>
> at
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.getVDIbyUuid(CitrixResourceBase.java:5794)
> at
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.execute(CitrixResourceBase.java:5632)
> at
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.executeRequest(CitrixResourceBase.java:431)
> at
> com.cloud.hypervisor.xen.resource.XenServer56Resource.executeRequest(XenServer56Resource.java:73)
> at
> com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
> 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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
> at
> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
> 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:679)
> Caused by: The uuid you supplied was invalid.
> at com.xensource.xenapi.Types.checkResponse(Types.java:927)
> at com.xensource.xenapi.Connection.dispatch(Connection.java:368)
> at
> com.cloud.hypervisor.xen.resource.XenServerConnectionPool$XenServerConnection.dispatch(XenServerConnectionPool.java:909)
> at com.xensource.xenapi.VDI.getByUuid(VDI.java:326)
> at
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.getVDIbyUuid(CitrixResourceBase.java:5790)
> ... 12 more
> 2013-08-26 13:17:06,547 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-57:null) Seq 47-349962293: Response Received:
> 2013-08-26 13:17:06,548 DEBUG [agent.transport.Request]
> (DirectAgent-57:null) Seq 47-349962293: Processing: { Ans: , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 110,
> [{"storage.CreateAnswer":{"requestTemplateReload":false,"result":false,"details":"Exception:
> com.cloud.utils.exception.CloudRuntimeException\nMessage: Catch Exception
> com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
> 331e6a93-cccf-44ef-98f5-b7ef6c4a8e51 failed due to The uuid you supplied
> was invalid.\nStack: com.cloud.utils.exception.CloudRuntimeException: Catch
> Exception com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
> 331e6a93-cccf-44ef-98f5-b7ef6c4a8e51 failed due to The uuid you supplied
> was invalid.\n\tat
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.getVDIbyUuid(CitrixResourceBase.java:5794)\n\tat
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.execute(CitrixResourceBase.java:5632)\n\tat
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.executeRequest(CitrixResourceBase.java:431)\n\tat
> com.cloud.hypervisor.xen.resource.XenServer56Resource.executeRequest(XenServer56Resource.java:73)\n\tat
> com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)\n\tat
> java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)\n\tat
> java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334)\n\tat
> java.util.concurrent.FutureTask.run(FutureTask.java:166)\n\tat
> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)\n\tat
> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)\n\tat
> java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146)\n\tat
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)\n\tat
> java.lang.Thread.run(Thread.java:679)\nCaused by: The uuid you supplied was
> invalid.\n\tat
> com.xensource.xenapi.Types.checkResponse(Types.java:927)\n\tat
> com.xensource.xenapi.Connection.dispatch(Connection.java:368)\n\tat
> com.cloud.hypervisor.xen.resource.XenServerConnectionPool$XenServerConnection.dispatch(XenServerConnectionPool.java:909)\n\tat
> com.xensource.xenapi.VDI.getByUuid(VDI.java:326)\n\tat
> com.cloud.hypervisor.xen.resource.CitrixResourceBase.getVDIbyUuid(CitrixResourceBase.java:5790)\n\t...
> 12 more\n","wait":0}}] }
> 2013-08-26 13:17:06,548 DEBUG [agent.manager.AgentAttache]
> (DirectAgent-57:null) Seq 47-349962293: No more commands found
> 2013-08-26 13:17:06,548 DEBUG [agent.transport.Request]
> (consoleproxy-1:null) Seq 47-349962293: Received: { Ans: , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 110, { CreateAnswer } }
> 2013-08-26 13:17:06,548 DEBUG [cloud.storage.StorageManagerImpl]
> (consoleproxy-1:null) Unable to create volume Vol[1408|vm=1369|ROOT]
> 2013-08-26 13:17:06,551 INFO [cloud.vm.VirtualMachineManagerImpl]
> (consoleproxy-1:null) Unable to contact resource.
> com.cloud.exception.StorageUnavailableException: Resource
> [StoragePool:210] is unreachable: Unable to create Vol[1408|vm=1369|ROOT]
> at
> com.cloud.storage.StorageManagerImpl.prepare(StorageManagerImpl.java:3488)
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:748)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:471)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:464)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:632)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1166)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1989)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:175)
> at
> com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:111)
> at
> com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:33)
> at
> com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:81)
> at
> com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:72)
> 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:1146)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:679)
> 2013-08-26 13:17:06,554 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (consoleproxy-1:null) Cleaning up resources for the vm
> VM[ConsoleProxy|v-1369-VM] in Starting state
> 2013-08-26 13:17:06,556 DEBUG [agent.transport.Request]
> (consoleproxy-1:null) Seq 47-349962294: Sending { Cmd , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 100111,
> [{"StopCommand":{"isProxy":false,"vmName":"v-1369-VM","wait":0}}] }
> 2013-08-26 13:17:06,556 DEBUG [agent.transport.Request]
> (consoleproxy-1:null) Seq 47-349962294: Executing: { Cmd , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 100111,
> [{"StopCommand":{"isProxy":false,"vmName":"v-1369-VM","wait":0}}] }
> 2013-08-26 13:17:06,556 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-10:null) Seq 47-349962294: Executing request
> 2013-08-26 13:17:06,577 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl] (RouterMonitor-1:null)
> Found 0 running routers.
> 2013-08-26 13:17:06,581 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 routers to update status.
> 2013-08-26 13:17:06,582 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
> 2013-08-26 13:17:06,603 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl] (RouterMonitor-1:null)
> Found 0 running routers.
> 2013-08-26 13:17:06,603 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 routers to update status.
> 2013-08-26 13:17:06,604 DEBUG
> [network.router.VirtualNetworkApplianceManagerImpl]
> (RouterStatusMonitor-1:null) Found 0 networks to update RvR status.
> 2013-08-26 13:17:06,636 INFO [xen.resource.CitrixResourceBase]
> (DirectAgent-10:null) VM does not exist on
> XenServer1b4825c9-82d5-434b-afe8-191694a7313e
> 2013-08-26 13:17:06,636 DEBUG [agent.manager.DirectAgentAttache]
> (DirectAgent-10:null) Seq 47-349962294: Response Received:
> 2013-08-26 13:17:06,636 DEBUG [agent.transport.Request]
> (DirectAgent-10:null) Seq 47-349962294: Processing: { Ans: , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 110,
> [{"StopAnswer":{"vncPort":0,"result":true,"details":"VM does not
> exist","wait":0}}] }
> 2013-08-26 13:17:06,636 DEBUG [agent.transport.Request]
> (consoleproxy-1:null) Seq 47-349962294: Received: { Ans: , MgmtId:
> 81375086018793, via: 47, Ver: v1, Flags: 110, { StopAnswer } }
> 2013-08-26 13:17:06,642 DEBUG [agent.manager.AgentAttache]
> (DirectAgent-10:null) Seq 47-349962294: No more commands found
> 2013-08-26 13:17:06,649 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking VirtualRouter to release
> Nic[4907-1369-24c1a86f-d807-42a3-9960-ad156773613c-192.168.1.157]
> 2013-08-26 13:17:06,649 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking Ovs to release
> Nic[4907-1369-24c1a86f-d807-42a3-9960-ad156773613c-192.168.1.157]
> 2013-08-26 13:17:06,649 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking SecurityGroupProvider to release
> Nic[4907-1369-24c1a86f-d807-42a3-9960-ad156773613c-192.168.1.157]
> 2013-08-26 13:17:06,649 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking VpcVirtualRouter to release
> Nic[4907-1369-24c1a86f-d807-42a3-9960-ad156773613c-192.168.1.157]
> 2013-08-26 13:17:06,649 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking NiciraNvp to release
> Nic[4907-1369-24c1a86f-d807-42a3-9960-ad156773613c-192.168.1.157]
> 2013-08-26 13:17:06,649 DEBUG [network.element.NiciraNvpElement]
> (consoleproxy-1:null) Checking if NiciraNvpElement can handle service
> Connectivity on network guestNetworkForBasicZone
> 2013-08-26 13:17:06,652 DEBUG [network.guru.ControlNetworkGuru]
> (consoleproxy-1:null) Released nic: NicProfile[4908-1369-null-null-null
> 2013-08-26 13:17:06,665 DEBUG
> [cloud.network.ExternalLoadBalancerUsageManagerImpl]
> (ExternalNetworkMonitor-1:null) External devices stats collector is
> running...
> 2013-08-26 13:17:06,666 DEBUG [storage.snapshot.SnapshotSchedulerImpl]
> (SnapshotPollTask:null) Snapshot scheduler.poll is being called at
> 2013-08-26 17:17:06 GMT
> 2013-08-26 13:17:06,668 DEBUG [storage.snapshot.SnapshotSchedulerImpl]
> (SnapshotPollTask:null) Got 0 snapshots to be executed at 2013-08-26
> 17:17:06 GMT
> 2013-08-26 13:17:06,677 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking VirtualRouter to release
> Nic[4908-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,677 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking Ovs to release
> Nic[4908-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,677 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking SecurityGroupProvider to release
> Nic[4908-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,677 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking VpcVirtualRouter to release
> Nic[4908-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,677 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking NiciraNvp to release
> Nic[4908-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,677 DEBUG [network.element.NiciraNvpElement]
> (consoleproxy-1:null) Checking if NiciraNvpElement can handle service
> Connectivity on network null
> 2013-08-26 13:17:06,680 DEBUG [dc.dao.DataCenterIpAddressDaoImpl]
> (consoleproxy-1:null) Releasing ip address for
> reservationId=24c1a86f-d807-42a3-9960-ad156773613c, instance=4909
> 2013-08-26 13:17:06,681 DEBUG [network.guru.PodBasedNetworkGuru]
> (consoleproxy-1:null) Released nic: NicProfile[4909-1369-null-null-null
> 2013-08-26 13:17:06,683 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking VirtualRouter to release
> Nic[4909-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,683 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking Ovs to release
> Nic[4909-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,683 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking SecurityGroupProvider to release
> Nic[4909-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,683 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking VpcVirtualRouter to release
> Nic[4909-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,683 DEBUG [cloud.network.NetworkManagerImpl]
> (consoleproxy-1:null) Asking NiciraNvp to release
> Nic[4909-1369-24c1a86f-d807-42a3-9960-ad156773613c-null]
> 2013-08-26 13:17:06,684 DEBUG [network.element.NiciraNvpElement]
> (consoleproxy-1:null) Checking if NiciraNvpElement can handle service
> Connectivity on network null
> 2013-08-26 13:17:06,684 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (consoleproxy-1:null) Successfully released network resources for the vm
> VM[ConsoleProxy|v-1369-VM]
> 2013-08-26 13:17:06,684 DEBUG [cloud.vm.VirtualMachineManagerImpl]
> (consoleproxy-1:null) Successfully cleanued up resources for the vm
> VM[ConsoleProxy|v-1369-VM] in Starting state
> 2013-08-26 13:17:06,686 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) DeploymentPlanner allocation algorithm: random
> 2013-08-26 13:17:06,686 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) Trying to allocate a host and storage pools from
> dc:9, pod:9,cluster:null, requested cpu: 500, requested ram: 1073741824
> 2013-08-26 13:17:06,686 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) Is ROOT volume READY (pool already allocated)?: No
> 2013-08-26 13:17:06,686 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) Searching resources only under specified Pod: 9
> 2013-08-26 13:17:06,687 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: 9
> 2013-08-26 13:17:06,688 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) CPUOverprovisioningFactor considered: 2.0
> 2013-08-26 13:17:06,695 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) Checking resources in Cluster: 10 under Pod: 9
> 2013-08-26 13:17:06,695 DEBUG [allocator.impl.FirstFitAllocator]
> (consoleproxy-1:FirstFitRoutingAllocator) Looking for hosts in dc: 9
> pod:9 cluster:10
> 2013-08-26 13:17:06,696 DEBUG [allocator.impl.FirstFitAllocator]
> (consoleproxy-1:FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to
> check for allocation: [Host[-47-Routing]]
> 2013-08-26 13:17:06,699 DEBUG [allocator.impl.FirstFitAllocator]
> (consoleproxy-1:FirstFitRoutingAllocator) Found 1 hosts for allocation
> after prioritization: [Host[-47-Routing]]
> 2013-08-26 13:17:06,699 DEBUG [allocator.impl.FirstFitAllocator]
> (consoleproxy-1:FirstFitRoutingAllocator) Looking for speed=500Mhz, Ram=1024
> 2013-08-26 13:17:06,699 DEBUG [allocator.impl.FirstFitAllocator]
> (consoleproxy-1:FirstFitRoutingAllocator) Host name:
> cstagZA-XCA-HV02.cloud.net, hostId: 47 is in avoid set, skipping this and
> trying other available hosts
> 2013-08-26 13:17:06,699 DEBUG [allocator.impl.FirstFitAllocator]
> (consoleproxy-1:FirstFitRoutingAllocator) Host Allocator returning 0
> suitable hosts
> 2013-08-26 13:17:06,699 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) No suitable hosts found
> 2013-08-26 13:17:06,699 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) No suitable hosts found under this Cluster: 10
> 2013-08-26 13:17:06,699 DEBUG [cloud.deploy.FirstFitPlanner]
> (consoleproxy-1:null) Could not find suitable Deployment Destination for
> this VM under any clusters, returning.
> 2013-08-26 13:17:06,724 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: 47
> 2013-08-26 13:17:06,729 DEBUG [cloud.capacity.CapacityManagerImpl]
> (consoleproxy-1:null) Hosts's actual total CPU: 20000 and CPU after
> applying overprovisioning: 40000
> 2013-08-26 13:17:06,729 DEBUG [cloud.capacity.CapacityManagerImpl]
> (consoleproxy-1:null) release cpu from host: 47, old used: 500,reserved: 0,
> actual total: 20000, total with overprovisioning: 40000; new used:
> 0,reserved:0; movedfromreserved: false,moveToReserveredfalse
> 2013-08-26 13:17:06,729 DEBUG [cloud.capacity.CapacityManagerImpl]
> (consoleproxy-1:null) release mem from host: 47, old used:
> 1073741824,reserved: 0, total: 9987731712; new used: 0,reserved:0;
> movedfromreserved: false,moveToReserveredfalse
> 2013-08-26 13:17:06,731 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-1369-VM]Scope=interface
> com.cloud.dc.DataCenter; id=9
> at
> com.cloud.vm.VirtualMachineManagerImpl.advanceStart(VirtualMachineManagerImpl.java:728)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:471)
> at
> com.cloud.vm.VirtualMachineManagerImpl.start(VirtualMachineManagerImpl.java:464)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.startProxy(ConsoleProxyManagerImpl.java:632)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.allocCapacity(ConsoleProxyManagerImpl.java:1166)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:1989)
> at
> com.cloud.consoleproxy.ConsoleProxyManagerImpl.expandPool(ConsoleProxyManagerImpl.java:175)
> at
> com.cloud.vm.SystemVmLoadScanner.loadScan(SystemVmLoadScanner.java:111)
> at
> com.cloud.vm.SystemVmLoadScanner.access$100(SystemVmLoadScanner.java:33)
> at
> com.cloud.vm.SystemVmLoadScanner$1.reallyRun(SystemVmLoadScanner.java:81)
> at
> com.cloud.vm.SystemVmLoadScanner$1.run(SystemVmLoadScanner.java:72)
> 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:1146)
> at
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
> at java.lang.Thread.run(Thread.java:679)
>
>
>
>
> Please help!
>
> Thanks
> Leeno
>
>
> On Mon, Aug 26, 2013 at 9:49 PM, Leeno Jose.P.A <leeno...@gmail.com>wrote:
>
>> Hi Users,
>>
>> I am getting below error on launching new VMs.
>>
>>
>> 2013-08-26 12:17:08,744 DEBUG [agent.manager.DirectAgentAttache]
>> (DirectAgent-134:null) Seq 47-1536688603: Executing request
>> 2013-08-26 12:17:08,823 DEBUG [xen.resource.CitrixResourceBase]
>> (DirectAgent-134:null) SR retrieved for be695799-ec7e-390b-b600-09ad8f8db048
>> 2013-08-26 12:17:08,834 DEBUG [xen.resource.CitrixResourceBase]
>> (DirectAgent-134:null) Checking be695799-ec7e-390b-b600-09ad8f8db048 or SR
>> 3e19cca0-08f2-a27b-6e07-5db234ed903c on XS[1b4825c9-82d5-4
>> 34b-afe8-191694a7313e-192.168.10.11]
>> 2013-08-26 12:17:08,850 DEBUG [xen.resource.CitrixResourceBase]
>> (DirectAgent-134:null) Catch Exception
>> com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
>> 331e6a93-cccf-44ef-98f5-b7ef6c
>> 4a8e51 failed due to The uuid you supplied was invalid.
>> 2013-08-26 12:17:08,850 WARN [xen.resource.CitrixResourceBase]
>> (DirectAgent-134:null) Unable to create volume;
>> Pool=Pool[210|192.168.10.252:2049|/cstagzb-pds01]; Disk:
>> DskChr[ROOT|565240320|]
>> com.cloud.utils.exception.CloudRuntimeException: Catch Exception
>> com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
>> 331e6a93-cccf-44ef-98f5-b7ef6c4a8e51 failed due to The uuid you supp
>> lied was invalid.
>> at
>> com.cloud.hypervisor.xen.resource.CitrixResourceBase.getVDIbyUuid(CitrixResourceBase.java:5794)
>> at
>> com.cloud.hypervisor.xen.resource.CitrixResourceBase.execute(CitrixResourceBase.java:5632)
>> at
>> com.cloud.hypervisor.xen.resource.CitrixResourceBase.executeRequest(CitrixResourceBase.java:431)
>> at
>> com.cloud.hypervisor.xen.resource.XenServer56Resource.executeRequest(XenServer56Resource.java:73)
>> at
>> com.cloud.agent.manager.DirectAgentAttache$Task.run(DirectAgentAttache.java:186)
>> 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.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:165)
>> at
>> java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:266)
>> 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:679)
>> Caused by: The uuid you supplied was invalid.
>> at com.xensource.xenapi.Types.checkResponse(Types.java:927)
>> at com.xensource.xenapi.Connection.dispatch(Connection.java:368)
>> at
>> com.cloud.hypervisor.xen.resource.XenServerConnectionPool$XenServerConnection.dispatch(XenServerConnectionPool.java:909)
>> at com.xensource.xenapi.VDI.getByUuid(VDI.java:326)
>> at
>> com.cloud.hypervisor.xen.resource.CitrixResourceBase.getVDIbyUuid(CitrixResourceBase.java:5790)
>> ... 12 more
>>
>>
>> --
>> Leeno Jose .P.A
>>
>
>
>
> --
> Leeno Jose .P.A
>
--
Leeno Jose .P.A
