You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Rajani Karuturi (JIRA)" <ji...@apache.org> on 2014/11/26 05:12:29 UTC

[jira] [Updated] (CLOUDSTACK-6101) Contrail:MS: Disable NAT on acquired IP results in exception

     [ https://issues.apache.org/jira/browse/CLOUDSTACK-6101?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]

Rajani Karuturi updated CLOUDSTACK-6101:
----------------------------------------
    Fix Version/s:     (was: 4.4.0)
                   4.4.3

> Contrail:MS: Disable NAT on acquired IP results in exception
> ------------------------------------------------------------
>
>                 Key: CLOUDSTACK-6101
>                 URL: https://issues.apache.org/jira/browse/CLOUDSTACK-6101
>             Project: CloudStack
>          Issue Type: Bug
>      Security Level: Public(Anyone can view this level - this is the default.) 
>          Components: Contrail, Management Server
>    Affects Versions: 4.3.0
>         Environment: Contrail
>            Reporter: Parth Jagirdar
>            Assignee: Sachchidanand Vaidya
>             Fix For: 4.4.3
>
>
> Disable NAT, rule gets removed but exception is thrown.
> 2014-02-13 13:53:08,389 DEBUG [c.c.n.r.RulesManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Revoking all Firewallrules as a part of disabling static nat for public IP id=3
> 2014-02-13 13:53:08,400 DEBUG [c.c.n.f.FirewallManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Releasing 0 firewall rules for ip id=3
> 2014-02-13 13:53:08,401 DEBUG [c.c.n.f.FirewallManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) There are no firewall rules to apply
> 2014-02-13 13:53:08,402 DEBUG [c.c.n.f.FirewallManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Successfully released firewall rules for ip id=3 and # of rules now = 0
> 2014-02-13 13:53:08,408 DEBUG [c.c.n.r.RulesManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Releasing 0 port forwarding rules for ip id=3
> 2014-02-13 13:53:08,410 DEBUG [c.c.n.r.RulesManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Releasing 0 static nat rules for ip id=3
> 2014-02-13 13:53:08,411 DEBUG [c.c.n.r.RulesManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) There are no port forwarding rules to apply for ip id=3
> 2014-02-13 13:53:08,412 DEBUG [c.c.n.r.RulesManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) There are no static nat rules to apply for ip id=3
> 2014-02-13 13:53:08,423 INFO  [o.a.c.e.o.NetworkOrchestrator] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Let ContrailElement handle StaticNat in network 206
> 2014-02-13 13:53:08,441 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: GET, /virtual-network/e6c067bc-bc63-4613-a7af-84d0182ff6d2
> 2014-02-13 13:53:08,451 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 200 OK
> 2014-02-13 13:53:08,455 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: PUT, /virtual-network/e6c067bc-bc63-4613-a7af-84d0182ff6d2, {"virtual-network":{"virtual_network_properties":{"extend_to_external_routers":false,"network_id":4},"route_target_list":{"route_target":["target:64512:1002","target:64512:1002","target:64512:1002","target:64512:1002","target:64512:1002","target:64512:1002","target:64512:1002"]},"network_ipam_refs":[{"to":["default-domain","default-project","default-network-ipam"],"attr":{"ipam_subnets":[{"subnet":{"ip_prefix":"10.223.138.64","ip_prefix_len":26},"default_gateway":"10.223.138.65"}]},"href":null,"uuid":null}],"floating_ip_pools":[{"to":["default-domain","default-project","__default_Public__","PublicIpPool"],"attr":null,"href":"http://10.223.58.3:8082/floating-ip-pool/8cf92e6e-b81a-44d6-9f6d-1472aaec7264","uuid":"8cf92e6e-b81a-44d6-9f6d-1472aaec7264"}],"routing_instances":[{"to":["default-domain","default-project","__default_Public__","__default_Public__"],"attr":null,"href":"http://10.223.58.3:8082/routing-instance/74769566-dfce-4b6d-bbb5-db772bccb2f9","uuid":"74769566-dfce-4b6d-bbb5-db772bccb2f9"}],"name":"__default_Public__","uuid":"e6c067bc-bc63-4613-a7af-84d0182ff6d2","fq_name":["default-domain","default-project","__default_Public__"],"parent_type":"project","parent_uuid":"fafebf0e-5d9c-4c99-928d-25ab65bd7ebc"}}
> 2014-02-13 13:53:08,492 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 200 OK
> 2014-02-13 13:53:08,492 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: GET, /virtual-machine-interface/07c6bdac-7be4-4d88-83ef-6f5ffe2f8b19
> 2014-02-13 13:53:08,496 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 404 Not Found
> 2014-02-13 13:53:08,496 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: POST, /virtual-machine-interfaces, {"virtual-machine-interface":{"virtual_machine_interface_mac_addresses":{"mac_address":["06:e4:2a:00:00:35"]},"virtual_network_refs":[{"to":["default-domain","default-project","__default_Public__"],"attr":null,"href":null,"uuid":null}],"name":"s-11-VM-2","uuid":"07c6bdac-7be4-4d88-83ef-6f5ffe2f8b19","fq_name":["s-11-VM","s-11-VM-2"],"parent_type":"virtual-machine"}}
> 2014-02-13 13:53:08,505 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 400 Bad Request
> 2014-02-13 13:53:08,505 ERROR [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) create api request failed: Bad Request
> 2014-02-13 13:53:08,508 ERROR [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Failure message:
>     <!DOCTYPE HTML PUBLIC "-//IETF//DTD HTML 2.0//EN">
>     <html>
>         <head>
>             <title>Error: 400 Bad Request</title>
>             <style type="text/css">
>               html {background-color: #eee; font-family: sans;}
>               body {background-color: #fff; border: 1px solid #ddd;
>                     padding: 15px; margin: 15px;}
>               pre {background-color: #eee; border: 1px solid #ddd; padding: 5px;}
>             </style>
>         </head>
>         <body>
>             <h1>Error: 400 Bad Request</h1>
>             <p>Sorry, the requested URL <tt>&#039;http://10.223.58.3:8082/virtual-machine-interfaces&#039;</tt>
>                caused an error:</p>
>             <pre>Parent [u&#039;s-11-VM&#039;] type virtual-machine does not exist</pre>
>         </body>
>     </html>
> 2014-02-13 13:53:08,509 WARN  [o.a.c.n.c.m.ContrailManager] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) virtual-network update:
> com.cloud.exception.InternalErrorException: Unable to create virtual-machine-interface 07c6bdac-7be4-4d88-83ef-6f5ffe2f8b19
>         at org.apache.cloudstack.network.contrail.model.VMInterfaceModel.update(VMInterfaceModel.java:229)
>         at org.apache.cloudstack.network.contrail.model.VirtualNetworkModel.update(VirtualNetworkModel.java:305)
>         at org.apache.cloudstack.network.contrail.management.ContrailManagerImpl.lookupPublicNetworkModel(ContrailManagerImpl.java:781)
>         at org.apache.cloudstack.network.contrail.management.ContrailManagerImpl.deleteFloatingIp(ContrailManagerImpl.java:826)
>         at org.apache.cloudstack.network.contrail.management.ContrailElementImpl.applyIps(ContrailElementImpl.java:349)
>         at com.cloud.network.IpAddressManagerImpl.applyIpAssociations(IpAddressManagerImpl.java:976)
>         at com.cloud.network.IpAddressManagerImpl.applyStaticNats(IpAddressManagerImpl.java:1790)
>         at com.cloud.network.rules.RulesManagerImpl.applyStaticNatForIp(RulesManagerImpl.java:1324)
>         at com.cloud.network.rules.RulesManagerImpl.revokeAllPFAndStaticNatRulesForIp(RulesManagerImpl.java:1102)
>         at com.cloud.network.rules.RulesManagerImpl.disableStaticNat(RulesManagerImpl.java:1267)
>         at com.cloud.network.rules.RulesManagerImpl.disableStaticNat(RulesManagerImpl.java:1238)
>         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:622)
>         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.apache.cloudstack.network.contrail.management.EventUtils$EventInterceptor.invoke(EventUtils.java:109)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
>         at com.cloud.event.ActionEventInterceptor.invoke(ActionEventInterceptor.java:50)
>         at org.springframework.aop.framework.ReflectiveMethodInvocation.proceed(ReflectiveMethodInvocation.java:161)
>         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.$Proxy88.disableStaticNat(Unknown Source)
>         at org.apache.cloudstack.api.command.user.nat.DisableStaticNatCmd.execute(DisableStaticNatCmd.java:83)
>         at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:161)
>         at com.cloud.api.ApiAsyncJobDispatcher.runJobInContext(ApiAsyncJobDispatcher.java:109)
>         at com.cloud.api.ApiAsyncJobDispatcher$1.run(ApiAsyncJobDispatcher.java:66)
>         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 com.cloud.api.ApiAsyncJobDispatcher.runJob(ApiAsyncJobDispatcher.java:63)
>         at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:526)
>         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 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:1146)
>         at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
>         at java.lang.Thread.run(Thread.java:701)
> 2014-02-13 13:53:08,512 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: GET, /floating-ip/fe78aa9f-7f82-4416-b214-bce21e4aca48
> 2014-02-13 13:53:08,518 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 200 OK
> 2014-02-13 13:53:08,519 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: DELETE, /floating-ip/fe78aa9f-7f82-4416-b214-bce21e4aca48
> 2014-02-13 13:53:08,551 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 200 OK
> 2014-02-13 13:53:08,551 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: GET, /floating-ip-pool/8cf92e6e-b81a-44d6-9f6d-1472aaec7264
> 2014-02-13 13:53:08,558 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 200 OK
> 2014-02-13 13:53:08,560 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) >> Request: DELETE, /floating-ip-pool/8cf92e6e-b81a-44d6-9f6d-1472aaec7264
> 2014-02-13 13:53:08,572 INFO  [n.j.c.a.ApiConnector] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) << Response Status: HTTP/1.1 200 OK
> 2014-02-13 13:53:08,572 DEBUG [o.a.c.n.c.m.ContrailElement] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Successfully deleted floating ip: 10.223.138.77
> 2014-02-13 13:53:08,576 DEBUG [c.c.n.r.RulesManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Successfully released rules for ip id=3 and # of rules now = 0
> 2014-02-13 13:53:08,607 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-77:ctx-6e8167ac ctx-152aebc9) Complete async job-115, jobStatus: SUCCEEDED, resultCode: 0, result: org.apache.cloudstack.api.response.SuccessResponse/null/{"success":true}
> 2014-02-13 13:53:08,622 DEBUG [o.a.c.f.j.i.AsyncJobManagerImpl] (Job-Executor-77:ctx-6e8167ac) Done executing org.apache.cloudstack.api.command.user.nat.DisableStaticNatCmd for job-115
> 2014-02-13 13:53:08,631 INFO  [o.a.c.f.j.i.AsyncJobMonitor] (Job-Executor-77:ctx-6e8167ac) Remove job-115 from job monitoring
> 2014-02-13 13:53:11,461 DEBUG [c.c.a.ApiServlet] (catalina-exec-19:ctx-0fe8a59e) ===START===  10.215.2.19 -- GET  command=queryAsyncJobResult&jobId=056b6fc2-992b-4f56-ab95-49ef4c11c23e&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&_=1392333100748
> 2014-02-13 13:53:11,480 DEBUG [c.c.a.ApiServlet] (catalina-exec-19:ctx-0fe8a59e ctx-2d4834d3) ===END===  10.215.2.19 -- GET  command=queryAsyncJobResult&jobId=056b6fc2-992b-4f56-ab95-49ef4c11c23e&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&_=1392333100748
> 2014-02-13 13:53:11,644 DEBUG [c.c.a.ApiServlet] (catalina-exec-16:ctx-f4c67cd6) ===START===  10.215.2.19 -- GET  command=listPublicIpAddresses&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&id=fe78aa9f-7f82-4416-b214-bce21e4aca48&_=1392333100833
> 2014-02-13 13:53:11,664 DEBUG [c.c.a.ApiServlet] (catalina-exec-16:ctx-f4c67cd6 ctx-4ae28adb) ===END===  10.215.2.19 -- GET  command=listPublicIpAddresses&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&id=fe78aa9f-7f82-4416-b214-bce21e4aca48&_=1392333100833
> 2014-02-13 13:53:11,673 DEBUG [c.c.a.ApiServlet] (catalina-exec-25:ctx-e47be587) ===START===  10.215.2.19 -- GET  command=listZones&id=cce32d06-91d9-47f0-90b5-766416d6add2&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&_=1392333100970
> 2014-02-13 13:53:11,685 DEBUG [c.c.a.ApiServlet] (catalina-exec-25:ctx-e47be587 ctx-4ac5f0e0) ===END===  10.215.2.19 -- GET  command=listZones&id=cce32d06-91d9-47f0-90b5-766416d6add2&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&_=1392333100970
> 2014-02-13 13:53:11,740 DEBUG [c.c.a.ApiServlet] (catalina-exec-20:ctx-a240485a) ===START===  10.215.2.19 -- GET  command=listPortForwardingRules&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&ipaddressid=fe78aa9f-7f82-4416-b214-bce21e4aca48&listAll=true&_=1392333101033
> 2014-02-13 13:53:11,751 DEBUG [c.c.a.ApiServlet] (catalina-exec-20:ctx-a240485a ctx-6ca0a0a4) ===END===  10.215.2.19 -- GET  command=listPortForwardingRules&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&ipaddressid=fe78aa9f-7f82-4416-b214-bce21e4aca48&listAll=true&_=1392333101033
> 2014-02-13 13:53:11,769 DEBUG [c.c.a.ApiServlet] (catalina-exec-10:ctx-d89ab182) ===START===  10.215.2.19 -- GET  command=listLoadBalancerRules&response=json&sessionkey=gmTvf42GzX8UhbQt9iTNSIQN6yE%3D&publicipid=fe78aa9f-7f82-4416-b214-bce21e4aca48&listAll=true&_=1392333101057
> 2014-02-13 13:53:11,779 DEBUG [c.c.a.ApiServlet] (catalina-exec-10:ctx-d89ab182 ctx-daf4f706) ===END===  10.215.2.19 -- GET  command=listLoadBalancerRules&response=json&sessionkey=gmTvf42GzX8



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)