[
https://issues.apache.org/jira/browse/CLOUDSTACK-7186?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=14075626#comment-14075626
]
Rayees Namathponnan commented on CLOUDSTACK-7186:
-------------------------------------------------
How to reproduce the issue
Run the BVT suite "test_network_acl"
0) Get the default network offering for VPC
1) Create VPC
2) Create ACL
3) Create ACL Item
4) Create network with ACL
5) Deploy a vm
Deploy VM fails with NPE
2014-07-27 06:43:23,185 WARN [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Failed to
add router VM[DomainRouter|r-268-VM] to network Ntwk[341|Guest|11] due to
java.lang.NullPointerException
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.createNicForVm(NetworkOrchestrator.java:3066)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateAddVmToNetwork(VirtualMachineManagerImpl.java:3409)
at
com.cloud.vm.VirtualMachineManagerImpl.addVmToNetwork(VirtualMachineManagerImpl.java:3355)
at
com.cloud.network.router.VpcVirtualNetworkApplianceManagerImpl.addVpcRouterToGuestNetwork(VpcVirtualNetworkApplianceManagerImpl.java:267)
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(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 com.sun.proxy.$Proxy189.addVpcRouterToGuestNetwork(Unknown Source)
at
com.cloud.network.element.VpcVirtualRouterElement.implement(VpcVirtualRouterElement.java:187)
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.implementNetworkElementsAndResources(NetworkOrchestrator.java:1088)
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.implementNetwork(NetworkOrchestrator.java:995)
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepare(NetworkOrchestrator.java:1282)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:985)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5146)
at sun.reflect.GeneratedMethodAccessor294.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at
com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5302)
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.run(FutureTask.java:262)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
2014-07-27 06:43:23,186 DEBUG [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Removing
the router VM[DomainRouter|r-268-VM] from network Ntwk[341|Guest|11] as a part
of cleanup
2014-07-27 06:43:23,205 DEBUG [c.c.n.NetworkModelImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Service
SecurityGroup is not supported in the network id=341
2014-07-27 06:43:23,215 DEBUG [c.c.n.NetworkModelImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Service
SecurityGroup is not supported in the network id=341
2014-07-27 06:43:23,223 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992377: Sending { Cmd , MgmtId: 29066118877352, via:
1(Rack2Host11.lab.vmops.com), Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.SetupGuestNetworkCommand":{"dhcpRange":"10.1.1.1","networkDomain":"csbcauto.advanced","isRedundant":false,"add":false,"nic":{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"pxeDisable":true,"nicUuid":"ae411b26-6aa3-4fdc-99be-bc15ff0578e2","uuid":"4da9a976-498f-4874-860a-2881a38a28f0","ip":"10.1.1.1","netmask":"255.255.255.192","gateway":"10.1.1.1","mac":"02:00:7f:48:00:02","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2312","isolationUri":"vlan://2312","isSecurityGroupEnabled":false},"accessDetails":{"router.guest.ip":"10.1.1.1","guest.vlan.tag":"2312","guest.network.gateway":"10.1.1.1","guest.bridge":"10.1.1.63","router.name":"r-268-VM","router.ip":"169.254.0.30"},"wait":0}}]
}
2014-07-27 06:43:23,272 DEBUG [c.c.a.t.Request] (AgentManager-Handler-3:null)
Seq 1-377457943768992377: Processing: { Ans: , MgmtId: 29066118877352, via: 1,
Ver: v1, Flags: 110,
[{"com.cloud.agent.api.Answer":{"result":false,"details":"Can not find nic with
mac 02:00:7f:48:00:02 for VM r-268-VM","wait":0}}] }
2014-07-27 06:43:23,272 DEBUG [c.c.a.m.AgentAttache]
(AgentManager-Handler-3:null) Seq 1-377457943768992377: No more commands found
2014-07-27 06:43:23,272 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992377: Received: { Ans: , MgmtId: 29066118877352, via: 1, Ver:
v1, Flags: 110, { Answer } }
2014-07-27 06:43:23,272 WARN [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Unable to
destroy guest network on router VM[DomainRouter|r-268-VM]
2014-07-27 06:43:23,272 WARN [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Failed to
destroy guest network config Ntwk[341|Guest|11] on router
VM[DomainRouter|r-268-VM]
2014-07-27 06:43:23,273 WARN [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Failed to
remove the router VM[DomainRouter|r-268-VM] from network Ntwk[341|Guest|11] as
a part of cleanup
2014-07-27 06:43:23,273 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Cleaning up
because we're unable to implement the network Ntwk[341|Guest|11]
2014-07-27 06:43:23,282 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Lock is
acquired for network Ntwk[341|Guest|11] as a part of network shutdown
2014-07-27 06:43:23,288 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Releasing 0
port forwarding rules for network id=341 as a part of shutdownNetworkRules
2014-07-27 06:43:23,288 DEBUG [c.c.n.f.FirewallManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) There are
no rules to forward to the network elements
2014-07-27 06:43:23,289 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Releasing 0
static nat rules for network id=341 as a part of shutdownNetworkRules
2014-07-27 06:43:23,290 DEBUG [c.c.n.f.FirewallManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) There are
no rules to forward to the network elements
2014-07-27 06:43:23,291 DEBUG [c.c.n.l.LoadBalancingRulesManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Revoking 0
Public load balancing rules for network id=341
2014-07-27 06:43:23,291 DEBUG [c.c.n.l.LoadBalancingRulesManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) There are
no Load Balancing Rules to forward to the network elements
2014-07-27 06:43:23,292 DEBUG [c.c.n.l.LoadBalancingRulesManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Revoking 0
Internal load balancing rules for network id=341
2014-07-27 06:43:23,292 DEBUG [c.c.n.l.LoadBalancingRulesManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) There are
no Load Balancing Rules to forward to the network elements
2014-07-27 06:43:23,293 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Releasing 0
firewall ingress rules for network id=341 as a part of shutdownNetworkRules
2014-07-27 06:43:23,293 DEBUG [c.c.n.f.FirewallManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) There are
no rules to forward to the network elements
2014-07-27 06:43:23,294 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Releasing 0
firewall egress rules for network id=341 as a part of shutdownNetworkRules
2014-07-27 06:43:23,295 DEBUG [c.c.n.f.FirewallManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) There are
no rules to forward to the network elements
2014-07-27 06:43:23,295 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Releasing
Network ACL Items for network id=341 as a part of shutdownNetworkRules
2014-07-27 06:43:23,298 DEBUG [c.c.n.v.NetworkACLManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Releasing 2
Network ACL Items for network id=341
2014-07-27 06:43:23,300 DEBUG [c.c.n.v.NetworkACLManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Applying
NetworkACL for network: 341 with Network ACL service provider
2014-07-27 06:43:23,305 DEBUG [c.c.n.r.VirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Applying
network acls in network Ntwk[341|Guest|11]
2014-07-27 06:43:23,314 DEBUG [c.c.n.NetworkModelImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Service
SecurityGroup is not supported in the network id=341
2014-07-27 06:43:23,322 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992378: Sending { Cmd , MgmtId: 29066118877352, via:
1(Rack2Host11.lab.vmops.com), Ver: v1, Flags: 100001,
[{"com.cloud.agent.api.routing.SetNetworkACLCommand":{"rules":[{"id":0,"vlanTag":"2312","protocol":"all","revoked":true,"alreadyAdded":false,"cidrList":["0.0.0.0/0"],"trafficType":"Ingress","action":"ACCEPT","number":1},{"id":0,"vlanTag":"2312","protocol":"all","revoked":true,"alreadyAdded":false,"cidrList":["0.0.0.0/0"],"trafficType":"Egress","action":"ACCEPT","number":2}],"nic":{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"pxeDisable":true,"nicUuid":"ae411b26-6aa3-4fdc-99be-bc15ff0578e2","uuid":"4da9a976-498f-4874-860a-2881a38a28f0","ip":"10.1.1.1","netmask":"255.255.255.192","gateway":"10.1.1.1","mac":"02:00:7f:48:00:02","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2312","isolationUri":"vlan://2312","isSecurityGroupEnabled":false},"accessDetails":{"zone.network.type":"Advanced","router.name":"r-268-VM","router.ip":"169.254.0.30","router.guest.ip":"10.1.1.1","guest.vlan.tag":"2312"},"wait":0}}]
}
2014-07-27 06:43:23,676 DEBUG [c.c.a.t.Request] (AgentManager-Handler-14:null)
Seq 1-377457943768992378: Processing: { Ans: , MgmtId: 29066118877352, via: 1,
Ver: v1, Flags: 0,
[{"com.cloud.agent.api.Answer":{"result":true,"details":"","wait":0}}] }
2014-07-27 06:43:23,676 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992378: Received: { Ans: , MgmtId: 29066118877352, via: 1, Ver:
v1, Flags: 0, { Answer } }
2014-07-27 06:43:23,677 DEBUG [c.c.n.v.NetworkACLManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844)
Successfully released Network ACLs for network id=341 and # of rules now = 2
2014-07-27 06:43:23,678 DEBUG [c.c.n.r.RulesManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Found 0
static nat rules to apply for network id 341
2014-07-27 06:43:23,680 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Sending
network shutdown to VpcVirtualRouter
2014-07-27 06:43:23,690 DEBUG [c.c.n.NetworkModelImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Service
SecurityGroup is not supported in the network id=341
2014-07-27 06:43:23,699 DEBUG [c.c.n.NetworkModelImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Service
SecurityGroup is not supported in the network id=341
2014-07-27 06:43:23,706 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992379: Sending { Cmd , MgmtId: 29066118877352, via:
1(Rack2Host11.lab.vmops.com), Ver: v1, Flags: 100111,
[{"com.cloud.agent.api.SetupGuestNetworkCommand":{"dhcpRange":"10.1.1.1","networkDomain":"csbcauto.advanced","isRedundant":false,"add":false,"nic":{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"pxeDisable":true,"nicUuid":"ae411b26-6aa3-4fdc-99be-bc15ff0578e2","uuid":"4da9a976-498f-4874-860a-2881a38a28f0","ip":"10.1.1.1","netmask":"255.255.255.192","gateway":"10.1.1.1","mac":"02:00:7f:48:00:02","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2312","isolationUri":"vlan://2312","isSecurityGroupEnabled":false},"accessDetails":{"router.guest.ip":"10.1.1.1","guest.vlan.tag":"2312","guest.network.gateway":"10.1.1.1","guest.bridge":"10.1.1.63","router.name":"r-268-VM","router.ip":"169.254.0.30"},"wait":0}}]
}
2014-07-27 06:43:23,755 DEBUG [c.c.a.t.Request] (AgentManager-Handler-10:null)
Seq 1-377457943768992379: Processing: { Ans: , MgmtId: 29066118877352, via: 1,
Ver: v1, Flags: 110,
[{"com.cloud.agent.api.Answer":{"result":false,"details":"Can not find nic with
mac 02:00:7f:48:00:02 for VM r-268-VM","wait":0}}] }
2014-07-27 06:43:23,755 DEBUG [c.c.a.m.AgentAttache]
(AgentManager-Handler-10:null) Seq 1-377457943768992379: No more commands found
2014-07-27 06:43:23,755 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992379: Received: { Ans: , MgmtId: 29066118877352, via: 1, Ver:
v1, Flags: 110, { Answer } }
2014-07-27 06:43:23,755 WARN [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Unable to
destroy guest network on router VM[DomainRouter|r-268-VM]
2014-07-27 06:43:23,755 WARN [c.c.n.r.VpcVirtualNetworkApplianceManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Failed to
destroy guest network config Ntwk[341|Guest|11] on router
VM[DomainRouter|r-268-VM]
2014-07-27 06:43:23,755 WARN [c.c.n.e.VpcVirtualRouterElement]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Failed to
unplug nic in network Ntwk[341|Guest|11] for virtual router
VM[DomainRouter|r-268-VM]
2014-07-27 06:43:23,755 WARN [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Unable to
complete shutdown of the network elements due to element: VpcVirtualRouter
2014-07-27 06:43:23,761 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Lock is
released for network Ntwk[341|Guest|11] as a part of network shutdown
2014-07-27 06:43:23,761 DEBUG [o.a.c.e.o.NetworkOrchestrator]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Lock is
released for network id 341 as a part of network implement
2014-07-27 06:43:23,761 ERROR [c.c.v.VirtualMachineManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Failed to
start instance VM[User|i-188-269-VM]
com.cloud.utils.exception.CloudRuntimeException: Failed to add VPC router
VM[DomainRouter|r-268-VM] to guest network Ntwk[341|Guest|11]
at
com.cloud.network.element.VpcVirtualRouterElement.implement(VpcVirtualRouterElement.java:188)
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.implementNetworkElementsAndResources(NetworkOrchestrator.java:1088)
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.implementNetwork(NetworkOrchestrator.java:995)
at
org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepare(NetworkOrchestrator.java:1282)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:985)
at
com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:5146)
at sun.reflect.GeneratedMethodAccessor294.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
at
com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:5302)
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.run(FutureTask.java:262)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:744)
2014-07-27 06:43:23,765 DEBUG [c.c.v.VirtualMachineManagerImpl]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Cleaning up
resources for the vm VM[User|i-188-269-VM] in Starting state
2014-07-27 06:43:23,768 DEBUG [c.c.a.t.Request]
(Work-Job-Executor-161:ctx-0bd6e9e3 job-1985/job-1986 ctx-d6950844) Seq
1-377457943768992380: Sending { Cmd , MgmtId: 29066118877352, via:
1(Rack2Host11.lab.vmops.com), Ver: v1, Flags: 100011,
[{"com.cloud.agent.api.StopCommand":{"isProxy":false,"executeInSequence":false,"checkBeforeCleanup":false,"vmName":"i-188-269-VM","wait":0}}]
}
> [Automation] Router deployment fails while calling SetupGuestNetworkCommand
> ----------------------------------------------------------------------------
>
> Key: CLOUDSTACK-7186
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-7186
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the
> default.)
> Components: Virtual Router
> Affects Versions: 4.5.0
> Environment: KVM (not verified with other hyper-visors)
> Master
> Reporter: Rayees Namathponnan
> Priority: Blocker
> Fix For: 4.5.0
>
>
> This issue is observed in automation run, failed to configure VR after
> deploying the VM , observed below error
> Failed to prepare VR command due to Can not find nic with mac
> 02:00:7d:56:00:02 for VM r-16-VM
> Agent log
> Can not find nic with mac 02:00:7d:56:00:02
> 2014-07-25 16:25:38,061 DEBUG [cloud.agent.Agent]
> (agentRequest-Handler-1:null) Request:Seq 2-4214524826288652384: {
> Cmd , MgmtId: 29066118877352, via: 2, Ver: v1, Flags: 100111,
> [{"com.cloud.agent.api.SetupGuestNetworkCommand":{"dhcpRange":"10.1.1.1","networkDomain":"vpc.vpn","isRedundant":false,"add":false,"nic":{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"pxeDisable":true,"nicUuid":"bad86d37-eedb-4c0b-8752-0631d5e74f1a","uuid":"b34acc98-77d7-4aa6-9a97-4417b1d1f579","ip":"10.1.1.1","netmask":"255.255.255.192","gateway":"10.1.1.1","mac":"02:00:7d:56:00:02","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2352","isolationUri":"vlan://2352","isSecurityGroupEnabled":false},"accessDetails":{"router.guest.ip":"10.1.1.1","guest.vlan.tag":"2352","guest.network.gateway":"10.1.1.1","guest.bridge":"10.1.1.63","router.ip":"169.254.2.226","router.name":"r-16-VM"},"wait":0}}]
> }
> 2014-07-25 16:25:38,062 DEBUG [cloud.agent.Agent]
> (agentRequest-Handler-1:null) Processing command:
> com.cloud.agent.api.SetupGuestNetworkCommand
> 2014-07-25 16:25:38,071 ERROR
> [resource.virtualnetwork.VirtualRoutingResource]
> (agentRequest-Handler-1:null) Failed to prepare VR command due to Can not
> find nic with mac 02:00:7d:56:00:02 for VM r-16-VM
> 2014-07-25 16:25:38,071 DEBUG [cloud.agent.Agent]
> (agentRequest-Handler-1:null) Seq 2-4214524826288652384: { Ans: , MgmtId:
> 29066118877352, via: 2, Ver: v1, Flags: 110,
> [{"com.cloud.agent.api.Answer":{"result":false,"details":"Can not find nic
> with mac 02:00:7d:56:00:02 for VM r-16-VM","wait":0}}] }
> 2014-07-25 16:25:38,171 DEBUG [cloud.agent.Agent]
> (agentRequest-Handler-2:null) Request:Seq 2-4214524826288652385: { Cmd ,
> MgmtId: 29066118877352, via: 2, Ver: v1, Flags: 100111,
> [{"com.cloud.agent.api.SetupGuestNetworkCommand":{"dhcpRange":"10.1.1.1","networkDomain":"vpc.vpn","isRedundant":false,"add":false,"nic":{"deviceId":2,"networkRateMbps":200,"defaultNic":false,"pxeDisable":true,"nicUuid":"bad86d37-eedb-4c0b-8752-0631d5e74f1a","uuid":"b34acc98-77d7-4aa6-9a97-4417b1d1f579","ip":"10.1.1.1","netmask":"255.255.255.192","gateway":"10.1.1.1","mac":"02:00:7d:56:00:02","broadcastType":"Vlan","type":"Guest","broadcastUri":"vlan://2352","isolationUri":"vlan://2352","isSecurityGroupEnabled":false},"accessDetails":{"router.guest.ip":"10.1.1.1","guest.vlan.tag":"2352","guest.network.gateway":"10.1.1.1","guest.bridge":"10.1.1.63","router.ip":"169.254.2.226","router.name":"r-16-VM"},"wait":0}}]
> }
> 2014-07-25 16:25:38,172 DEBUG [cloud.agent.Agent]
> (agentRequest-Handler-2:null) Processing command:
> com.cloud.agent.api.SetupGuestNetworkCommand
> 2014-07-25 16:25:38,180 ERROR
> [resource.virtualnetwork.VirtualRoutingResource]
> (agentRequest-Handler-2:null) Failed to prepare VR command due to Can not
> find nic with mac 02:00:7d:56:00:02 for VM r-16-VM
> 2014-07-25 16:25:38,181 DEBUG [cloud.agent.Agent]
> (agentRequest-Handler-2:null) Seq 2-4214524826288652385: { Ans: , MgmtId:
> 29066118877352, via: 2, Ver: v1, Flags: 110,
> [{"com.cloud.agent.api.Answer":{"result":false,"details":"Can not find nic
> with mac 02:00:7d:56:00:02 for VM r-16-VM","wait":0}}] }
--
This message was sent by Atlassian JIRA
(v6.2#6252)
