Tamas Monos created CLOUDSTACK-2996:
---------------------------------------
Summary: Nullpointer exception on view console on vmware
Key: CLOUDSTACK-2996
URL: https://issues.apache.org/jira/browse/CLOUDSTACK-2996
Project: CloudStack
Issue Type: Bug
Security Level: Public (Anyone can view this level - this is the default.)
Components: VNC Proxy
Affects Versions: 4.1.0
Environment: VMware 5.1 with CentOS 6
Reporter: Tamas Monos
Priority: Critical
Hi,
After 3.0.2->4.1 upgrade I cannot use the view-console function in the UI.
I always get "Access is denied for the console session. Please close the window
and retry again"
In the management-server log I find lots of nullpointer exceptions:
2013-06-13 16:20:14,561 DEBUG [vmware.mo.HostMO]
(DirectAgent-56:esxw1.veber.co.uk) find VM i-2-5-VM on host
2013-06-13 16:20:14,562 DEBUG [vmware.mo.HostMO]
(DirectAgent-56:esxw1.veber.co.uk) load VM cache on host
2013-06-13 16:20:15,000 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-56:null) Seq 2-205195617: Response Received:
2013-06-13 16:20:15,000 DEBUG [agent.transport.Request] (StatsCollector-1:null)
Seq 2-205195617: Received: { Ans: , MgmtId: 345049205465, via: 2, Ver: v1,
Flags: 10, { GetVmStatsAnswer } }
2013-06-13 16:20:19,142 DEBUG [agent.transport.Request]
(AgentManager-Handler-13:null) Seq 2-1681524997: Executing: { Cmd , MgmtId:
345049213916, via: 2, Ver: v1, Flags: 100011, [{"GetVncPortCommand":{"id
":5,"name":"i-2-5-VM","wait":0}}] }
2013-06-13 16:20:19,142 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-41:null) Seq 2-1681524997: Executing request
2013-06-13 16:20:19,143 DEBUG [vmware.mo.HostMO]
(DirectAgent-41:esxw1.veber.co.uk) find VM i-2-5-VM on host
2013-06-13 16:20:19,143 DEBUG [vmware.mo.HostMO]
(DirectAgent-41:esxw1.veber.co.uk) load VM cache on host
2013-06-13 16:20:20,503 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-41:null) Seq 2-1681524997: Response Received:
2013-06-13 16:20:20,503 DEBUG [agent.manager.ClusteredAgentManagerImpl]
(DirectAgent-41:null) Seq 2-1681524997: MgmtId 345049213916: Resp: Routing to
peer
2013-06-13 16:20:22,838 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-14:null) SeqA 4-1561: Processing Seq 4-1561: { Cmd ,
MgmtId: -1, via: 4, Ver: v1, Flags: 11,
[{"ConsoleAccessAuthenticationCommand":{"_host":"192.168.1.8","_port":"5908","_vmId":"18b5fb46-5802-421f-beba-1656674ccd86","_sid":"abddf0e66a4610b3","_ticket":"EBf0KlF4mayF4/Ueu50EFGS5uls=","_isReauthenticating":false,"wait":0}}]
}
2013-06-13 16:20:22,838 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
(AgentManager-Handler-14:null) Console authentication. Ticket in url for
192.168.1.8:5908-18b5fb46-5802-421f-beba-1656674ccd86 is
EBf0KlF4mayF4/Ueu50EFGS5uls=
2013-06-13 16:20:22,839 ERROR [cloud.servlet.ConsoleProxyServlet]
(AgentManager-Handler-14:null) Unexpected exception
java.lang.NullPointerException
at
com.cloud.servlet.ConsoleProxyServlet.genAccessTicket(ConsoleProxyServlet.java:429)
at
com.cloud.servlet.ConsoleProxyServlet.genAccessTicket(ConsoleProxyServlet.java:418)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.onConsoleAccessAuthentication(ConsoleProxyManagerImpl.java:906)
at
com.cloud.consoleproxy.ConsoleProxyListener.processControlCommand(ConsoleProxyListener.java:61)
at
com.cloud.agent.manager.AgentManagerImpl.handleControlCommand(AgentManagerImpl.java:348)
at
com.cloud.agent.manager.AgentManagerImpl.access$200(AgentManagerImpl.java:145)
at
com.cloud.agent.manager.AgentManagerImpl$AgentHandler.processRequest(AgentManagerImpl.java:1286)
at
com.cloud.agent.manager.AgentManagerImpl$AgentHandler.doTask(AgentManagerImpl.java:1374)
at
com.cloud.agent.manager.ClusteredAgentManagerImpl$ClusteredAgentHandler.doTask(ClusteredAgentManagerImpl.java:659)
at com.cloud.utils.nio.Task.run(Task.java:83)
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:679)
2013-06-13 16:20:22,839 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
(AgentManager-Handler-14:null) Console authentication. Ticket in 1 minute
boundary for 192.168.1.8:5908-18b5fb46-5802-421f-beba-1656674ccd86 is
2013-06-13 16:20:22,839 ERROR [cloud.servlet.ConsoleProxyServlet]
(AgentManager-Handler-14:null) Unexpected exception
java.lang.NullPointerException
at
com.cloud.servlet.ConsoleProxyServlet.genAccessTicket(ConsoleProxyServlet.java:429)
at
com.cloud.consoleproxy.ConsoleProxyManagerImpl.onConsoleAccessAuthentication(ConsoleProxyManagerImpl.java:914)
at
com.cloud.consoleproxy.ConsoleProxyListener.processControlCommand(ConsoleProxyListener.java:61)
at
com.cloud.agent.manager.AgentManagerImpl.handleControlCommand(AgentManagerImpl.java:348)
at
com.cloud.agent.manager.AgentManagerImpl.access$200(AgentManagerImpl.java:145)
at
com.cloud.agent.manager.AgentManagerImpl$AgentHandler.processRequest(AgentManagerImpl.java:1286)
at
com.cloud.agent.manager.AgentManagerImpl$AgentHandler.doTask(AgentManagerImpl.java:1374)
at
com.cloud.agent.manager.ClusteredAgentManagerImpl$ClusteredAgentHandler.doTask(ClusteredAgentManagerImpl.java:659)
at com.cloud.utils.nio.Task.run(Task.java:83)
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:679)
2013-06-13 16:20:22,840 DEBUG [cloud.consoleproxy.ConsoleProxyManagerImpl]
(AgentManager-Handler-14:null) Console authentication. Ticket in 2-minute
boundary for 192.168.1.8:5908-18b5fb46-5802-421f-beba-1656674ccd86 is
2013-06-13 16:20:22,840 ERROR [cloud.consoleproxy.ConsoleProxyManagerImpl]
(AgentManager-Handler-14:null) Access ticket expired or has been modified.
vmId: 18b5fb46-5802-421f-beba-1656674ccd86ticket in URL:
EBf0KlF4mayF4/Ueu50EFGS5uls=, tickets to check against: ,
2013-06-13 16:20:22,840 DEBUG [agent.manager.AgentManagerImpl]
(AgentManager-Handler-14:null) SeqA 4-1561: Sending Seq 4-1561: { Ans: ,
MgmtId: 345049205465, via: 4, Ver: v1, Flags: 100010,
[{"ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}]
}
2013-06-13 16:20:31,100 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-177:null) Seq 2-1681524998: Executing request
2013-06-13 16:20:31,907 DEBUG [vmware.mo.HostMO]
(DirectAgent-177:esxw1.veber.co.uk) find VM i-2-5-VM on host
2013-06-13 16:20:31,908 DEBUG [vmware.mo.HostMO]
(DirectAgent-177:esxw1.veber.co.uk) load VM cache on host
2013-06-13 16:20:32,416 DEBUG [agent.manager.DirectAgentAttache]
(DirectAgent-177:null) Seq 2-1681524998: Response Received:
Is it me doing something wrong somewhere?
Regards
--
This message is automatically generated by JIRA.
If you think it was sent incorrectly, please contact your JIRA administrators
For more information on JIRA, see: http://www.atlassian.com/software/jira
