Hi,

 

I can't create new instances anymore on my ACS 4.9 on XEN, with basic
networking.

Last Thursday, this was possible without any issues.

 

Since then, I have tested 2 things:

-          Creating domains and accounts

-          Adding SSH auth to one VM I had created with an ISO

(So, no real issues, I'd assume)

 

However, after I destroyed the one VM mentioned above, I tried to set up a
new one, so I could create a base template.

 

But alas: All methods I tried fail (API and Web)

To me it looks, like it is looking "in the wrong direction", as it can't
seem to see my cluster, hosts etc.

However, looking under "Infrastructure" - all seems to be fine.

 

First "solution": Reboot mgmt server and system vms: No success.

 

 

2016-09-18 14:55:37,115 DEBUG [c.c.a.ApiServlet]
(catalina-exec-3:ctx-a5945e12) (logid:3dd43961) ===START===  192.168.254.142
-- GET
command=deployVirtualMachine&response=json&zoneid=baee96f3-fee4-4e18-9f44-42
8206d1b3f3&templateid=7662eb72-791c-11e6-9aa7-00155dfa0a0e&hypervisor=XenSer
ver&serviceofferingid=083d3f86-4b95-44c8-8361-0e571890ae2a&securitygroupids=
07265180-791d-11e6-9aa7-00155dfa0a0e&_=1474203217288

2016-09-18 14:55:37,132 DEBUG [c.c.u.AccountManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Access granted
to Acct[07261698-791d-11e6-9aa7-00155dfa0a0e-admin] to
org.apache.cloudstack.quota.vo.ServiceOfferingVO$$EnhancerByCGLIB$$7f648b5a@
5724d0d6 by AffinityGroupAccessChecker

2016-09-18 14:55:37,133 DEBUG [c.c.u.AccountManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Access granted
to Acct[07261698-791d-11e6-9aa7-00155dfa0a0e-admin] to null by
AffinityGroupAccessChecker

2016-09-18 14:55:37,158 DEBUG [c.c.v.UserVmManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Allocating in
the DB for vm

2016-09-18 14:55:37,165 DEBUG [c.c.v.VirtualMachineManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Allocating
entries for VM: VM[User|i-2-15-VM]

2016-09-18 14:55:37,165 DEBUG [c.c.v.VirtualMachineManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Allocating nics
for VM[User|i-2-15-VM]

2016-09-18 14:55:37,166 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Allocating nic
for vm VM[User|i-2-15-VM] in network Ntwk[204|Guest|6] with requested
profile NicProfile[0-0-null-null-null

2016-09-18 14:55:37,171 DEBUG [c.c.v.VirtualMachineManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Allocating
disks for VM[User|i-2-15-VM]

2016-09-18 14:55:37,180 DEBUG [c.c.v.VirtualMachineManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Allocation
completed for VM: VM[User|i-2-15-VM]

2016-09-18 14:55:37,180 DEBUG [c.c.v.UserVmManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) Successfully
allocated DB entry for VM[User|i-2-15-VM]

2016-09-18 14:55:37,221 INFO  [o.a.c.f.j.i.AsyncJobMonitor]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:1f41919b) Add job-135 into
job monitoring

2016-09-18 14:55:37,231 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) submit async
job-135, details: AsyncJobVO {id:135, userId: 2, accountId: 2, instanceType:
VirtualMachine, instanceId: 15, cmd:
org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin, cmdInfo:
{"id":"15","response":"json","serviceofferingid":"083d3f86-4b95-44c8-8361-0e
571890ae2a","ctxDetails":"{\"interface
com.cloud.vm.VirtualMachine\":\"d483480a-fa2d-47d2-ab9d-4355015f829e\",\"int
erface
com.cloud.template.VirtualMachineTemplate\":\"7662eb72-791c-11e6-9aa7-00155d
fa0a0e\",\"interface
com.cloud.network.security.SecurityGroup\":\"07265180-791d-11e6-9aa7-00155df
a0a0e\",\"interface
com.cloud.offering.ServiceOffering\":\"083d3f86-4b95-44c8-8361-0e571890ae2a\
",\"interface
com.cloud.dc.DataCenter\":\"baee96f3-fee4-4e18-9f44-428206d1b3f3\"}","cmdEve
ntType":"VM.CREATE","ctxUserId":"2","zoneid":"baee96f3-fee4-4e18-9f44-428206
d1b3f3","hypervisor":"XenServer","templateid":"7662eb72-791c-11e6-9aa7-00155
dfa0a0e","httpmethod":"GET","_":"1474203217288","securitygroupids":"07265180
-791d-11e6-9aa7-00155dfa0a0e","uuid":"d483480a-fa2d-47d2-ab9d-4355015f829e",
"ctxAccountId":"2","ctxStartEventId":"279"}, cmdVersion: 0, status:
IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
91770980878, completeMsid: null, lastUpdated: null, lastPolled: null,
created: null}

2016-09-18 14:55:37,232 DEBUG [c.c.a.ApiServlet]
(catalina-exec-3:ctx-a5945e12 ctx-a27aa791) (logid:3dd43961) ===END===
192.168.254.142 -- GET
command=deployVirtualMachine&response=json&zoneid=baee96f3-fee4-4e18-9f44-42
8206d1b3f3&templateid=7662eb72-791c-11e6-9aa7-00155dfa0a0e&hypervisor=XenSer
ver&serviceofferingid=083d3f86-4b95-44c8-8361-0e571890ae2a&securitygroupids=
07265180-791d-11e6-9aa7-00155dfa0a0e&_=1474203217288

2016-09-18 14:55:37,236 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Executing
AsyncJobVO {id:135, userId: 2, accountId: 2, instanceType: VirtualMachine,
instanceId: 15, cmd:
org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin, cmdInfo:
{"id":"15","response":"json","serviceofferingid":"083d3f86-4b95-44c8-8361-0e
571890ae2a","ctxDetails":"{\"interface
com.cloud.vm.VirtualMachine\":\"d483480a-fa2d-47d2-ab9d-4355015f829e\",\"int
erface
com.cloud.template.VirtualMachineTemplate\":\"7662eb72-791c-11e6-9aa7-00155d
fa0a0e\",\"interface
com.cloud.network.security.SecurityGroup\":\"07265180-791d-11e6-9aa7-00155df
a0a0e\",\"interface
com.cloud.offering.ServiceOffering\":\"083d3f86-4b95-44c8-8361-0e571890ae2a\
",\"interface
com.cloud.dc.DataCenter\":\"baee96f3-fee4-4e18-9f44-428206d1b3f3\"}","cmdEve
ntType":"VM.CREATE","ctxUserId":"2","zoneid":"baee96f3-fee4-4e18-9f44-428206
d1b3f3","hypervisor":"XenServer","templateid":"7662eb72-791c-11e6-9aa7-00155
dfa0a0e","httpmethod":"GET","_":"1474203217288","securitygroupids":"07265180
-791d-11e6-9aa7-00155dfa0a0e","uuid":"d483480a-fa2d-47d2-ab9d-4355015f829e",
"ctxAccountId":"2","ctxStartEventId":"279"}, cmdVersion: 0, status:
IN_PROGRESS, processStatus: 0, resultCode: 0, result: null, initMsid:
91770980878, completeMsid: null, lastUpdated: null, lastPolled: null,
created: null}

2016-09-18 14:55:37,278 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Deploy avoids pods: [], clusters: [], hosts: []

2016-09-18 14:55:37,279 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
DeploymentPlanner allocation algorithm:
com.cloud.deploy.FirstFitPlanner@4bfa7932

2016-09-18 14:55:37,279 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Trying to allocate a host and storage pools from dc:1,
pod:null,cluster:null, requested cpu: 1000, requested ram: 1073741824

2016-09-18 14:55:37,279 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd) Is
ROOT volume READY (pool already allocated)?: No

2016-09-18 14:55:37,279 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Searching all possible resources under this Zone: 1

2016-09-18 14:55:37,279 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Listing clusters in order of aggregate capacity, that have (atleast one host
with) enough CPU and RAM capacity under this Zone: 1

2016-09-18 14:55:37,282 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Removing from the clusterId list these clusters from avoid set: []

2016-09-18 14:55:37,288 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Checking resources in Cluster: 1 under Pod: 1

2016-09-18 14:55:37,288 DEBUG [c.c.a.m.a.i.FirstFitAllocator]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50
FirstFitRoutingAllocator) (logid:c69c1ccd) Looking for hosts in dc: 1  pod:1
cluster:1

2016-09-18 14:55:37,290 DEBUG [c.c.a.m.a.i.FirstFitAllocator]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50
FirstFitRoutingAllocator) (logid:c69c1ccd) FirstFitAllocator has 0 hosts to
check for allocation: []

2016-09-18 14:55:37,292 DEBUG [c.c.a.m.a.i.FirstFitAllocator]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50
FirstFitRoutingAllocator) (logid:c69c1ccd) Found 0 hosts for allocation
after prioritization: []

2016-09-18 14:55:37,292 DEBUG [c.c.a.m.a.i.FirstFitAllocator]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50
FirstFitRoutingAllocator) (logid:c69c1ccd) Looking for speed=1000Mhz,
Ram=1024

2016-09-18 14:55:37,292 DEBUG [c.c.a.m.a.i.FirstFitAllocator]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50
FirstFitRoutingAllocator) (logid:c69c1ccd) Host Allocator returning 0
suitable hosts

2016-09-18 14:55:37,292 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd) No
suitable hosts found

2016-09-18 14:55:37,292 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd) No
suitable hosts found under this Cluster: 1

2016-09-18 14:55:37,294 DEBUG [c.c.d.DeploymentPlanningManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Could not find suitable Deployment Destination for this VM under any
clusters, returning. 

2016-09-18 14:55:37,294 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Searching all possible resources under this Zone: 1

2016-09-18 14:55:37,295 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Listing clusters in order of aggregate capacity, that have (atleast one host
with) enough CPU and RAM capacity under this Zone: 1

2016-09-18 14:55:37,297 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Removing from the clusterId list these clusters from avoid set: [1]

2016-09-18 14:55:37,297 DEBUG [c.c.d.FirstFitPlanner]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd) No
clusters found after removing disabled clusters and clusters in avoid list,
returning.

2016-09-18 14:55:37,299 DEBUG [c.c.v.UserVmManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Destroying vm VM[User|i-2-15-VM] as it failed to create on Host with Id:null

2016-09-18 14:55:37,311 DEBUG [c.c.c.CapacityManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd) 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

2016-09-18 14:55:37,329 DEBUG [c.c.u.AccountManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Access granted to Acct[07261698-791d-11e6-9aa7-00155dfa0a0e-admin] to
Domain:1/ by AffinityGroupAccessChecker

2016-09-18 14:55:37,334 WARN  [o.a.c.alerts]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
alertType:: 8 // dataCenterId:: 1 // podId:: null // clusterId:: null //
message:: Failed to deploy Vm with Id: 15, on Host with Id: null

2016-09-18 14:55:37,356 INFO  [o.a.c.a.c.a.v.DeployVMCmdByAdmin]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
com.cloud.exception.InsufficientServerCapacityException: Unable to create a
deployment for VM[User|i-2-15-VM]Scope=interface com.cloud.dc.DataCenter;
id=1

2016-09-18 14:55:37,356 INFO  [o.a.c.a.c.a.v.DeployVMCmdByAdmin]
(API-Job-Executor-27:ctx-4b92f4ea job-135 ctx-fac5dc50) (logid:c69c1ccd)
Unable to create a deployment for VM[User|i-2-15-VM]

com.cloud.exception.InsufficientServerCapacityException: Unable to create a
deployment for VM[User|i-2-15-VM]Scope=interface com.cloud.dc.DataCenter;
id=1

                at
org.apache.cloudstack.engine.cloud.entity.api.VMEntityManagerImpl.reserveVir
tualMachine(VMEntityManagerImpl.java:214)

                at
org.apache.cloudstack.engine.cloud.entity.api.VirtualMachineEntityImpl.reser
ve(VirtualMachineEntityImpl.java:200)

                at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:40
92)

                at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:37
10)

                at
com.cloud.vm.UserVmManagerImpl.startVirtualMachine(UserVmManagerImpl.java:36
98)

                at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)

                at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57
)

                at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl
.java:43)

                at java.lang.reflect.Method.invoke(Method.java:606)

                at
org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopU
tils.java:317)

                at
org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint
(ReflectiveMethodInvocation.java:183)

                at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Reflect
iveMethodInvocation.java:150)

                at
org.apache.cloudstack.network.contrail.management.EventUtils$EventIntercepto
r.invoke(EventUtils.java:106)

                at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Reflect
iveMethodInvocation.java:161)

                at
com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:51
)

                at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Reflect
iveMethodInvocation.java:161)

                at
org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(Expos
eInvocationInterceptor.java:91)

                at
org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(Reflect
iveMethodInvocation.java:172)

                at
org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopPro
xy.java:204)

                at com.sun.proxy.$Proxy198.startVirtualMachine(Unknown
Source)

                at
org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin.execute(Deploy
VMCmdByAdmin.java:50)

                at
com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:150)

                at
com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:108)

                at
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext
(AsyncJobManagerImpl.java:554)

                at
org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedCo
ntextRunnable.java:49)

                at
org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(Defa
ultManagedContext.java:56)

                at
org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithCon
text(DefaultManagedContext.java:103)

                at
org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithCont
ext(DefaultManagedContext.java:53)

                at
org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedCont
extRunnable.java:46)

                at
org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJob
ManagerImpl.java:502)

                at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)

                at java.util.concurrent.FutureTask.run(FutureTask.java:262)

                at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:11
45)

                at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:6
15)

                at java.lang.Thread.run(Thread.java:745)

2016-09-18 14:55:37,356 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Complete async
job-135, jobStatus: FAILED, resultCode: 530, result:
org.apache.cloudstack.api.response.ExceptionResponse/null/{"uuidList":[],"er
rorcode":533,"errortext":"Unable to create a deployment for
VM[User|i-2-15-VM]"}

2016-09-18 14:55:37,357 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Publish async
job-135 complete on message bus

2016-09-18 14:55:37,357 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Wake up jobs
related to job-135

2016-09-18 14:55:37,357 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Update db status
for job-135

2016-09-18 14:55:37,359 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Wake up jobs
joined with job-135 and disjoin all subjobs created from job- 135

2016-09-18 14:55:37,361 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Done executing
org.apache.cloudstack.api.command.admin.vm.DeployVMCmdByAdmin for job-135

2016-09-18 14:55:37,361 INFO  [o.a.c.f.j.i.AsyncJobMonitor]
(API-Job-Executor-27:ctx-4b92f4ea job-135) (logid:c69c1ccd) Remove job-135
from job monitoring

 

 





JeroenKeerl


Keerl IT Services GmbH
Birkenstraße 1b. 21521 Aumühle

+49 177 6320 317

www.keerl-it.com
i...@keerl-it.com

Geschäftsführer. Jacobus J. Keerl
Registergericht Lubeck. HRB-Nr. 14511

Unsere Allgemeine Geschäftsbedingungen finden Siehier.


Reply via email to