Leeno,
You can check the uuids for the objects in xencenter against what is
in the cloudstack database. There is a mismatch there.
this is what xapi tries to say with "Exception
com.xensource.xenapi.Types$UuidInvalid :VDI getByUuid for uuid:
331e6a93-cccf-44ef-98f5-b7ef6c4a8e51 failed due to The uuid you supplied
was invalid."
It is complaining about a vdi but it would be my guess that a cluster
id or something else is the culprit.
good luck
On Mon, Aug 26, 2013 at 8:06 PM, Leeno Jose.P.A <leeno...@gmail.com> wrote:
> 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
