You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@cloudstack.apache.org by "wangyuyang1985@163.com" <wa...@163.com> on 2015/03/26 09:52:27 UTC

CloudStack Access is denied for the console

HI,ALL!!

       open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
       test cpvm network:
       ping public ip and private ip is ok.
       
      check cpvm log
      /var/log/cloud.log throw error:error occurred in initializing rdp client null

      version 
        hyper-v agent:4.4.3 or 4.4.1
        cloudstack:4.4.2
        hyper-v :  2012 r2
        system vm template:4.4.1-7 or 4.4.0-6

     cs manage server log(/var/log/cloudstack/management/management-server.log)

     2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] } 
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA= 
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs= 
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4= 
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4= 
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] } 
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] } 
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] } 
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5 
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }

     cp vm log(/var/log/cloud.log)
  
     2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms 
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59 
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179 
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e 
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped. 
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59 
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179 
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e 
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long 
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224 
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59 
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179 
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e 
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] } 
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175 
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: { 
"connections": [ 
{ 
"id": 3, 
"clientInfo": "", 
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59", 
"port": 2179, 
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e", 
"createTime": 1427357027344, 
"lastUsedTime": 1427357028242 
} 
] 
} 
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : { 
"connections": [ 
{ 
"id": 3, 
"clientInfo": "", 
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59", 
"port": 2179, 
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e", 
"createTime": 1427357027344, 
"lastUsedTime": 1427357028242 
} 
] 
} 
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long 
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33 
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null



wangyuyang1985@163.com

Re: Re: CloudStack Access is denied for the console

Posted by "wangyuyang1985@163.com" <wa...@163.com>.
hi:
 i chang CPVM time sync to cloudstack  management server time。
can you tell me how to verified this?




wangyuyang1985@163.com
 
From: Anshul Gangwar
Date: 2015-03-26 18:05
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
Have you verified that CPVM time and management server time is in sync?
 
Regards,
Anshul
 
On 26-Mar-2015, at 2:22 pm, wangyuyang1985@163.com<ma...@163.com> wrote:
 
HI,ALL!!
 
      open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
      test cpvm network:
      ping public ip and private ip is ok.
 
     check cpvm log
     /var/log/cloud.log throw error:error occurred in initializing rdp client null
 
     version
       hyper-v agent:4.4.3 or 4.4.1
       cloudstack:4.4.2
       hyper-v :  2012 r2
       system vm template:4.4.1-7 or 4.4.0-6
 
    cs manage server log(/var/log/cloudstack/management/management-server.log)
 
    2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] }
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA=
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs=
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
 
    cp vm log(/var/log/cloud.log)
 
    2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped.
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null
 
 
 
wangyuyang1985@163.com<ma...@163.com>
 

Re: CloudStack Access is denied for the console

Posted by Anshul Gangwar <an...@citrix.com>.
Are they on the same timezone?

Below error points  to that only unless somebody is modifying request in between.
Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=

Regards,
Anshul

On 26-Mar-2015, at 4:38 pm, wangyuyang1985@163.com<ma...@163.com> wrote:

yes,i set the CPVM time sync to management server ,but also get the error.
thanks.


wangyuyang1985@163.com<ma...@163.com>

From: Anshul Gangwar
Date: 2015-03-26 18:49
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
You can set using date command from terminal. All you need to make sure that it is within the 2 minute window of management server.

Regards,
Anshul

On 26-Mar-2015, at 4:03 pm, wangyuyang1985@163.com<ma...@163.com> wrote:

hi:
how set  CPVM time and management server time  sync?
CPVM not has ntpdate lib.
thanks!



wangyuyang1985@163.com<ma...@163.com>

From: Anshul Gangwar
Date: 2015-03-26 18:05
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
Have you verified that CPVM time and management server time is in sync?

Regards,
Anshul

On 26-Mar-2015, at 2:22 pm, wangyuyang1985@163.com<ma...@163.com> wrote:

HI,ALL!!

    open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
    test cpvm network:
    ping public ip and private ip is ok.

   check cpvm log
   /var/log/cloud.log throw error:error occurred in initializing rdp client null

   version
     hyper-v agent:4.4.3 or 4.4.1
     cloudstack:4.4.2
     hyper-v :  2012 r2
     system vm template:4.4.1-7 or 4.4.0-6

  cs manage server log(/var/log/cloudstack/management/management-server.log)

  2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] }
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA=
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs=
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }

  cp vm log(/var/log/cloud.log)

  2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped.
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null



wangyuyang1985@163.com<ma...@163.com>




Re: Re: CloudStack Access is denied for the console

Posted by "wangyuyang1985@163.com" <wa...@163.com>.
yes,i set the CPVM time sync to management server ,but also get the error.
thanks.


wangyuyang1985@163.com
 
From: Anshul Gangwar
Date: 2015-03-26 18:49
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
You can set using date command from terminal. All you need to make sure that it is within the 2 minute window of management server.
 
Regards,
Anshul
 
On 26-Mar-2015, at 4:03 pm, wangyuyang1985@163.com<ma...@163.com> wrote:
 
hi:
how set  CPVM time and management server time  sync?
CPVM not has ntpdate lib.
thanks!
 
 
 
wangyuyang1985@163.com<ma...@163.com>
 
From: Anshul Gangwar
Date: 2015-03-26 18:05
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
Have you verified that CPVM time and management server time is in sync?
 
Regards,
Anshul
 
On 26-Mar-2015, at 2:22 pm, wangyuyang1985@163.com<ma...@163.com> wrote:
 
HI,ALL!!
 
     open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
     test cpvm network:
     ping public ip and private ip is ok.
 
    check cpvm log
    /var/log/cloud.log throw error:error occurred in initializing rdp client null
 
    version
      hyper-v agent:4.4.3 or 4.4.1
      cloudstack:4.4.2
      hyper-v :  2012 r2
      system vm template:4.4.1-7 or 4.4.0-6
 
   cs manage server log(/var/log/cloudstack/management/management-server.log)
 
   2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] }
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA=
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs=
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
 
   cp vm log(/var/log/cloud.log)
 
   2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped.
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null
 
 
 
wangyuyang1985@163.com<ma...@163.com>
 
 

Re: CloudStack Access is denied for the console

Posted by Anshul Gangwar <an...@citrix.com>.
You can set using date command from terminal. All you need to make sure that it is within the 2 minute window of management server.

Regards,
Anshul

On 26-Mar-2015, at 4:03 pm, wangyuyang1985@163.com<ma...@163.com> wrote:

hi:
how set  CPVM time and management server time  sync?
CPVM not has ntpdate lib.
thanks!



wangyuyang1985@163.com<ma...@163.com>

From: Anshul Gangwar
Date: 2015-03-26 18:05
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
Have you verified that CPVM time and management server time is in sync?

Regards,
Anshul

On 26-Mar-2015, at 2:22 pm, wangyuyang1985@163.com<ma...@163.com> wrote:

HI,ALL!!

     open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
     test cpvm network:
     ping public ip and private ip is ok.

    check cpvm log
    /var/log/cloud.log throw error:error occurred in initializing rdp client null

    version
      hyper-v agent:4.4.3 or 4.4.1
      cloudstack:4.4.2
      hyper-v :  2012 r2
      system vm template:4.4.1-7 or 4.4.0-6

   cs manage server log(/var/log/cloudstack/management/management-server.log)

   2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] }
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA=
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs=
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }

   cp vm log(/var/log/cloud.log)

   2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped.
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null



wangyuyang1985@163.com<ma...@163.com>



Re: Re: CloudStack Access is denied for the console

Posted by "wangyuyang1985@163.com" <wa...@163.com>.
hi:
how set  CPVM time and management server time  sync?
CPVM not has ntpdate lib.
thanks!



wangyuyang1985@163.com
 
From: Anshul Gangwar
Date: 2015-03-26 18:05
To: dev@cloudstack.apache.org
Subject: Re: CloudStack Access is denied for the console
Have you verified that CPVM time and management server time is in sync?
 
Regards,
Anshul
 
On 26-Mar-2015, at 2:22 pm, wangyuyang1985@163.com<ma...@163.com> wrote:
 
HI,ALL!!
 
      open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
      test cpvm network:
      ping public ip and private ip is ok.
 
     check cpvm log
     /var/log/cloud.log throw error:error occurred in initializing rdp client null
 
     version
       hyper-v agent:4.4.3 or 4.4.1
       cloudstack:4.4.2
       hyper-v :  2012 r2
       system vm template:4.4.1-7 or 4.4.0-6
 
    cs manage server log(/var/log/cloudstack/management/management-server.log)
 
    2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] }
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA=
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs=
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
 
    cp vm log(/var/log/cloud.log)
 
    2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped.
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null
 
 
 
wangyuyang1985@163.com<ma...@163.com>
 

Re: CloudStack Access is denied for the console

Posted by Anshul Gangwar <an...@citrix.com>.
Have you verified that CPVM time and management server time is in sync?

Regards,
Anshul

On 26-Mar-2015, at 2:22 pm, wangyuyang1985@163.com<ma...@163.com> wrote:

HI,ALL!!

      open vm console in chrome,throw faile: Access is denied for the console session. Please close the window and retry again
      test cpvm network:
      ping public ip and private ip is ok.

     check cpvm log
     /var/log/cloud.log throw error:error occurred in initializing rdp client null

     version
       hyper-v agent:4.4.3 or 4.4.1
       cloudstack:4.4.2
       hyper-v :  2012 r2
       system vm template:4.4.1-7 or 4.4.0-6

    cs manage server log(/var/log/cloudstack/management/management-server.log)

    2015-03-26 14:42:02,052 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Processing Seq 5-185: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleAccessAuthenticationCommand":{"_host":"C8948337-5798-4CCE-AF70-88A492DBFC59","_port":"2179","_vmId":"e8b6b638-c242-4967-9c6c-31e713ec9e4e","_sid":"48c46e43d09d45d8","_ticket":"30iCc6wPoNRkDPTAAoLKLUAcZhA=","_isReauthenticating":false,"wait":0}}] }
2015-03-26 14:42:02,053 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in url for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is 30iCc6wPoNRkDPTAAoLKLUAcZhA=
2015-03-26 14:42:02,054 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 1 minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is mt6IJaCS7K8QSlXl65POQ/Fl/xs=
2015-03-26 14:42:02,055 DEBUG [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Console authentication. Ticket in 2-minute boundary for C8948337-5798-4CCE-AF70-88A492DBFC59:2179-e8b6b638-c242-4967-9c6c-31e713ec9e4e is QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,055 ERROR [c.c.c.AgentHookBase] (AgentManager-Handler-2:null) Access ticket expired or has been modified. vmId: e8b6b638-c242-4967-9c6c-31e713ec9e4eticket in URL: 30iCc6wPoNRkDPTAAoLKLUAcZhA=, tickets to check against: mt6IJaCS7K8QSlXl65POQ/Fl/xs=,QY7JHae79ImLfKHWWD5YTw6Fho4=
2015-03-26 14:42:02,057 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-2:null) SeqA 5-185: Sending Seq 5-185: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":false,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 14:42:06,027 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Processing Seq 5-186: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }
2015-03-26 14:42:06,038 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-4:null) SeqA 5-186: Sending Seq 5-186: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.AgentControlAnswer":{"result":true,"wait":0}}] }
2015-03-26 14:42:08,754 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-5:null) Ping from 5
2015-03-26 14:42:11,035 DEBUG [c.c.a.m.AgentManagerImpl] (AgentManager-Handler-6:null) SeqA 5-188: Processing Seq 5-188: { Cmd , MgmtId: -1, via: 5, Ver: v1, Flags: 11, [{"com.cloud.agent.api.ConsoleProxyLoadReportCommand":{"_proxyVmId":10,"_loadInfo":"{\n \"connections\": [\n {\n \"id\": 1,\n \"clientInfo\": \"\",\n \"host\": \"C8948337-5798-4CCE-AF70-88A492DBFC59\",\n \"port\": 2179,\n \"tag\": \"e8b6b638-c242-4967-9c6c-31e713ec9e4e\",\n \"createTime\": 1427351854018,\n \"lastUsedTime\": 1427352118366\n }\n ]\n}","wait":0}}] }

    cp vm log(/var/log/cloud.log)

    2015-03-26 08:03:48,225 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-307:null) /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=2&ts=1427357028151Process time 3 ms
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. port: 2179
2015-03-26 08:03:48,239 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-308:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:48,463 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-300:null) Receiver thread stopped.
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. port: 2179
2015-03-26 08:03:51,299 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-309:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,300 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) Front end has been idle for too long
2015-03-26 08:03:51,302 DEBUG [cloud.consoleproxy.ConsoleProxyAjaxImageHandler] (Thread-310:null) AjaxImageHandler /ajaximg?token=R8PmzJ5hl-JHQiy47HEarljkCuE5kPEZuUBbHzE5lsd1baTwi7c9dtRojjBXDtszcodh-PgAht5KFaw8j0e90dfTA5Hf2mxVolCKQ-GlbcnXk5Gbo1Z5eqH-ABH9tkujR612H-9k_T7ZKf2jJiaDMbfa8QH5d-fa85HgK1LYAUzYKqOnOOhO56f5-hJDhmo1wAVf5oZ3JtuRtGMSkzEp0F2Z3HQqe7o9Q0AT0k6M3tSxg08uGfJIAz1_AIal0Xr1V-qada2sEU_AK5kjxvT7KMiOXnhooRI8q4HtnYuaQELfcenKQWYtMLaPtAVhM6l86Eb5oJmD0y2VzGqvcT8nWCVR1OsohGk__GNAHQnxqRVAcX0YxXqP5y_lX-9g1asW9hQnJ845FI96it3aE7MsJg&key=3&ts=1427357031224
2015-03-26 08:03:51,303 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. host: C8948337-5798-4CCE-AF70-88A492DBFC59
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. port: 2179
2015-03-26 08:03:51,304 DEBUG [cloud.consoleproxy.ConsoleProxyHttpHandlerHelper] (Thread-310:null) decode token. tag: e8b6b638-c242-4967-9c6c-31e713ec9e4e
2015-03-26 08:03:51,358 DEBUG [cloud.agent.Agent] (Agent-Handler-2:null) Received response: Seq 5-832: { Ans: , MgmtId: 2450559922832, via: 5, Ver: v1, Flags: 100010, [{"com.cloud.agent.api.ConsoleAccessAuthenticationAnswer":{"_success":true,"_isReauthenticating":false,"_port":0,"result":true,"wait":0}}] }
2015-03-26 08:03:51,361 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-309:null) connecting to instance C8948337-5798-4CCE-AF70-88A492DBFC59 on host 192.168.212.175
2015-03-26 08:03:51,364 DEBUG [resource.consoleproxy.ConsoleProxyResource] (Thread-309:null) Report proxy load info, proxy : 10, load: {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,364 DEBUG [cloud.consoleproxy.ConsoleProxy] (Thread-309:null) Report load change : {
"connections": [
{
"id": 3,
"clientInfo": "",
"host": "C8948337-5798-4CCE-AF70-88A492DBFC59",
"port": 2179,
"tag": "e8b6b638-c242-4967-9c6c-31e713ec9e4e",
"createTime": 1427357027344,
"lastUsedTime": 1427357028242
}
]
}
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) Front end has been idle for too long
2015-03-26 08:03:51,365 INFO [cloud.consoleproxy.ConsoleProxy] (Thread-310:null) The rfb thread died, reinitializing the viewer com.cloud.consoleproxy.ConsoleProxyRdpClient@5c9c2c33
2015-03-26 08:03:51,366 INFO [cloud.consoleproxy.ConsoleProxyRdpClient] (Thread-310:null) error occurred in initializing rdp client null



wangyuyang1985@163.com<ma...@163.com>