Cisco Support Community
cancel
Showing results for 
Search instead for 
Did you mean: 
Announcements

Welcome to Cisco Support Community. We would love to have your feedback.

For an introduction to the new site, click here. If you'd prefer to explore, try our test area to get started. And see here for current known issues.

New Member

UCCX CAD - Reserved but phone not ringing

Hi guys,

When I am trying to call my UCCX application, my CAD will go to reserved state but the phone is not ringing. Below are the logs. Please advise where I did wrong. Attach also the script configuration.

script.png

                  

2014-02-23 17:24:02:484 DEBUG [0xf28] ssRecoveryThread.cpp[51] ssEnterpriseClient::recoveryThread: Wait timed out

2014-02-23 17:24:02:484 DEBUG [0xf28] ssRecoveryThread.cpp[38] ssEnterpriseClient::recoveryThread: Waiting for recovery message.....

2014-02-23 17:24:08:359 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:08:359 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is RESERVED

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 8

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 3

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:08:359 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  RESERVED  NextAgentState LOGIN

2014-02-23 17:24:08:359 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:08:359 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:08:359 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_SELECTED>, <ReasonCode=0>

2014-02-23 17:24:08:359 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_SELECTED, businessCall <false>, display business call only <true>

2014-02-23 17:24:08:359 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_SELECTED with reason code 0

2014-02-23 17:24:08:359 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Selected>, Transitions <00090000>, ReasonCode <>

2014-02-23 17:24:08:359 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:08:359 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Selected, stateTransitionMask: 589824, reasonCode: .

2014-02-23 17:24:08:359 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:08:359 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:08:359 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:08:359 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:08:359 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:08:359 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:08:359 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_READY         agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:08:359 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540081', 1393146723}, 250, 'jbond', 'jbond', 20, 0, 35)

2014-02-23 17:24:08:406 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:08:406 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:08:406 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_SELECTED

2014-02-23 17:24:08:406 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_SELECTED and new callID 0.

2014-02-23 17:24:08:406 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:08:406 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:08:406 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:08:406 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:08:406 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is AVAILABLE

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 3

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 4294967295

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:08:406 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  AVAILABLE  NextAgentState LOGIN

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_READY       

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_READY        >, <ReasonCode=0>

2014-02-23 17:24:08:406 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_READY        , businessCall <false>, display business call only <true>

2014-02-23 17:24:08:406 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_READY         with reason code 0

2014-02-23 17:24:08:406 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Ready>, Transitions <00090065>, ReasonCode <>

2014-02-23 17:24:08:406 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:08:406 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Ready, stateTransitionMask: 589925, reasonCode: .

2014-02-23 17:24:08:406 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:08:421 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:08:421 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_SELECTED agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:08:421 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540082', 1393146723}, 0, 'jbond', 'jbond', 35, 0, 20)

2014-02-23 17:24:08:421 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_READY       

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[1429] CAppearanceEventWnd::ProcessEvent: Calling NewEventNotification....

2014-02-23 17:24:08:421 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_READY         and new callID 0.

2014-02-23 17:24:08:421 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: Entering with CallID: 0, Event type: <Ready>, Management type: <EMT_AGENT>

2014-02-23 17:24:08:421 DEBUG [0x204] EventList.cpp[26] CEventList::FindEvent: BEGIN find Ready for EMT_AGENT

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[2112] CAppearanceEventWnd::CheckEventRules: Rule: <Default>, Event Name: <Ready> evaluates to <true>

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[2150] CAppearanceEventWnd::CheckEventRules: No actions to execute.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[2157] CAppearanceEventWnd::CheckEventRules: Leaving

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: End.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_READY       

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_DIVERTED_EVENT>.

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2355] GetDebugInfo: CALL_DIVERTED_EVENT: MonitorID = 6012

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2356] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2357] GetDebugInfo: CALL_DIVERTED_EVENT: LocalConnectionState = LCS_FAIL

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2358] GetDebugInfo: CALL_DIVERTED_EVENT: EventCause = CEC_CALL_NOT_ANSWERED

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2359] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionDeviceID = 6012

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2360] GetDebugInfo: CALL_DIVERTED_EVENT: DivertingDeviceID = 6012

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2361] GetDebugInfo: CALL_DIVERTED_EVENT: CalledDeviceID = 6012

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:16782297, CallState:CS_DISCONNECTED

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=16782297>, <new CallID=0>, <CallState=CS_DISCONNECTED >, <ReasonCode=0>

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:16782297, CallState:CS_DISCONNECTED , businessCall <false>, display business call only <true>

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[1890] OnCallDivertedEvent: RNA call dropped with callid 16782297

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:08:421 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is RESERVED

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 8

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 3

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:08:421 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  RESERVED  NextAgentState LOGIN

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_SELECTED>, <ReasonCode=0>

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_SELECTED, businessCall <false>, display business call only <true>

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_SELECTED with reason code 0

2014-02-23 17:24:08:421 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Selected>, Transitions <00090000>, ReasonCode <>

2014-02-23 17:24:08:421 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Selected, stateTransitionMask: 589824, reasonCode: .

2014-02-23 17:24:08:421 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:08:421 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:08:421 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_READY         agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:08:421 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540083', 1393146723}, 0, 'jbond', 'jbond', 20, 0, 35)

2014-02-23 17:24:08:421 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:08:421 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_SELECTED

2014-02-23 17:24:08:421 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_SELECTED and new callID 0.

2014-02-23 17:24:08:421 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:08:421 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:08:437 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:08:437 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:08:437 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:08:437 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:08:453 DEBUG [0x204] CJToolbars.cpp[680] CCJMainToolBars::CheckButton: set check for <Ready> to false

2014-02-23 17:24:09:281 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:09:281 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is AVAILABLE

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 3

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 4294967295

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:09:281 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  AVAILABLE  NextAgentState LOGIN

2014-02-23 17:24:09:281 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_READY       

2014-02-23 17:24:09:281 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:09:281 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_READY        >, <ReasonCode=0>

2014-02-23 17:24:09:281 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_READY        , businessCall <false>, display business call only <true>

2014-02-23 17:24:09:281 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_READY         with reason code 0

2014-02-23 17:24:09:281 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Ready>, Transitions <00090065>, ReasonCode <>

2014-02-23 17:24:09:281 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:09:281 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Ready, stateTransitionMask: 589925, reasonCode: .

2014-02-23 17:24:09:281 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:09:281 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:09:281 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:09:281 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:09:281 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:09:281 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:09:281 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_SELECTED agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:09:281 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540084', 1393146723}, 1, 'jbond', 'jbond', 35, 0, 20)

2014-02-23 17:24:09:296 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_READY       

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[1429] CAppearanceEventWnd::ProcessEvent: Calling NewEventNotification....

2014-02-23 17:24:09:296 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_READY         and new callID 0.

2014-02-23 17:24:09:296 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: Entering with CallID: 0, Event type: <Ready>, Management type: <EMT_AGENT>

2014-02-23 17:24:09:296 DEBUG [0x204] EventList.cpp[26] CEventList::FindEvent: BEGIN find Ready for EMT_AGENT

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[2112] CAppearanceEventWnd::CheckEventRules: Rule: <Default>, Event Name: <Ready> evaluates to <true>

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[2150] CAppearanceEventWnd::CheckEventRules: No actions to execute.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[2157] CAppearanceEventWnd::CheckEventRules: Leaving

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: End.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_READY       

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_DIVERTED_EVENT>.

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2355] GetDebugInfo: CALL_DIVERTED_EVENT: MonitorID = 6012

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2356] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2357] GetDebugInfo: CALL_DIVERTED_EVENT: LocalConnectionState = LCS_FAIL

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2358] GetDebugInfo: CALL_DIVERTED_EVENT: EventCause = CEC_CALL_NOT_ANSWERED

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2359] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionDeviceID = 6012

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2360] GetDebugInfo: CALL_DIVERTED_EVENT: DivertingDeviceID = 6012

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2361] GetDebugInfo: CALL_DIVERTED_EVENT: CalledDeviceID = 6012

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:16782297, CallState:CS_DISCONNECTED

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=16782297>, <new CallID=0>, <CallState=CS_DISCONNECTED >, <ReasonCode=0>

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:16782297, CallState:CS_DISCONNECTED , businessCall <false>, display business call only <true>

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[1890] OnCallDivertedEvent: RNA call dropped with callid 16782297

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:09:296 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is RESERVED

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 8

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 3

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:09:296 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  RESERVED  NextAgentState LOGIN

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_SELECTED>, <ReasonCode=0>

2014-02-23 17:24:09:296 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_SELECTED, businessCall <false>, display business call only <true>

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_SELECTED with reason code 0

2014-02-23 17:24:09:296 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Selected>, Transitions <00090000>, ReasonCode <>

2014-02-23 17:24:09:296 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:09:296 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Selected, stateTransitionMask: 589824, reasonCode: .

2014-02-23 17:24:09:296 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:09:296 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:09:296 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:09:296 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_READY         agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:09:296 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540085', 1393146723}, 0, 'jbond', 'jbond', 20, 0, 35)

2014-02-23 17:24:09:312 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:09:312 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:09:312 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_SELECTED

2014-02-23 17:24:09:312 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_SELECTED and new callID 0.

2014-02-23 17:24:09:312 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:09:312 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:09:312 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:09:312 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:09:312 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:09:312 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:09:312 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:09:890 DEBUG [0xed0] FCCClientAPI.cpp[3452] FCCClientAPI::RecoveryThread: after waiting for 60 seconds.

2014-02-23 17:24:11:125 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:11:125 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is AVAILABLE

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 3

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 4294967295

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:11:125 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  AVAILABLE  NextAgentState LOGIN

2014-02-23 17:24:11:125 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_READY       

2014-02-23 17:24:11:125 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:11:125 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_READY        >, <ReasonCode=0>

2014-02-23 17:24:11:125 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_READY        , businessCall <false>, display business call only <true>

2014-02-23 17:24:11:125 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_READY         with reason code 0

2014-02-23 17:24:11:125 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Ready>, Transitions <00090065>, ReasonCode <>

2014-02-23 17:24:11:125 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:11:125 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Ready, stateTransitionMask: 589925, reasonCode: .

2014-02-23 17:24:11:125 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:11:125 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:11:125 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:11:125 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:11:125 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:11:125 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:11:125 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_SELECTED agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:11:125 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540086', 1393146723}, 2, 'jbond', 'jbond', 35, 0, 20)

2014-02-23 17:24:11:140 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_READY       

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[1429] CAppearanceEventWnd::ProcessEvent: Calling NewEventNotification....

2014-02-23 17:24:11:140 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_READY         and new callID 0.

2014-02-23 17:24:11:140 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: Entering with CallID: 0, Event type: <Ready>, Management type: <EMT_AGENT>

2014-02-23 17:24:11:140 DEBUG [0x204] EventList.cpp[26] CEventList::FindEvent: BEGIN find Ready for EMT_AGENT

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[2112] CAppearanceEventWnd::CheckEventRules: Rule: <Default>, Event Name: <Ready> evaluates to <true>

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[2150] CAppearanceEventWnd::CheckEventRules: No actions to execute.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[2157] CAppearanceEventWnd::CheckEventRules: Leaving

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: End.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_READY       

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_DIVERTED_EVENT>.

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2355] GetDebugInfo: CALL_DIVERTED_EVENT: MonitorID = 6012

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2356] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2357] GetDebugInfo: CALL_DIVERTED_EVENT: LocalConnectionState = LCS_FAIL

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2358] GetDebugInfo: CALL_DIVERTED_EVENT: EventCause = CEC_CALL_NOT_ANSWERED

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2359] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionDeviceID = 6012

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2360] GetDebugInfo: CALL_DIVERTED_EVENT: DivertingDeviceID = 6012

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2361] GetDebugInfo: CALL_DIVERTED_EVENT: CalledDeviceID = 6012

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:16782297, CallState:CS_DISCONNECTED

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=16782297>, <new CallID=0>, <CallState=CS_DISCONNECTED >, <ReasonCode=0>

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:16782297, CallState:CS_DISCONNECTED , businessCall <false>, display business call only <true>

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[1890] OnCallDivertedEvent: RNA call dropped with callid 16782297

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:11:140 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is RESERVED

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 8

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 3

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:11:140 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  RESERVED  NextAgentState LOGIN

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_SELECTED>, <ReasonCode=0>

2014-02-23 17:24:11:140 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_SELECTED, businessCall <false>, display business call only <true>

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_SELECTED with reason code 0

2014-02-23 17:24:11:140 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Selected>, Transitions <00090000>, ReasonCode <>

2014-02-23 17:24:11:140 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:11:140 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Selected, stateTransitionMask: 589824, reasonCode: .

2014-02-23 17:24:11:140 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:11:140 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:11:140 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:11:140 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_READY         agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:11:140 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540087', 1393146723}, 0, 'jbond', 'jbond', 20, 0, 35)

2014-02-23 17:24:11:156 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:11:156 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:11:156 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_SELECTED

2014-02-23 17:24:11:156 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_SELECTED and new callID 0.

2014-02-23 17:24:11:156 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:11:156 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:11:156 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:11:156 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:11:156 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:11:156 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:11:156 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:12:500 DEBUG [0xf28] ssRecoveryThread.cpp[51] ssEnterpriseClient::recoveryThread: Wait timed out

2014-02-23 17:24:12:500 DEBUG [0xf28] ssRecoveryThread.cpp[38] ssEnterpriseClient::recoveryThread: Waiting for recovery message.....

2014-02-23 17:24:12:671 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:12:671 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is AVAILABLE

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 3

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 4294967295

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:12:671 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  AVAILABLE  NextAgentState LOGIN

2014-02-23 17:24:12:671 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_READY       

2014-02-23 17:24:12:671 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:12:671 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_READY        >, <ReasonCode=0>

2014-02-23 17:24:12:671 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_READY        , businessCall <false>, display business call only <true>

2014-02-23 17:24:12:671 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_READY         with reason code 0

2014-02-23 17:24:12:671 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Ready>, Transitions <00090065>, ReasonCode <>

2014-02-23 17:24:12:671 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:12:671 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Ready, stateTransitionMask: 589925, reasonCode: .

2014-02-23 17:24:12:671 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:12:671 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:12:671 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:12:671 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:12:671 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:12:671 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:12:671 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_SELECTED agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:12:671 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540088', 1393146723}, 1, 'jbond', 'jbond', 35, 0, 20)

2014-02-23 17:24:12:687 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:12:687 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:12:687 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_READY       

2014-02-23 17:24:12:687 DEBUG [0x204] AppearanceEventWnd.cpp[1429] CAppearanceEventWnd::ProcessEvent: Calling NewEventNotification....

2014-02-23 17:24:12:687 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_READY         and new callID 0.

2014-02-23 17:24:12:687 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:12:687 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: Entering with CallID: 0, Event type: <Ready>, Management type: <EMT_AGENT>

2014-02-23 17:24:12:703 DEBUG [0x204] EventList.cpp[26] CEventList::FindEvent: BEGIN find Ready for EMT_AGENT

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[2112] CAppearanceEventWnd::CheckEventRules: Rule: <Default>, Event Name: <Ready> evaluates to <true>

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[2150] CAppearanceEventWnd::CheckEventRules: No actions to execute.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[2157] CAppearanceEventWnd::CheckEventRules: Leaving

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: End.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_READY       

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_DIVERTED_EVENT>.

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2355] GetDebugInfo: CALL_DIVERTED_EVENT: MonitorID = 6012

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2356] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2357] GetDebugInfo: CALL_DIVERTED_EVENT: LocalConnectionState = LCS_FAIL

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2358] GetDebugInfo: CALL_DIVERTED_EVENT: EventCause = CEC_CALL_NOT_ANSWERED

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2359] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionDeviceID = 6012

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2360] GetDebugInfo: CALL_DIVERTED_EVENT: DivertingDeviceID = 6012

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2361] GetDebugInfo: CALL_DIVERTED_EVENT: CalledDeviceID = 6012

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:16782297, CallState:CS_DISCONNECTED

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=16782297>, <new CallID=0>, <CallState=CS_DISCONNECTED >, <ReasonCode=0>

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:16782297, CallState:CS_DISCONNECTED , businessCall <false>, display business call only <true>

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[1890] OnCallDivertedEvent: RNA call dropped with callid 16782297

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is RESERVED

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 8

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 3

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:12:703 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  RESERVED  NextAgentState LOGIN

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_SELECTED>, <ReasonCode=0>

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_SELECTED, businessCall <false>, display business call only <true>

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_SELECTED with reason code 0

2014-02-23 17:24:12:703 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Selected>, Transitions <00090000>, ReasonCode <>

2014-02-23 17:24:12:703 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:12:703 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Selected, stateTransitionMask: 589824, reasonCode: .

2014-02-23 17:24:12:703 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:12:703 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:12:703 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_READY         agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:12:703 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f910000003540089', 1393146723}, 0, 'jbond', 'jbond', 20, 0, 35)

2014-02-23 17:24:12:703 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:12:703 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_SELECTED

2014-02-23 17:24:12:703 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_SELECTED and new callID 0.

2014-02-23 17:24:12:703 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:12:703 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:12:703 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:13:875 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:13:875 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is AVAILABLE

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 3

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 4294967295

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:13:875 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  AVAILABLE  NextAgentState LOGIN

2014-02-23 17:24:13:875 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_READY       

2014-02-23 17:24:13:875 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:13:875 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_READY        >, <ReasonCode=0>

2014-02-23 17:24:13:875 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_READY        , businessCall <false>, display business call only <true>

2014-02-23 17:24:13:875 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_READY         with reason code 0

2014-02-23 17:24:13:875 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Ready>, Transitions <00090065>, ReasonCode <>

2014-02-23 17:24:13:875 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:13:875 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Ready, stateTransitionMask: 589925, reasonCode: .

2014-02-23 17:24:13:875 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:13:875 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:13:875 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:13:875 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:13:875 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:13:875 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:13:875 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_SELECTED agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:13:875 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f91000000354008a', 1393146723}, 1, 'jbond', 'jbond', 35, 0, 20)

2014-02-23 17:24:14:015 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:14:015 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:14:015 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_READY       

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[1429] CAppearanceEventWnd::ProcessEvent: Calling NewEventNotification....

2014-02-23 17:24:14:015 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_READY         and new callID 0.

2014-02-23 17:24:14:015 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: Entering with CallID: 0, Event type: <Ready>, Management type: <EMT_AGENT>

2014-02-23 17:24:14:015 DEBUG [0x204] EventList.cpp[26] CEventList::FindEvent: BEGIN find Ready for EMT_AGENT

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[2112] CAppearanceEventWnd::CheckEventRules: Rule: <Default>, Event Name: <Ready> evaluates to <true>

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[2150] CAppearanceEventWnd::CheckEventRules: No actions to execute.

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[2157] CAppearanceEventWnd::CheckEventRules: Leaving

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: End.

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_READY       

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:14:015 DEBUG [0x204] CJToolbars.cpp[680] CCJMainToolBars::CheckButton: set check for <Ready> to true

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_DIVERTED_EVENT>.

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2355] GetDebugInfo: CALL_DIVERTED_EVENT: MonitorID = 6012

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2356] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2357] GetDebugInfo: CALL_DIVERTED_EVENT: LocalConnectionState = LCS_FAIL

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2358] GetDebugInfo: CALL_DIVERTED_EVENT: EventCause = CEC_CALL_NOT_ANSWERED

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2359] GetDebugInfo: CALL_DIVERTED_EVENT: ConnectionDeviceID = 6012

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2360] GetDebugInfo: CALL_DIVERTED_EVENT: DivertingDeviceID = 6012

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2361] GetDebugInfo: CALL_DIVERTED_EVENT: CalledDeviceID = 6012

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_DIVERTED_EVENT ---------------------

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:16782297, CallState:CS_DISCONNECTED

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=16782297>, <new CallID=0>, <CallState=CS_DISCONNECTED >, <ReasonCode=0>

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:16782297, CallState:CS_DISCONNECTED , businessCall <false>, display business call only <true>

2014-02-23 17:24:14:015 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[1890] OnCallDivertedEvent: RNA call dropped with callid 16782297

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:14:015 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:14:015 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is RESERVED

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 8

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 3

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:14:031 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  RESERVED  NextAgentState LOGIN

2014-02-23 17:24:14:031 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:14:031 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:14:031 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_SELECTED>, <ReasonCode=0>

2014-02-23 17:24:14:031 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_SELECTED, businessCall <false>, display business call only <true>

2014-02-23 17:24:14:031 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_SELECTED with reason code 0

2014-02-23 17:24:14:031 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Selected>, Transitions <00090000>, ReasonCode <>

2014-02-23 17:24:14:031 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:14:031 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Selected, stateTransitionMask: 589824, reasonCode: .

2014-02-23 17:24:14:031 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:14:031 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:14:031 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:14:031 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:14:031 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:14:031 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:14:031 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_READY         agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:14:031 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f91000000354008b', 1393146723}, 1, 'jbond', 'jbond', 20, 0, 35)

2014-02-23 17:24:14:046 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:14:046 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:14:046 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_SELECTED

2014-02-23 17:24:14:046 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_SELECTED and new callID 0.

2014-02-23 17:24:14:046 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:14:046 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:14:046 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:14:046 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_SELECTED

2014-02-23 17:24:14:046 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:14:046 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:14:046 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:14:046 DEBUG [0xed4] FCCClientAPI.cpp[3231] FCCClientAPI::heartbeatThread: Got timeout.  Sending heartbeat.

2014-02-23 17:24:14:046 DEBUG [0xed4] FCCClientAPI.cpp[2027] FCCClientAPI::sendHeartbeat: Begin.

2014-02-23 17:24:14:046 DEBUG [0xed4] FCCClientAPI.cpp[2053] FCCClientAPI::sendHeartbeat: Sending heartbeat...

2014-02-23 17:24:14:046 DEBUG [0xed4] FCCClientAPI.cpp[2065] FCCClientAPI::sendHeartbeat: End with return code 0.

2014-02-23 17:24:14:046 DEBUG [0xed4] FCCClientAPI.cpp[2081] FCCClientAPI::sendHeartbeat: End.  return_code = 0.

2014-02-23 17:24:14:046 DEBUG [0xed4] FCCClientAPI.cpp[3221] FCCClientAPI::heartbeatThread: Waiting for timeout or shutdown...

2014-02-23 17:24:14:109 DEBUG [0x204] CJToolbars.cpp[680] CCJMainToolBars::CheckButton: set check for <Ready> to false

2014-02-23 17:24:16:890 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:16:890 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:16:890 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <HEARTBEAT_CONF>.

2014-02-23 17:24:16:890 DEBUG [0x204] EventHandler.cpp[622] OnHeartBeatConf: InvokeID = 329

2014-02-23 17:24:16:890 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:16:890 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:22:500 DEBUG [0xf28] ssRecoveryThread.cpp[51] ssEnterpriseClient::recoveryThread: Wait timed out

2014-02-23 17:24:22:500 DEBUG [0xf28] ssRecoveryThread.cpp[38] ssEnterpriseClient::recoveryThread: Waiting for recovery message.....

2014-02-23 17:24:23:062 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:23:062 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <AGENT_STATE_EVENT>.

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2199] GetDebugInfo: AGENT_STATE_EVENT: MonitorID is 0

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2200] GetDebugInfo: AGENT_STATE_EVENT: AgentState is AVAILABLE

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2201] GetDebugInfo: AGENT_STATE_EVENT: NextAgentState is LOGIN

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2202] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupStateElement is 3

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2203] GetDebugInfo: AGENT_STATE_EVENT: StateDurationElement is 0

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2204] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupNumberElement is 4294967295

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2205] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupIDElement is 4294967295

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2206] GetDebugInfo: AGENT_STATE_EVENT: SkillGroupPriorityElement is 0

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2207] GetDebugInfo: AGENT_STATE_EVENT: EventReasonCodeElement is 0

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2208] GetDebugInfo: AGENT_STATE_EVENT: AgentIDElement is jbond

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2209] GetDebugInfo: AGENT_STATE_EVENT: AgentExtensionElement is 6012

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2210] GetDebugInfo: AGENT_STATE_EVENT: AgentInstrumentElement is

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2211] GetDebugInfo: AGENT_STATE_EVENT: AgentID_LongElement is jbond

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: AGENT_STATE_EVENT ---------------------

2014-02-23 17:24:23:062 DEBUG [0x204] EventHandler.cpp[2086] OnAgentStateEvent: AgentState  AVAILABLE  NextAgentState LOGIN

2014-02-23 17:24:23:062 DEBUG [0x204] AppearanceEventWnd.cpp[307] CAppearanceEventWnd::StateCallback: StateCallback - CallID:0, CallState:AS_READY       

2014-02-23 17:24:23:062 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: Begin.

2014-02-23 17:24:23:062 DEBUG [0x204] AppearanceEventWnd.cpp[401] CAppearanceEventWnd::ProcessEvent: Process CTI message <CallID=0>, <new CallID=0>, <CallState=AS_READY        >, <ReasonCode=0>

2014-02-23 17:24:23:062 DEBUG [0x204] AppearanceEventWnd.cpp[407] CAppearanceEventWnd::ProcessEvent: Begin: CallID:0, CallState:AS_READY        , businessCall <false>, display business call only <true>

2014-02-23 17:24:23:062 DEBUG [0x204] AgentStateManager.cpp[260] CAgentStateManager::HandleEvent: ASM0260 Begin handling agent state event - AS_READY         with reason code 0

2014-02-23 17:24:23:062 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: Ext <6012>, State <Ready>, Transitions <00090065>, ReasonCode <>

2014-02-23 17:24:23:062 DEBUG [0x204] FCCClientAPI.cpp[1449] FCCClientAPI::setAgentAcdState: Begin.

2014-02-23 17:24:23:062 DEBUG [0x204] FCCClientAPI.cpp[1464] FCCClientAPI::setAgentAcdState: Begin. Ext: 6012, agentState: Ready, stateTransitionMask: 589925, reasonCode: .

2014-02-23 17:24:23:062 DEBUG [0x204] FCCClientAPI.cpp[1468] FCCClientAPI::setAgentAcdState: Calling the server IDL setAgentAcdState function.

2014-02-23 17:24:23:062 DEBUG [0x204] FCCClientAPI.cpp[1514] FCCClientAPI::setAgentAcdState: End.  return_code: 0.

2014-02-23 17:24:23:062 DEBUG [0x204] ChatAPI.cpp[1045] CChatAPI::SetAgentAcdState: End.

2014-02-23 17:24:23:062 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: Begin.

2014-02-23 17:24:23:062 DEBUG [0x204] AgentStateManager.cpp[1273] CAgentStateManager::AgentStateToSupervisorDirect: End.

2014-02-23 17:24:23:062 DEBUG [0x204] AgentStateManager.cpp[673] CAgentStateManager::WriteStateChangeToRascal: ASM0673 Begin writing agent state data to RASCAL

2014-02-23 17:24:23:062 DEBUG [0x204] AgentStateManager.cpp[858] CAgentStateManager::WriteStateChangeToRascal: ASM0858 Sending AS_SELECTED agent state change to RASCAL with GID=1393146723

2014-02-23 17:24:23:062 DEBUG [0x204] FCRasClient.cpp[1354] FCRasClientBase::AgentStateChange: Attempting to call IDL function agentStateChange({'000c2945f91000000354008c', 1393146723}, 9, 'jbond', 'jbond', 35, 0, 20)

2014-02-23 17:24:23:078 DEBUG [0x204] FCRasClient.cpp[1360] FCRasClientBase::AgentStateChange: IDL function agentStateChange returned 0

2014-02-23 17:24:23:078 DEBUG [0x204] AgentStateManager.cpp[924] CAgentStateManager::WriteStateChangeToRascal: ASM0924 End writing agent state data to RASCAL

2014-02-23 17:24:23:078 DEBUG [0x204] AgentStateManager.cpp[584] CAgentStateManager::HandleEvent: ASM0584 End handling agent state event - AS_READY       

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[1429] CAppearanceEventWnd::ProcessEvent: Calling NewEventNotification....

2014-02-23 17:24:23:078 DEBUG [0x204] VoiceContactList.cpp[282] CVoiceContactList::UpdateCallInListCtl: Begin update for callID 0 with call state AS_READY         and new callID 0.

2014-02-23 17:24:23:078 DEBUG [0x204] VoiceContactList.cpp[292] CVoiceContactList::UpdateCallInListCtl: CallID is empty - nothing to update - returning.

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: Begin.

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: Entering with CallID: 0, Event type: <Ready>, Management type: <EMT_AGENT>

2014-02-23 17:24:23:078 DEBUG [0x204] EventList.cpp[26] CEventList::FindEvent: BEGIN find Ready for EMT_AGENT

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[2112] CAppearanceEventWnd::CheckEventRules: Rule: <Default>, Event Name: <Ready> evaluates to <true>

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[2150] CAppearanceEventWnd::CheckEventRules: No actions to execute.

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[2157] CAppearanceEventWnd::CheckEventRules: Leaving

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[2012] CAppearanceEventWnd::CheckEventRules: End.

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[1921] CAppearanceEventWnd::CheckCallStateRules: End.

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[1507] CAppearanceEventWnd::ProcessEvent: End: CallID:0, CallState:AS_READY       

2014-02-23 17:24:23:078 DEBUG [0x204] AppearanceEventWnd.cpp[390] CAppearanceEventWnd::ProcessEvent: End.

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_CONNECTION_CLEARED_EVENT>.

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_CONNECTION_CLEARED_EVENT ---------------------

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2300] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: MonitorID = 6012

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2301] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2302] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: LocalConnectionState = LCS_NONE

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2303] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: EventCause = CEC_REDIRECTED

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2304] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: ReleasingDeviceID = 9009

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_CONNECTION_CLEARED_EVENT ---------------------

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <CALL_CONNECTION_CLEARED_EVENT>.

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: CALL_CONNECTION_CLEARED_EVENT ---------------------

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2300] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: MonitorID = 6012

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2301] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: ConnectionCallID = 16782297

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2302] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: LocalConnectionState = LCS_NONE

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2303] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: EventCause = CEC_NONE

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2304] GetDebugInfo: CALL_CONNECTION_CLEARED_EVENT: ReleasingDeviceID = 6012

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: CALL_CONNECTION_CLEARED_EVENT ---------------------

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[405] GetEventThread: Polling message Q. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[416] GetEventThread: Post WM_ACMI_CTI_EVENT. -- BEGIN

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[160] CTIEventProc: Start processing CTI message <END_CALL_EVENT>.

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2146] GetDebugInfo: GetDebugInfo --------------------- Begin: END_CALL_EVENT ---------------------

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2226] GetDebugInfo: BEGIN_CALL_EVENT: MonitorID = 6012

2014-02-23 17:24:23:078 DEBUG [0x204] EventHandler.cpp[2463] GetDebugInfo:   GetDebugInfo --------------------- End: END_CALL_EVENT ---------------------

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[419] GetEventThread: Post WM_ACMI_CTI_EVENT <0>. -- END

2014-02-23 17:24:23:078 DEBUG [0x138] PhoneDev.cpp[403] GetEventThread: Polling message Q with server connection <1>. -- BEGIN

2014-02-23 17:24:23:250 DEBUG [0x204] CJToolbars.cpp[680] CCJMainToolBars::CheckButton: set check for <Ready> to true

Thanks in advance.

  • Contact Center
Everyone's tags (3)
6 REPLIES

UCCX CAD - Reserved but phone not ringing

Hi,

can you please pull the MIVR logs as well. And please attach them as a text file. Thanks.

G.

New Member

Re: UCCX CAD - Reserved but phone not ringing

Hi.

Please find attached MIVR log file for your reference

UCCX CAD - Reserved but phone not ringing

Hi,

based on this

1312060: Feb 23 21:04:21.933 SGT %MIVR-SS_TEL-7-UNK:CallID:21 MediaId:5088/1 Task:28000000073 consultWithoutMedia gets CiscoJtapiException: 0x0(CTIERR_UNSPECIFIED)::Unspecified error

1312061: Feb 23 21:04:21.936 SGT %MIVR-SS_TEL-7-UNK:CallID:21 MediaId:5088/1 Task:28000000073 Got CallCtlConnEstablishedEv 9000::1,  events on the AddressCallObserver.

1312062: Feb 23 21:04:21.937 SGT %MIVR-SS_TEL-7-UNK:OrigCall=CallID:21 MediaId:5088/1 Task:28000000073, ConsultEvent= ConnFailedEv 9000::1

1312063: Feb 23 21:04:21.937 SGT %MIVR-SS_TEL-7-UNK:OrigCall=CallID:21 MediaId:5088/1 Task:28000000073, ConsultEvent= CallCtlConnFailedEv 9000::1

1312064: Feb 23 21:04:21.937 SGT %MIVR-SS_TEL-7-UNK:CallID:21 MediaId:5088/1 Task:28000000073, ConsultCallObserver FAILED, cause: 109, callctl cause: 109

1312065: Feb 23 21:04:21.937 SGT %MIVR-SS_TEL-7-UNK:OrigCall=CallID:21 MediaId:5088/1 Task:28000000073, ConsultEvent= CallObservationEndedEv

1312066: Feb 23 21:04:21.937 SGT %MIVR-SS_TEL-7-UNK:Call.transferFailed(6012, UNKNOWN) JTAPICallContact[id=21,implId=5088/1,state=STATE_ANSWERED_IDX,inbound=true,App name=HelpDesk,task=28000000073,session=7000000088,seq num=0,cn=4000,dn=4000,cgn=5010,ani=null,dnis=null,clid=null,atype=DIRECT,lrd=null,ocn=4000,route=RP[num=4000],OrigProtocolCallRef=00000000000013E00125FB5800000000,DestProtocolCallRef=null,TP=9000]

1312067: Feb 23 21:04:21.937 SGT %MIVR-SS_CM-7-UNK:ICDContactAdapter 21 : ContactConnectFailed received for App FW contact 21with reason as UNKNOWN, iefSourceContact is 16782304 [5088/1] (21)

UCCX tries to transfer the call from the CTI port but it fails.

Possible reasons:

- CAC

- CSS of CTI port does not contain partition of the agent extension

Can you also tell me whether this is an inbound call?

G.

New Member

UCCX CAD - Reserved but phone not ringing

There is no CAC and I am using default partition/CSS.

Yes, this is an inbound call.

UCCX CAD - Reserved but phone not ringing

Hi,

is the user jbond also assigned to an outbound CSQ?

Also, you are absolutely sure there's no connectivity issue?

G.

New Member

UCCX CAD - Reserved but phone not ringing

I am just testing the script in a lab environment where there is only a single active voip call to the help desk, not quite sure whether there's a connectivity issue as I think all the required services are up.

I havent configured any outbound dialing.

376
Views
0
Helpful
6
Replies
This widget could not be displayed.