You are viewing a plain text version of this content. The canonical link for it is here.
Posted to issues@cloudstack.apache.org by "Tamas Monos (JIRA)" <ji...@apache.org> on 2013/06/27 19:13:24 UTC

[jira] [Comment Edited] (CLOUDSTACK-2996) Nullpointer exception on view console on vmware

    [ https://issues.apache.org/jira/browse/CLOUDSTACK-2996?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=13694876#comment-13694876 ] 

Tamas Monos edited comment on CLOUDSTACK-2996 at 6/27/13 5:13 PM:
------------------------------------------------------------------

I have found systemvm logs on the console-proxy:

16:36:34,630  WARN ConsoleProxy:74 - External authenticator failed authencation request for vm 23051082-7954-43d2-9bbe-19d37843fb18 with sid 678d40a4ee46a519
16:36:34,645  WARN ConsoleProxyAjaxHandler:78 - Failed to create viewer due to External authenticator failed request for vm 23051082-7954-43d2-9bbe-19d37843fb18 with sid 678d40a4ee46a519
com.cloud.consoleproxy.AuthenticationException: External authenticator failed request for vm 23051082-7954-43d2-9bbe-19d37843fb18 with sid 678d40a4ee46a519
        at com.cloud.consoleproxy.ConsoleProxy.authenticationExternally(ConsoleProxy.java:487)
        at com.cloud.consoleproxy.ConsoleProxy.getAjaxVncViewer(ConsoleProxy.java:428)
        at com.cloud.consoleproxy.ConsoleProxyAjaxHandler.doHandle(ConsoleProxyAjaxHandler.java:128)
        at com.cloud.consoleproxy.ConsoleProxyAjaxHandler.handle(ConsoleProxyAjaxHandler.java:47)
        at com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:65)
        at sun.net.httpserver.AuthFilter.doFilter(AuthFilter.java:65)
        at com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:68)
        at sun.net.httpserver.ServerImpl$Exchange$LinkHandler.handle(ServerImpl.java:555)
        at com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:65)
        at sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:525)
        at java.lang.Thread.run(Thread.java:662)

                
      was (Author: tamasm):
    I have found systemvm logs on the console-roxy:

16:36:34,630  WARN ConsoleProxy:74 - External authenticator failed authencation request for vm 23051082-7954-43d2-9bbe-19d37843fb18 with sid 678d40a4ee46a519
16:36:34,645  WARN ConsoleProxyAjaxHandler:78 - Failed to create viewer due to External authenticator failed request for vm 23051082-7954-43d2-9bbe-19d37843fb18 with sid 678d40a4ee46a519
com.cloud.consoleproxy.AuthenticationException: External authenticator failed request for vm 23051082-7954-43d2-9bbe-19d37843fb18 with sid 678d40a4ee46a519
        at com.cloud.consoleproxy.ConsoleProxy.authenticationExternally(ConsoleProxy.java:487)
        at com.cloud.consoleproxy.ConsoleProxy.getAjaxVncViewer(ConsoleProxy.java:428)
        at com.cloud.consoleproxy.ConsoleProxyAjaxHandler.doHandle(ConsoleProxyAjaxHandler.java:128)
        at com.cloud.consoleproxy.ConsoleProxyAjaxHandler.handle(ConsoleProxyAjaxHandler.java:47)
        at com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:65)
        at sun.net.httpserver.AuthFilter.doFilter(AuthFilter.java:65)
        at com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:68)
        at sun.net.httpserver.ServerImpl$Exchange$LinkHandler.handle(ServerImpl.java:555)
        at com.sun.net.httpserver.Filter$Chain.doFilter(Filter.java:65)
        at sun.net.httpserver.ServerImpl$Exchange.run(ServerImpl.java:525)
        at java.lang.Thread.run(Thread.java:662)

                  
> 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