Return-Path: X-Original-To: apmail-cloudstack-dev-archive@www.apache.org Delivered-To: apmail-cloudstack-dev-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id D58AC1104D for ; Wed, 6 Aug 2014 19:21:06 +0000 (UTC) Received: (qmail 23686 invoked by uid 500); 6 Aug 2014 19:21:06 -0000 Delivered-To: apmail-cloudstack-dev-archive@cloudstack.apache.org Received: (qmail 23636 invoked by uid 500); 6 Aug 2014 19:21:06 -0000 Mailing-List: contact dev-help@cloudstack.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@cloudstack.apache.org Delivered-To: mailing list dev@cloudstack.apache.org Received: (qmail 23624 invoked by uid 99); 6 Aug 2014 19:21:06 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 06 Aug 2014 19:21:05 +0000 X-ASF-Spam-Status: No, hits=-0.7 required=5.0 tests=RCVD_IN_DNSWL_LOW,SPF_PASS X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: domain of kuangching.wang@gmail.com designates 209.85.192.171 as permitted sender) Received: from [209.85.192.171] (HELO mail-pd0-f171.google.com) (209.85.192.171) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 06 Aug 2014 19:21:00 +0000 Received: by mail-pd0-f171.google.com with SMTP id z10so3814177pdj.30 for ; Wed, 06 Aug 2014 12:20:40 -0700 (PDT) DKIM-Signature: v=1; a=rsa-sha256; c=relaxed/relaxed; d=gmail.com; s=20120113; h=content-type:mime-version:subject:from:in-reply-to:date :content-transfer-encoding:message-id:references:to; bh=+/1TL9Z+FAEafOos4uM5+41YzUFAVfXrM2/ym7imsKI=; b=nlSdK8ySzgpEZ+tKNkyL2e059uV1MWzz2aVliB9VD4CHLYcXoncbZXAmoVBtl7Fl4Y eVzATntt5/slPzU9s5V7qjErCp4n2BTee3bsMPCb2uj5t+Hl5jDHZ3Ffh32QVXd//GxV vIN1Xf5Ah5uHFADyD4suE6HVnP4NyLNFcDR6/UDn4fnoQv/vfDJTi33+B4zJpoKtnuEc zMO77X88k2DA5ZQUCn0wWwvZJ0mjIK20fu5ro927/oq5pvYkEzbewkS+67jH1XafExya R6CXiGAgTXm5AmcrNdLJ3ik2521ZASMYhou/a70n+oh1Vohs5Yh3jFuGur9MwuZpZD4I BAMg== X-Received: by 10.70.103.204 with SMTP id fy12mr13077207pdb.144.1407352840441; Wed, 06 Aug 2014 12:20:40 -0700 (PDT) Received: from [10.1.2.92] ([173.227.38.50]) by mx.google.com with ESMTPSA id v17sm2966782pdj.11.2014.08.06.12.20.38 for (version=TLSv1 cipher=ECDHE-RSA-RC4-SHA bits=128/128); Wed, 06 Aug 2014 12:20:39 -0700 (PDT) Content-Type: text/plain; charset=windows-1252 Mime-Version: 1.0 (Mac OS X Mail 7.2 \(1874\)) Subject: Re: Getting "Refusing to design this network, the physical isolation type is not MIDO" while deploying a VM with new network from UI From: Kuang-Ching Wang In-Reply-To: <79639FB0AD38DB4797D4AD9D722E36A6500EE961@SINPEX01CL02.citrite.net> Date: Wed, 6 Aug 2014 12:20:37 -0700 Content-Transfer-Encoding: quoted-printable Message-Id: References: <79639FB0AD38DB4797D4AD9D722E36A6500EE961@SINPEX01CL02.citrite.net> To: "dev@cloudstack.apache.org" X-Mailer: Apple Mail (2.1874) X-Virus-Checked: Checked by ClamAV on apache.org Since you turned in DEBUG logging, the =93Refusing to design=94 messages = are normally expected. The code steps through all registered network = gurus, and only those with the right type you requested will design the = network. All others will produce the =93refusing=94 statement. KC On Aug 6, 2014, at 11:36 AM, Abhinav Roy wrote: > Hi, >=20 >=20 > I am getting this error while deploying a VM on XENSERVER : >=20 > 2014-08-06 21:42:22,774 DEBUG [c.c.a.ApiServlet] = (catalina-exec-2:ctx-6c894fdd) =3D=3D=3DSTART=3D=3D=3D 10.144.7.6 -- = GET = command=3DcreateNetwork&response=3Djson&sessionkey=3DIyiV1YiWuFVSGa7GynZv5= T12nLk%3D&networkOfferingId=3D94cef53e-49ec-4a9f-a0fc-f82f0e40aba5&name=3D= test&displayText=3Dtest&zoneId=3D29d069ac-e1ea-45dc-8c35-dd5b6c628ce2&_=3D= 1407340991296 > 2014-08-06 21:42:22,798 DEBUG [o.a.c.a.BaseCmd] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Ignoring paremeter = displaynetwork as the caller is not authorized to pass it in > 2014-08-06 21:42:22,803 DEBUG [o.a.c.a.BaseCmd] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Ignoring paremeter = displaynetwork as the caller is not authorized to pass it in > 2014-08-06 21:42:22,872 DEBUG [o.a.c.n.c.m.ContrailGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network > 2014-08-06 21:42:22,873 DEBUG [c.c.n.g.MidoNetGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) design called > 2014-08-06 21:42:22,875 DEBUG [c.c.n.g.MidoNetGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network, the physical isolation type is not MIDO > 2014-08-06 21:42:22,877 DEBUG [c.c.n.g.NiciraNvpGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network > 2014-08-06 21:42:22,879 DEBUG [o.a.c.n.o.OpendaylightGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network > 2014-08-06 21:42:22,881 DEBUG [c.c.n.g.OvsGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network > 2014-08-06 21:42:22,915 DEBUG [o.a.c.n.g.SspGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) SSP not configured to be = active > 2014-08-06 21:42:22,917 DEBUG [c.c.n.g.BrocadeVcsGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network > 2014-08-06 21:42:22,919 DEBUG [c.c.n.g.NuageVspGuestNetworkGuru] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Refusing to design this = network > 2014-08-06 21:42:22,920 DEBUG [o.a.c.e.o.NetworkOrchestrator] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) Releasing lock for = Acct[6ee1e382-fe5b-4571-a9cb-a8a7cb85665d-test] > 2014-08-06 21:42:22,967 DEBUG [c.c.a.ApiServlet] = (catalina-exec-2:ctx-6c894fdd ctx-99f95792) =3D=3D=3DEND=3D=3D=3D = 10.144.7.6 -- GET = command=3DcreateNetwork&response=3Djson&sessionkey=3DIyiV1YiWuFVSGa7GynZv5= T12nLk%3D&networkOfferingId=3D94cef53e-49ec-4a9f-a0fc-f82f0e40aba5&name=3D= test&displayText=3Dtest&zoneId=3D29d069ac-e1ea-45dc-8c35-dd5b6c628ce2&_=3D= 1407340991296 > 2014-08-06 21:42:23,018 DEBUG [c.c.a.ApiServlet] = (catalina-exec-25:ctx-e2a0589a) =3D=3D=3DSTART=3D=3D=3D 10.144.7.6 -- = GET = command=3DdeployVirtualMachine&response=3Djson&sessionkey=3DIyiV1YiWuFVSGa= 7GynZv5T12nLk%3D&zoneid=3D29d069ac-e1ea-45dc-8c35-dd5b6c628ce2&templateid=3D= 991edabc-9662-4244-ad92-85f732a9f024&hypervisor=3DXenServer&serviceofferin= gid=3Dd4206400-e06a-4c58-bdf1-97df6bf06592&iptonetworklist%5B0%5D.networki= d=3D190a586d-833e-4ff8-ba0c-6c5ce7bbfd2e&_=3D1407340991465 > 2014-08-06 21:42:23,043 DEBUG [o.a.c.a.BaseCmd] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Ignoring paremeter = displayvm as the caller is not authorized to pass it in > 2014-08-06 21:42:23,043 DEBUG [o.a.c.a.BaseCmd] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Ignoring paremeter = deploymentplanner as the caller is not authorized to pass it in > 2014-08-06 21:42:23,069 DEBUG [o.a.c.a.BaseCmd] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Ignoring paremeter = displayvm as the caller is not authorized to pass it in > 2014-08-06 21:42:23,069 DEBUG [o.a.c.a.BaseCmd] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Ignoring paremeter = deploymentplanner as the caller is not authorized to pass it in > 2014-08-06 21:42:23,190 DEBUG [c.c.n.NetworkModelImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Service SecurityGroup is = not supported in the network id=3D222 > 2014-08-06 21:42:23,207 DEBUG [c.c.v.UserVmManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Allocating in the DB for vm > 2014-08-06 21:42:23,225 DEBUG [c.c.v.VirtualMachineManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Allocating entries for VM: = VM[User|i-41-64-VM] > 2014-08-06 21:42:23,228 DEBUG [c.c.v.VirtualMachineManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Allocating nics for = VM[User|i-41-64-VM] > 2014-08-06 21:42:23,229 DEBUG [o.a.c.e.o.NetworkOrchestrator] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Allocating nic for vm = VM[User|i-41-64-VM] in network Ntwk[222|Guest|8] with requested profile = NicProfile[0-0-null-null-null > 2014-08-06 21:42:23,256 DEBUG [c.c.n.NetworkModelImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Service SecurityGroup is = not supported in the network id=3D222 > 2014-08-06 21:42:23,258 DEBUG [c.c.v.VirtualMachineManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Allocating disks for = VM[User|i-41-64-VM] > 2014-08-06 21:42:23,274 DEBUG [c.c.v.VirtualMachineManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Allocation completed for = VM: VM[User|i-41-64-VM] > 2014-08-06 21:42:23,274 DEBUG [c.c.v.UserVmManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Successfully allocated DB = entry for VM[User|i-41-64-VM] > 2014-08-06 21:42:23,304 DEBUG [c.c.n.NetworkModelImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Service SecurityGroup is = not supported in the network id=3D222 > 2014-08-06 21:42:23,309 DEBUG [c.c.n.NetworkModelImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) Service SecurityGroup is = not supported in the network id=3D222 > 2014-08-06 21:42:23,347 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) submit async job-420, = details: AsyncJobVO {id:420, userId: 41, accountId: 41, instanceType: = VirtualMachine, instanceId: 64, cmd: = org.apache.cloudstack.api.command.user.vm.DeployVMCmd, cmdInfo: = {"serviceofferingid":"d4206400-e06a-4c58-bdf1-97df6bf06592","sessionkey":"= IyiV1YiWuFVSGa7GynZv5T12nLk\u003d","cmdEventType":"VM.CREATE","ctxUserId":= "41","zoneid":"29d069ac-e1ea-45dc-8c35-dd5b6c628ce2","httpmethod":"GET","t= emplateid":"991edabc-9662-4244-ad92-85f732a9f024","response":"json","id":"= 64","ctxDetails":"{\"com.cloud.template.VirtualMachineTemplate\":\"991edab= c-9662-4244-ad92-85f732a9f024\",\"com.cloud.vm.VirtualMachine\":\"1ad7627d= -b4da-4501-83a1-e648bd9fd7e6\",\"com.cloud.dc.DataCenter\":\"29d069ac-e1ea= -45dc-8c35-dd5b6c628ce2\",\"com.cloud.offering.ServiceOffering\":\"d420640= 0-e06a-4c58-bdf1-97df6bf06592\"}","hypervisor":"XenServer","iptonetworklis= t[0].networkid":"190a586d-833e-4ff8-ba0c-6c5ce7bbfd2e","_":"1407340991465"= ,"uuid":"1ad7627d-b4da-4501-83a1-e648bd9fd7e6","ctxAccountId":"41","ctxSta= rtEventId":"884"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, = resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: = null, lastUpdated: null, lastPolled: null, created: null} > 2014-08-06 21:42:23,348 DEBUG [c.c.a.ApiServlet] = (catalina-exec-25:ctx-e2a0589a ctx-7a1d3c27) =3D=3D=3DEND=3D=3D=3D = 10.144.7.6 -- GET = command=3DdeployVirtualMachine&response=3Djson&sessionkey=3DIyiV1YiWuFVSGa= 7GynZv5T12nLk%3D&zoneid=3D29d069ac-e1ea-45dc-8c35-dd5b6c628ce2&templateid=3D= 991edabc-9662-4244-ad92-85f732a9f024&hypervisor=3DXenServer&serviceofferin= gid=3Dd4206400-e06a-4c58-bdf1-97df6bf06592&iptonetworklist%5B0%5D.networki= d=3D190a586d-833e-4ff8-ba0c-6c5ce7bbfd2e&_=3D1407340991465 > 2014-08-06 21:42:23,350 INFO [o.a.c.f.j.i.AsyncJobMonitor] = (API-Job-Executor-2:ctx-e92d4da4 job-420) Add job-420 into job = monitoring > 2014-08-06 21:42:23,351 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420) Executing AsyncJobVO {id:420, = userId: 41, accountId: 41, instanceType: VirtualMachine, instanceId: 64, = cmd: org.apache.cloudstack.api.command.user.vm.DeployVMCmd, cmdInfo: = {"serviceofferingid":"d4206400-e06a-4c58-bdf1-97df6bf06592","sessionkey":"= IyiV1YiWuFVSGa7GynZv5T12nLk\u003d","cmdEventType":"VM.CREATE","ctxUserId":= "41","zoneid":"29d069ac-e1ea-45dc-8c35-dd5b6c628ce2","httpmethod":"GET","t= emplateid":"991edabc-9662-4244-ad92-85f732a9f024","response":"json","id":"= 64","ctxDetails":"{\"com.cloud.template.VirtualMachineTemplate\":\"991edab= c-9662-4244-ad92-85f732a9f024\",\"com.cloud.vm.VirtualMachine\":\"1ad7627d= -b4da-4501-83a1-e648bd9fd7e6\",\"com.cloud.dc.DataCenter\":\"29d069ac-e1ea= -45dc-8c35-dd5b6c628ce2\",\"com.cloud.offering.ServiceOffering\":\"d420640= 0-e06a-4c58-bdf1-97df6bf06592\"}","hypervisor":"XenServer","iptonetworklis= t[0].networkid":"190a586d-833e-4ff8-ba0c-6c5ce7bbfd2e","_":"1407340991465"= ,"uuid":"1ad7627d-b4da-4501-83a1-e648bd9fd7e6","ctxAccountId":"41","ctxSta= rtEventId":"884"}, cmdVersion: 0, status: IN_PROGRESS, processStatus: 0, = resultCode: 0, result: null, initMsid: 213737702773493, completeMsid: = null, lastUpdated: null, lastPolled: null, created: null} > 2014-08-06 21:42:23,363 DEBUG [o.a.c.a.BaseCmd] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Ignoring = paremeter displayvm as the caller is not authorized to pass it in > 2014-08-06 21:42:23,363 DEBUG [o.a.c.a.BaseCmd] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Ignoring = paremeter deploymentplanner as the caller is not authorized to pass it = in > 2014-08-06 21:42:23,393 DEBUG [o.a.c.a.BaseCmd] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Ignoring = paremeter displayvm as the caller is not authorized to pass it in > 2014-08-06 21:42:23,393 DEBUG [o.a.c.a.BaseCmd] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Ignoring = paremeter deploymentplanner as the caller is not authorized to pass it = in > 2014-08-06 21:42:23,430 DEBUG [c.c.n.NetworkModelImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Service = SecurityGroup is not supported in the network id=3D222 > 2014-08-06 21:42:23,435 DEBUG [c.c.n.NetworkModelImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Service = SecurityGroup is not supported in the network id=3D222 > 2014-08-06 21:42:23,456 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Deploy avoids = pods: [], clusters: [], hosts: [] > 2014-08-06 21:42:23,457 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) DeploymentPlanner = allocation algorithm: com.cloud.deploy.FirstFitPlanner@1186306 > 2014-08-06 21:42:23,458 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Trying to = allocate a host and storage pools from dc:1, pod:null,cluster:null, = requested cpu: 3200, requested ram: 3221225472 > 2014-08-06 21:42:23,458 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Is ROOT volume = READY (pool already allocated)?: No > 2014-08-06 21:42:23,458 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Searching all = possible resources under this Zone: 1 > 2014-08-06 21:42:23,461 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Listing clusters = in order of aggregate capacity, that have (atleast one host with) enough = CPU and RAM capacity under this Zone: 1 > 2014-08-06 21:42:23,465 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Removing from the = clusterId list these clusters from avoid set: [] > 2014-08-06 21:42:23,476 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Checking = resources in Cluster: 1 under Pod: 1 > 2014-08-06 21:42:23,477 DEBUG [c.c.a.m.a.i.FirstFitAllocator] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) Looking for hosts in dc: 1 pod:1 cluster:1 > 2014-08-06 21:42:23,481 DEBUG [c.c.a.m.a.i.FirstFitAllocator] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) FirstFitAllocator has 1 hosts to check for = allocation: [Host[-1-Routing]] > 2014-08-06 21:42:23,486 DEBUG [c.c.a.m.a.i.FirstFitAllocator] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) Found 1 hosts for allocation after = prioritization: [Host[-1-Routing]] > 2014-08-06 21:42:23,486 DEBUG [c.c.a.m.a.i.FirstFitAllocator] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) Looking for speed=3D3200Mhz, Ram=3D3072 > 2014-08-06 21:42:23,493 DEBUG [c.c.r.ResourceManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) Host ID: 1 does not have GPU device available > 2014-08-06 21:42:23,493 INFO [c.c.a.m.a.i.FirstFitAllocator] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) Host name: cldstk-R720-10, hostId: 1 does not = have required GPU devices available > 2014-08-06 21:42:23,493 DEBUG [c.c.a.m.a.i.FirstFitAllocator] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9 = FirstFitRoutingAllocator) Host Allocator returning 0 suitable hosts > 2014-08-06 21:42:23,493 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) No suitable hosts = found > 2014-08-06 21:42:23,493 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) No suitable hosts = found under this Cluster: 1 > 2014-08-06 21:42:23,496 DEBUG [c.c.d.DeploymentPlanningManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Could not find = suitable Deployment Destination for this VM under any clusters, = returning. > 2014-08-06 21:42:23,496 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Searching all = possible resources under this Zone: 1 > 2014-08-06 21:42:23,497 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Listing clusters = in order of aggregate capacity, that have (atleast one host with) enough = CPU and RAM capacity under this Zone: 1 > 2014-08-06 21:42:23,501 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Removing from the = clusterId list these clusters from avoid set: [1] > 2014-08-06 21:42:23,506 DEBUG [c.c.d.FirstFitPlanner] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) No clusters found = after removing disabled clusters and clusters in avoid list, returning. > 2014-08-06 21:42:23,510 DEBUG [c.c.v.UserVmManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Destroying vm = VM[User|i-41-64-VM] as it failed to create on Host with Id:null > 2014-08-06 21:42:23,538 DEBUG [c.c.c.CapacityManagerImpl] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) VM state = transitted from :Stopped to Error with event: OperationFailedToErrorvm's = original host id: null new host id: null host id before state = transition: null > 2014-08-06 21:42:23,562 WARN [o.a.c.alerts] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) alertType:: 8 // = dataCenterId:: 1 // podId:: null // clusterId:: null // message:: Failed = to deploy Vm with Id: 64, on Host with Id: null > 2014-08-06 21:42:23,621 INFO [o.a.c.a.c.u.v.DeployVMCmd] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) = com.cloud.exception.InsufficientServerCapacityException: Unable to = create a deployment for VM[User|i-41-64-VM]Scope=3Dinterface = com.cloud.dc.DataCenter; id=3D1 > 2014-08-06 21:42:23,622 INFO [o.a.c.a.c.u.v.DeployVMCmd] = (API-Job-Executor-2:ctx-e92d4da4 job-420 ctx-8546dbd9) Unable to create = a deployment for VM[User|i-41-64-VM] > com.cloud.exception.InsufficientServerCapacityException: Unable to = create a deployment for VM[User|i-41-64-VM]Scope=3Dinterface = com.cloud.dc.DataCenter; id=3D1 > at = org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.reserveV= irtualMachine(VMEntityManagerImpl.java:214) > at = org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.res= erve(VirtualMachineEntityImpl.java:200) > at = com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:= 3510) > at = com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:= 3161) > at = com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:= 3149) > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) > at = sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:= 57) > at = sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorIm= pl.java:43) > at java.lang.reflect.Method.invoke(Method.java:601) > at = org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(Ao= pUtils.java:317) > at = org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoi= nt(ReflectiveMethodInvocation.java:183) > at = org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Refle= ctiveMethodInvocation.java:150) > at = org.apache.cloudstack.network.contrail.management.EventUtils$EventIntercep= tor.invoke(EventUtils.java:106) > at = org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Refle= ctiveMethodInvocation.java:161) > at = com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:= 51) > at = org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Refle= ctiveMethodInvocation.java:161) > at = org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(Exp= oseInvocationInterceptor.java:91) > at = org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Refle= ctiveMethodInvocation.java:172) > at = org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopP= roxy.java:204) > at $Proxy211.startVirtualMachine(Unknown Source) > at = org.apache.cloudstack.api.command.user.vm.DeployVMCmd.execute(DeployVMCmd.= java:450) > at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:141) > at = com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:108)= > at = org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInConte= xt(AsyncJobManagerImpl.java:503) > at = org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(Managed= ContextRunnable.java:49) > at = org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(De= faultManagedContext.java:56) > at = org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithC= ontext(DefaultManagedContext.java:103) > at = org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithCo= ntext(DefaultManagedContext.java:53) > at = org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedCo= ntextRunnable.java:46) > at = org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJ= obManagerImpl.java:460) > 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.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:= 1110) > at = java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java= :603) > at java.lang.Thread.run(Thread.java:722) >=20 > Has anyone seen this before and knows the solution? >=20 > Thanks and regards, > Abhinav