You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Rohit Yadav (JIRA)" <ji...@apache.org> on 2015/03/17 09:54:38 UTC
[jira] [Closed] (CLOUDSTACK-8331) VR will not start
[ https://issues.apache.org/jira/browse/CLOUDSTACK-8331?page=com.atlassian.jira.plugin.system.issuetabpanels:all-tabpanel ]
Rohit Yadav closed CLOUDSTACK-8331.
-----------------------------------
Resolution: Fixed
Fixed, now savepassword.sh will try all interfaces.
> VR will not start
> ------------------
>
> Key: CLOUDSTACK-8331
> URL: https://issues.apache.org/jira/browse/CLOUDSTACK-8331
> Project: CloudStack
> Issue Type: Bug
> Security Level: Public(Anyone can view this level - this is the default.)
> Components: Virtual Router
> Affects Versions: 4.5.1
> Reporter: Abhinandan Prateek
> Assignee: Rohit Yadav
> Priority: Blocker
> Fix For: 4.5.1
>
>
> The VR is unreachable due to failure to save password. Relevant parts of the log are:
> 2015-03-14 20:12:56,395 DEBUG [c.c.a.t.Request] (Work-Job-Executor-3:ctx-325477a4 job-19/job-20 ctx-f1392b6e) Seq 1-3218384883709640791: Sending { Cmd , MgmtId: 345043735628, via: 1(xen651), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.routing.SavePasswordCommand":{,"vmIpAddress":"10.1.1.101","vmName":"VM-4c266b62-36b2-43ce-9c04-eea97449ee45","executeInSequence":false,"accessDetails":{"zone.network.type":"Advanced","router.name":"r-4-VM","router.ip":"169.254.0.16","router.guest.ip":"10.1.1.1"},"wait":0}},{"com.cloud.agent.api.routing.VmDataCommand":{"vmIpAddress":"10.1.1.101","vmName":"VM-4c266b62-36b2-43ce-9c04-eea97449ee45","executeInSequence":false,"accessDetails":{"zone.network.type":"Advanced","router.name":"r-4-VM","router.ip":"169.254.0.16","router.guest.ip":"10.1.1.1"},"wait":0}}] }
> 2015-03-14 20:12:56,396 DEBUG [c.c.a.t.Request] (Work-Job-Executor-3:ctx-325477a4 job-19/job-20 ctx-f1392b6e) Seq 1-3218384883709640791: Executing: { Cmd , MgmtId: 345043735628, via: 1(xen651), Ver: v1, Flags: 100011, [{"com.cloud.agent.api.routing.SavePasswordCommand":{,"vmIpAddress":"10.1.1.101","vmName":"VM-4c266b62-36b2-43ce-9c04-eea97449ee45","executeInSequence":false,"accessDetails":{"zone.network.type":"Advanced","router.name":"r-4-VM","router.ip":"169.254.0.16","router.guest.ip":"10.1.1.1"},"wait":0}},{"com.cloud.agent.api.routing.VmDataCommand":{"vmIpAddress":"10.1.1.101","vmName":"VM-4c266b62-36b2-43ce-9c04-eea97449ee45","executeInSequence":false,"accessDetails":{"zone.network.type":"Advanced","router.name":"r-4-VM","router.ip":"169.254.0.16","router.guest.ip":"10.1.1.1"},"wait":0}}] }
> 2015-03-14 20:12:56,397 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-49:ctx-893edf61) Seq 1-3218384883709640791: Executing request
> 2015-03-14 20:12:56,397 DEBUG [c.c.h.x.r.CitrixResourceBase] (DirectAgent-49:ctx-893edf61) Executing command in VR: /opt/cloud/bin/router_proxy.sh savepassword.sh 169.254.0.16 -v 10.1.1.101 -p sY2evk
> 2015-03-14 20:12:58,447 DEBUG [c.c.a.ApiServlet] (1720400359@qtp-837591326-8:ctx-efacc4aa) ===START=== 192.168.100.4 -- GET command=queryAsyncJobResult&jobId=f0a6798b-35c4-4f56-bb72-d3a57a5c7746&response=json&sessionkey=2C%2BRRM0GYLK%2FOD5YXwNgZVDsHJw%3D&_=1426577384035
> 2015-03-14 20:12:58,457 DEBUG [c.c.a.ApiServlet] (1720400359@qtp-837591326-8:ctx-efacc4aa ctx-9349eaec) ===END=== 192.168.100.4 -- GET command=queryAsyncJobResult&jobId=f0a6798b-35c4-4f56-bb72-d3a57a5c7746&response=json&sessionkey=2C%2BRRM0GYLK%2FOD5YXwNgZVDsHJw%3D&_=1426577384035
> 2015-03-14 20:12:58,968 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-13:null) SeqA 2-331: Processing Seq 2-331: { Cmd , MgmtId: -1, via: 2, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":1,"_loadInfo":"{\n \"connections\": []\n}","wait":0}}] }
> 2015-03-14 20:12:58,971 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-13:null) SeqA 2-331: Sending Seq 2-331: { Ans: , MgmtId: 345043735628, via: 2, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
> 2015-03-14 20:12:59,990 INFO [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-4d07a070) Begin cleanup expired async-jobs
> 2015-03-14 20:12:59,993 INFO [o.a.c.f.j.i.AsyncJobManagerImpl] (AsyncJobMgr-Heartbeat-1:ctx-4d07a070) End cleanup expired async-jobs
> 2015-03-14 20:13:01,450 DEBUG [c.c.a.ApiServlet] (1720400359@qtp-837591326-8:ctx-e70924b9) ===START=== 192.168.100.4 -- GET command=queryAsyncJobResult&jobId=f0a6798b-35c4-4f56-bb72-d3a57a5c7746&response=json&sessionkey=2C%2BRRM0GYLK%2FOD5YXwNgZVDsHJw%3D&_=1426577387038
> 2015-03-14 20:13:01,467 DEBUG [c.c.a.ApiServlet] (1720400359@qtp-837591326-8:ctx-e70924b9 ctx-54e03c08) ===END=== 192.168.100.4 -- GET command=queryAsyncJobResult&jobId=f0a6798b-35c4-4f56-bb72-d3a57a5c7746&response=json&sessionkey=2C%2BRRM0GYLK%2FOD5YXwNgZVDsHJw%3D&_=1426577387038
> 2015-03-14 20:13:01,640 ERROR [c.c.u.s.SshHelper] (DirectAgent-49:ctx-893edf61) SSH execution of command /opt/cloud/bin/router_proxy.sh savepassword.sh 169.254.0.16 -v 10.1.1.101 -p sY2evk has an error status code in return. result output: % Total % Received % Xferd Average Speed Time Time Time Current
> Dload Upload Total Spent Left Speed
> 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) couldn't connect to host
> 2015-03-14 20:13:01,640 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-49:ctx-893edf61) Seq 1-3218384883709640791: Cancelling because one of the answers is false and it is stop on error.
> 2015-03-14 20:13:01,640 DEBUG [c.c.a.m.DirectAgentAttache] (DirectAgent-49:ctx-893edf61) Seq 1-3218384883709640791: Response Received:
> 2015-03-14 20:13:01,640 DEBUG [c.c.a.t.Request] (DirectAgent-49:ctx-893edf61) Seq 1-3218384883709640791: Processing: { Ans: , MgmtId: 345043735628, via: 1, Ver: v1, Flags: 10, [{"com.cloud.agent.api.Answer":{"result":false,"details":" % Total % Received % Xferd Average Speed Time Time Time Current\n Dload Upload Total Spent Left Speed\n\r 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0curl: (7) couldn't connect to host\n","wait":0}}] }
> 2015-03-14 20:13:01,640 DEBUG [c.c.a.t.Request] (Work-Job-Executor-3:ctx-325477a4 job-19/job-20 ctx-f1392b6e) Seq 1-3218384883709640791: Received: { Ans: , MgmtId: 345043735628, via: 1, Ver: v1, Flags: 10, { Answer } }
> 2015-03-14 20:13:01,642 INFO [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-3:ctx-325477a4 job-19/job-20 ctx-f1392b6e) Unable to contact resource.
> com.cloud.exception.ResourceUnavailableException: Resource [DataCenter:1] is unreachable: Unable to apply userdata and password entry on router
> at com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyRules(VirtualNetworkApplianceManagerImpl.java:4089)
> at com.cloud.network.router.VirtualNetworkApplianceManagerImpl.applyUserData(VirtualNetworkApplianceManagerImpl.java:3283)
> 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.$Proxy196.applyUserData(Unknown Source)
> at com.cloud.network.element.VirtualRouterElement.addPasswordAndUserdata(VirtualRouterElement.java:948)
> at org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepareElement(NetworkOrchestrator.java:1250)
> at org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepareNic(NetworkOrchestrator.java:1367)
> at org.apache.cloudstack.engine.orchestration.NetworkOrchestrator.prepare(NetworkOrchestrator.java:1303)
> at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:980)
> at com.cloud.vm.VirtualMachineManagerImpl.orchestrateStart(VirtualMachineManagerImpl.java:4471)
> 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 com.cloud.vm.VmWorkJobHandlerProxy.handleVmWorkJob(VmWorkJobHandlerProxy.java:107)
> at com.cloud.vm.VirtualMachineManagerImpl.handleVmWorkJob(VirtualMachineManagerImpl.java:4627)
> at com.cloud.vm.VmWorkJobDispatcher.runJob(VmWorkJobDispatcher.java:103)
> at org.apache.cloudstack.framework.jobs.impl.AsyncJobManagerImpl$5.runInContext(AsyncJobManagerImpl.java:537)
> 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:494)
> 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:745)
> 2015-03-14 20:13:01,644 DEBUG [c.c.v.VirtualMachineManagerImpl] (Work-Job-Executor-3:ctx-325477a4 job-19/job-20 ctx-f1392b6e) Cleaning up resources for the vm VM[User|i-2-3-VM] in Starting state
--
This message was sent by Atlassian JIRA
(v6.3.4#6332)