Chandan Purushothama created CLOUDSTACK-7423: ------------------------------------------------
Summary: [Automation] Unable to start Virtual Machine due to - Unable to apply dhcp entry on router Key: CLOUDSTACK-7423 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-7423 Project: CloudStack Issue Type: Bug Security Level: Public (Anyone can view this level - this is the default.) Components: Automation, Test Affects Versions: 4.5.0 Reporter: Chandan Purushothama Priority: Critical Fix For: 4.5.0 Unable to start after stopping a User VM as part of *integration.component.test_cpu_project_limits.TestProjectsCPULimits.test_01_project_counts_start_stop_instance* ============ *Error Message* ============ Failed to start instance: Job failed: {jobprocstatus : 0, created : u'2014-08-24T09:23:02+0000', jobresult : {errorcode : 530, errortext : u'Job failed due to exception Unable to create a deployment for VM[User|i-218-404-VM]'}, cmd : u'org.apache.cloudstack.api.command.admin.vm.StartVMCmdByAdmin', userid : u'77df13d2-2b4d-11e4-89bd-1e5d0e053e75', jobstatus : 2, jobid : u'76b12bb1-52fc-45f4-933f-31399cefd624', jobresultcode : 530, jobinstanceid : u'f565ab82-6d89-416e-9d93-9b04cf2667d0', jobresulttype : u'object', jobinstancetype : u'VirtualMachine', accountid : u'77df055e-2b4d-11e4-89bd-1e5d0e053e75'} Logs available at http://xenrt.hq.xensource.com/control/queue.cgi?action=testlogs&id=804076&phase=Parallel&test=cpu_project_limits Stacktrace File "/usr/lib/python2.7/unittest/case.py", line 332, in run testMethod() File "/root/cloudstack/test/integration/component/test_cpu_project_limits.py", line 263, in test_01_project_counts_start_stop_instance self.fail("Failed to start instance: %s" % e) File "/usr/lib/python2.7/unittest/case.py", line 413, in fail raise self.failureException(msg) 'Failed to start instance: Job failed: {jobprocstatus : 0, created : u\'2014-08-24T09:23:02+0000\', jobresult : {errorcode : 530, errortext : u\'Job failed due to exception Unable to create a deployment for VM[User|i-218-404-VM]\'}, cmd : u\'org.apache.cloudstack.api.command.admin.vm.StartVMCmdByAdmin\', userid : u\'77df13d2-2b4d-11e4-89bd-1e5d0e053e75\', jobstatus : 2, jobid : u\'76b12bb1-52fc-45f4-933f-31399cefd624\', jobresultcode : 530, jobinstanceid : u\'f565ab82-6d89-416e-9d93-9b04cf2667d0\', jobresulttype : u\'object\', jobinstancetype : u\'VirtualMachine\', accountid : u\'77df055e-2b4d-11e4-89bd-1e5d0e053e75\'}\n =========================== Error of Management Server Log: =========================== {code} 2014-08-24 09:23:03,513 INFO [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-21:ctx-e6e44390 job-2922/job-2923 ctx-2994f1d0) Unable to contact resource. com.cloud.exception.ResourceUnavailableException: Resource [DataCenter:1] is unreachable: Unable to apply dhcp entry on router at com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyRules(VirtualNetworkApplianceManagerImpl.java:4031) at com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyDhcpEntry(VirtualNetworkApplianceManagerImpl.java:3150) at sun.reflect.GeneratedMethodAccessor447.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:601) at org.springframework.aop.support.AopUtils.invokeJoinpointUsingReflection(AopUtils.java:317) at org.springframework.aop.framework.ReflectiveMethodInvocation.invokeJoinpoint(ReflectiveMethodInvocation.java:183) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:150) at org.springframework.aop.interceptor.ExposeInvocationInterceptor.invoke(ExposeInvocationInterceptor.java:91) at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:172) at org.springframework.aop.framework.JdkDynamicAopProxy.invoke(JdkDynamicAopProxy.java:204) at $Proxy190.applyDhcpEntry(Unknown Source) at com.cloud.network.element.VirtualRouterElement.addDhcpEntry(VirtualRouterElement.java:924) at org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepareElement(NetworkOrchestrator.java:1251) at org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepareNic(NetworkOrchestrator.java:1373) at org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepare(NetworkOrchestrator.java:1309) at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:972) at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:4582) at sun.reflect.GeneratedMethodAccessor383.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:601) at com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107) at com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:4738) at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:102) at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:503) at org.apache.cloudstack.managed.context.ManagedContextRunnable$1.run(ManagedContextRunnable.java:49) at org.apache.cloudstack.managed.context.impl.DefaultManagedContext$1.call(DefaultManagedContext.java:56) at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.callWithContext(DefaultManagedContext.java:103) at org.apache.cloudstack.managed.context.impl.DefaultManagedContext.runWithContext(DefaultManagedContext.java:53) at org.apache.cloudstack.managed.context.ManagedContextRunnable.run(ManagedContextRunnable.java:46) at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.run(AsyncJobManagerImpl.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) 2014-08-24 09:23:03,515 DEBUG [c.c.d.DeploymentPlanningManagerImpl] (API-Job-Executor-19:ctx-542348cb job-2924 ctx-7f90f0e1) Found a potential host id: 1 name: cl09-B-02 and associated storage pools for this VM 2014-08-24 09:23:03,517 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-21:ctx-e6e44390 job-2922/job-2923 ctx-2994f1d0) Cleaning up resources for the vm VM[User|i-218-404-VM] in Starting state {code} -- This message was sent by Atlassian JIRA (v6.2#6252)