Parth Jagirdar created CLOUDSTACK-6070:
------------------------------------------
Summary: Contrail:Static NAT: Unable to create
virtual-machine-interface
Key: CLOUDSTACK-6070
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-6070
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Components: API, Contrail
Affects Versions: 4.2.1
Environment: Contrail, Xen
Reporter: Parth Jagirdar
Priority: Critical
Fix For: 4.2.1
Acquire IP, Enable Static NAT,
Choose a VM and following exception is raised. Although NAt does get enabled.
2014-02-10 10:20:21,975 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) >> 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-10 10:20:21,997 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) << Response Status: HTTP/1.1 400
Bad Request
2014-02-10 10:20:21,997 ERROR [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) create api request failed: Bad
Request
2014-02-10 10:20:21,998 ERROR [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) 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>'http://10.223.58.3:8082/virtual-machine-interfaces'</tt>
caused an error:</p>
<pre>Parent [u's-11-VM'] type virtual-machine does not
exist</pre>
</body>
</html>
2014-02-10 10:20:21,998 WARN [o.a.c.n.c.m.ContrailManager]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) 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.createFloatingIp(ContrailManagerImpl.java:791)
at
org.apache.cloudstack.network.contrail.management.ContrailElementImpl.applyIps(ContrailElementImpl.java:345)
at
com.cloud.network.IpAddressManagerImpl.applyIpAssociations(IpAddressManagerImpl.java:976)
at
com.cloud.network.IpAddressManagerImpl.applyStaticNats(IpAddressManagerImpl.java:1756)
at
com.cloud.network.rules.RulesManagerImpl.applyStaticNatForIp(RulesManagerImpl.java:1324)
at
com.cloud.network.rules.RulesManagerImpl.enableStaticNat(RulesManagerImpl.java:602)
at
com.cloud.network.rules.RulesManagerImpl.enableStaticNat(RulesManagerImpl.java:446)
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.enableStaticNat(Unknown Source)
at
org.apache.cloudstack.api.command.user.nat.EnableStaticNatCmd.execute(EnableStaticNatCmd.java:129)
at com.cloud.api.ApiDispatcher.dispatch(ApiDispatcher.java:161)
at com.cloud.api.ApiServer.queueCommand(ApiServer.java:530)
at com.cloud.api.ApiServer.handleRequest(ApiServer.java:373)
at com.cloud.api.ApiServlet.processRequestInContext(ApiServlet.java:322)
at com.cloud.api.ApiServlet.access$000(ApiServlet.java:52)
at com.cloud.api.ApiServlet$1.run(ApiServlet.java:114)
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.ApiServlet.processRequest(ApiServlet.java:111)
at com.cloud.api.ApiServlet.doGet(ApiServlet.java:73)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:617)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:717)
at
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:290)
at
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:206)
at
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:233)
at
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:191)
at
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:127)
at
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:102)
at
org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:555)
at
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:109)
at
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:298)
at
org.apache.coyote.http11.Http11NioProcessor.process(Http11NioProcessor.java:889)
at
org.apache.coyote.http11.Http11NioProtocol$Http11ConnectionHandler.process(Http11NioProtocol.java:721)
at
org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.run(NioEndpoint.java:2274)
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-10 10:20:22,007 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) >> Request: POST, /fqname-to-id,
{"type":"floating-ip-pool","fq_name":["default-domain","default-project","__default_Public__","PublicIpPool"]}
2014-02-10 10:20:22,012 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) << Response Status: HTTP/1.1 404
Not Found
2014-02-10 10:20:22,015 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) >> Request: POST,
/floating-ip-pools,
{"floating-ip-pool":{"name":"PublicIpPool","fq_name":["default-domain","default-project","__default_Public__","PublicIpPool"],"parent_type":"virtual-network"}}
2014-02-10 10:20:22,035 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) << Response Status: HTTP/1.1 200 OK
2014-02-10 10:20:22,049 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) >> Request: GET,
/floating-ip/6a6fa311-e5a0-4dfb-b289-cbad2122a756
2014-02-10 10:20:22,054 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) << Response Status: HTTP/1.1 404
Not Found
2014-02-10 10:20:22,062 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) >> Request: POST, /floating-ips,
{"floating-ip":{"floating_ip_address":"10.223.138.78","floating_ip_is_virtual_ip":false,"virtual_machine_interface_refs":[{"to":["i-2-37-VM","i-2-37-VM-0"],"attr":null,"href":null,"uuid":null}],"name":"4","uuid":"6a6fa311-e5a0-4dfb-b289-cbad2122a756","fq_name":["default-domain","default-project","__default_Public__","PublicIpPool","4"],"parent_type":"floating-ip-pool"}}
2014-02-10 10:20:22,077 INFO [n.j.c.a.ApiConnector]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) << Response Status: HTTP/1.1 200 OK
2014-02-10 10:20:22,078 DEBUG [o.a.c.n.c.m.ContrailElement]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) Successfully created floating ip:
10.223.138.78
2014-02-10 10:20:22,081 INFO [o.a.c.e.o.NetworkOrchestrator]
(catalina-exec-11:ctx-8730afff ctx-f70574dc) Let ContrailElement handle
StaticNat in network 205
2014-02-10 10:20:22,091 DEBUG [c.c.a.ApiServlet] (catalina-exec-11:ctx-8730afff
ctx-f70574dc) ===END=== 10.215.2.19 -- GET
command=enableStaticNat&response=json&sessionkey=sHulzWsJF6AFX%2BK6zhMU8MzvWis%3D&ipaddressid=6a6fa311-e5a0-4dfb-b289-cbad2122a756&virtualmachineid=e7561a28-7070-4926-8ac7-73946db98cbd&_=1392061126290
2014-02-10 10:20:26,565 DEBUG [c.c.a.m.AgentManagerImpl]
(AgentManager-Handler-6:null) SeqA 3-43386: Processing Seq 3-43386: { Cmd ,
MgmtId: -1, via: 3, Ver: v1, Flags: 11,
[{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":1,"_loadInfo":"{\n
\"connections\": [\n {\n \"id\": 4,\n \"clientInfo\": \"\",\n
\"host\": \"10.223.58.66\",\n \"port\": -1,\n \"tag\":
\"e7561a28-7070-4926-8ac7-73946db98cbd\",\n \"createTime\":
1392060836067,\n \"lastUsedTime\": 1392060845195\n }\n
]\n}","wait":0}}] }
2014-02-10 10:20:26,569 DEBUG [c.c.a.m.AgentManagerImpl]
(AgentManager-Handler-6:null) SeqA 3-43386: Sending Seq 3-43386: { Ans: ,
MgmtId: 214151488957798, via: 3, Ver: v1, Flags: 100010,
[{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
--
This message was sent by Atlassian JIRA
(v6.1.5#6160)