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
