Hi All,
I am facing an error while agent is getting logged on station.
JTAPi Client is throwing following exception :
com.avaya.jtapi.tsapi.TsapiInvalidArgumentException: agent address name must be the same as this terminal's name
at com.avaya.jtapi.tsapi.impl.TsapiTerminal.addAgent(TsapiTerminal.java:865)
Whereas my address and terminal object are for same device.
I am facing one more issue followed to this issue, when agent re-login after getting this error than agent logs in successfully but jtapi client does not fire any call control events. It seems there is issue while adding call observer from jtapi client side.
Please note there is no issue while adding terminal and address observer on the same station , I can see TerminalChangeEvent is getting propagating to my client.
Issue is occurring always in the same pattern first we get InvalidArgumentException and than no call events in subsequent login request.
JTAPI Client lib - 6.2
AES - 6.2
Kindly revert on this as this is production issue.
Following is the jtapi trace for the same :
station Id : 5472
In the following trace you can call observer getting added on second login is taking more time compartively.
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] INFO TSDevice - Constructing device TSDevice[5472]@26a8e590 with name 5472 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] INFO TsapiSession - Sent InvokeID 67563 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] DEBUG TsapiSession - CSTAQueryDeviceInfo ::=
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] DEBUG TsapiSession - {
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] DEBUG TsapiSession - }
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] INFO TSDevice - isTerminal() for TSDevice[5472]@26a8e590
2014-03-25 08:15:18,422 [http-nio-8080-exec-77] INFO TSDevice - TSDevice[5472]@26a8e590 waiting for initialization to complete
2014-03-25 08:15:18,469 [GetEventThread] INFO TsapiSession - Received invokeID 67563 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - CSTAQueryDeviceInfoConfEvent ::=
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - deviceType 0 < DT_STATION >
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - deviceClass 0x80000000 < DC_VOICE >
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - data 2 0 62 0 30 8 a 1 6 a 1 a 16 0
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - tsType 38
2014-03-25 08:15:18,469 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,469 [GetEventThread] DEBUG LucentPrivateData - LucentV5QueryDeviceInfoConfEvent ::=
2014-03-25 08:15:18,469 [GetEventThread] DEBUG LucentPrivateData - {
2014-03-25 08:15:18,469 [GetEventThread] DEBUG LucentPrivateData - extensionClass 6 < EC_PROPRIETARY >
2014-03-25 08:15:18,469 [GetEventThread] DEBUG LucentPrivateData - associatedClass 10 < EC_OTHER >
2014-03-25 08:15:18,469 [GetEventThread] DEBUG LucentPrivateData - associatedDevice <null>
2014-03-25 08:15:18,469 [GetEventThread] DEBUG LucentPrivateData - }
2014-03-25 08:15:18,469 [GetEventThread] INFO TSInvokeID - Handling INVOKE ID 67563 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,469 [GetEventThread] INFO TSDevice - Initialization complete for TSDevice TSDevice[5472]@26a8e590 - making values available - for TSProvider[#1]@330fef92
2014-03-25 08:15:18,469 [GetEventThread] INFO TSInvokeID - DONE handling INVOKE ID 67563 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] TRACE LucentV5TerminalExImpl - com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@26a8e590 constructed.
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] TRACE LucentV7ProviderImpl - <-- getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] TRACE LucentV5TerminalExImpl - --> getTerminalConnections[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@26a8e590
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] INFO TsapiSession - Sent InvokeID 67564 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] DEBUG TsapiSession - CSTASnapshotDevice ::=
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] DEBUG TsapiSession - {
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] DEBUG TsapiSession - snapshotObject "5472"
2014-03-25 08:15:18,469 [http-nio-8080-exec-77] DEBUG TsapiSession - }
2014-03-25 08:15:18,532 [GetEventThread] INFO TsapiSession - Received invokeID 67564 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - CSTASnapshotDeviceConfEvent ::=
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - snapshotData
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - data 2 0 48 0 30 0
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - tsType 123
2014-03-25 08:15:18,532 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,532 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTASnapshotDeviceConfEvent]@768d7ce8. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,532 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTASnapshotDeviceConfEvent]@768d7ce8 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,532 [DistributeCSTAEvent] INFO LucentPrivateData - data PDU 72 not decoded
2014-03-25 08:15:18,532 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67564 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,532 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67564 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] INFO LucentPrivateData - data PDU 72 not decoded
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] TRACE LucentV5TerminalExImpl - <-- getTerminalConnections[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@26a8e590
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] TRACE LucentV5TerminalExImpl - --> getAgents[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@26a8e590
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG LucentPrivateData - LucentQueryAgentState ::=
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG LucentPrivateData - {
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG LucentPrivateData - split "3995"
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG LucentPrivateData - }
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] INFO TsapiSession - Sent InvokeID 67565 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - CSTAQueryAgentState ::=
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - {
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - }
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - {
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - data 2 0 10 0 30 6 16 4 33 39 39 35
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - tsType 89
2014-03-25 08:15:18,532 [http-nio-8080-exec-77] DEBUG TsapiSession - }
2014-03-25 08:15:18,594 [GetEventThread] INFO TsapiSession - Received invokeID 67565 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,594 [GetEventThread] DEBUG TsapiSession - CSTAQueryAgentStateConfEvent ::=
2014-03-25 08:15:18,594 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,594 [GetEventThread] DEBUG TsapiSession - agentState 1 < AG_NULL >
2014-03-25 08:15:18,594 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,594 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryAgentStateConfEvent]@23074129. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,594 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryAgentStateConfEvent]@23074129 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,594 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67565 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,594 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67565 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,594 [http-nio-8080-exec-77] INFO TsapiSession - Sent InvokeID 67566 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,594 [http-nio-8080-exec-77] DEBUG TsapiSession - CSTAQueryDeviceInfo ::=
2014-03-25 08:15:18,594 [http-nio-8080-exec-77] DEBUG TsapiSession - {
2014-03-25 08:15:18,594 [http-nio-8080-exec-77] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,594 [http-nio-8080-exec-77] DEBUG TsapiSession - }
2014-03-25 08:15:18,656 [GetEventThread] INFO TsapiSession - Received invokeID 67566 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - CSTAQueryDeviceInfoConfEvent ::=
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - deviceType 0 < DT_STATION >
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - deviceClass 0x80000000 < DC_VOICE >
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - data 2 0 62 0 30 8 a 1 6 a 1 a 16 0
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - tsType 38
2014-03-25 08:15:18,656 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,656 [GetEventThread] DEBUG LucentPrivateData - LucentV5QueryDeviceInfoConfEvent ::=
2014-03-25 08:15:18,656 [GetEventThread] DEBUG LucentPrivateData - {
2014-03-25 08:15:18,656 [GetEventThread] DEBUG LucentPrivateData - extensionClass 6 < EC_PROPRIETARY >
2014-03-25 08:15:18,656 [GetEventThread] DEBUG LucentPrivateData - associatedClass 10 < EC_OTHER >
2014-03-25 08:15:18,656 [GetEventThread] DEBUG LucentPrivateData - associatedDevice <null>
2014-03-25 08:15:18,656 [GetEventThread] DEBUG LucentPrivateData - }
2014-03-25 08:15:18,656 [GetEventThread] INFO TSInvokeID - Handling INVOKE ID 67566 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [GetEventThread] INFO TSInvokeID - DONE handling INVOKE ID 67566 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - Recreating deleted device TSDevice[5472]@b1170a7
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSProviderImpl - NOTICE: devHash.put() replaced TSDevice[5472]@26a8e590 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - TSDevice state transition: Deleted -> Active, device TSDevice[5472]@b1170a7
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - Device 5472 (object= TSDevice[5472]@b1170a7) being re-added for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - stopMonitorForThisDevice: Device TSDevice[5472]@b1170a7 about to consider DevMon stop (xref=0 mcvdxref=0), for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - Device TSDevice[5472]@b1170a7 being deleted for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - stopMonitorForThisDevice: Device TSDevice[5472]@b1170a7 about to consider DevMon stop (xref=0 mcvdxref=0), for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - TSDevice state transition: Active -> BeingDeleted, device TSDevice[5472]@b1170a7
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSProviderImpl - NOTICE: devHash.remove() expected, found and removed TSDevice[5472]@b1170a7 by device name(s) [5472]
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - TSDevice state transition: BeingDeleted -> Deleted, device TSDevice[5472]@b1170a7
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSAgent - Agent object=TSAgent[TSAgentKey(5472,3995,10889)]@1cd5eb9being deleted for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] TRACE LucentV5TerminalExImpl - <-- getAgents[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@26a8e590
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] TRACE LucentV7ProviderImpl - --> getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - Constructing device TSDevice[5472]@2b792a00 with name 5472 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TsapiSession - Sent InvokeID 67567 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] DEBUG TsapiSession - CSTAQueryDeviceInfo ::=
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] DEBUG TsapiSession - {
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] DEBUG TsapiSession - }
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - getDeviceType() for TSDevice[5472]@2b792a00
2014-03-25 08:15:18,656 [http-nio-8080-exec-77] INFO TSDevice - TSDevice[5472]@2b792a00 waiting for initialization to complete
2014-03-25 08:15:18,703 [GetEventThread] INFO TsapiSession - Received invokeID 67567 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - CSTAQueryDeviceInfoConfEvent ::=
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - deviceType 0 < DT_STATION >
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - deviceClass 0x80000000 < DC_VOICE >
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,703 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:18,719 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:18,719 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:18,719 [GetEventThread] DEBUG TsapiSession - data 2 0 62 0 30 8 a 1 6 a 1 a 16 0
2014-03-25 08:15:18,719 [GetEventThread] DEBUG TsapiSession - tsType 38
2014-03-25 08:15:18,719 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:18,719 [GetEventThread] DEBUG LucentPrivateData - LucentV5QueryDeviceInfoConfEvent ::=
2014-03-25 08:15:18,719 [GetEventThread] DEBUG LucentPrivateData - {
2014-03-25 08:15:18,719 [GetEventThread] DEBUG LucentPrivateData - extensionClass 6 < EC_PROPRIETARY >
2014-03-25 08:15:18,719 [GetEventThread] DEBUG LucentPrivateData - associatedClass 10 < EC_OTHER >
2014-03-25 08:15:18,719 [GetEventThread] DEBUG LucentPrivateData - associatedDevice <null>
2014-03-25 08:15:18,719 [GetEventThread] DEBUG LucentPrivateData - }
2014-03-25 08:15:18,719 [GetEventThread] INFO TSInvokeID - Handling INVOKE ID 67567 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,719 [GetEventThread] INFO TSDevice - Initialization complete for TSDevice TSDevice[5472]@2b792a00 - making values available - for TSProvider[#1]@330fef92
2014-03-25 08:15:18,719 [GetEventThread] INFO TSInvokeID - DONE handling INVOKE ID 67567 for TSProvider[#1]@330fef92
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentV7ProviderImpl - <-- getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentV7ProviderImpl - --> getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentACDAddressImpl - com.avaya.jtapi.tsapi.impl.LucentACDAddressImpl@2a6e53a8 constructed.
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentV7ProviderImpl - <-- getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentV5TerminalExImpl - --> addAgent[LucentAddress agentAddress, ACDAddress acdAddress, int initialState, int workMode, int reasonCode, String agentID, String password]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@26a8e590
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentAddressImpl - --> getTSDevice[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:18,719 [http-nio-8080-exec-77] TRACE LucentAddressImpl - <-- getTSDevice[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:23,633 [AuditThread] INFO TSAuditThread - AUDIT: removing call TSCall[10243]@250cc7c5 for TSProvider[#1]@330fef92
2014-03-25 08:15:23,633 [AuditThread] INFO TSAuditThread - AUDIT: removing conn TSConnection[termConn:(10243,2511)]@3fdd230c for TSProvider[#1]@330fef92
2014-03-25 08:15:23,633 [AuditThread] INFO TSAuditThread - AUDIT: removing conn TSConnection[conn:(10243,2812196613)]@1ebd346f for TSProvider[#1]@330fef92
2014-03-25 08:15:23,633 [AuditThread] INFO TSAuditThread - AUDIT: removing conn TSConnection[termConn:(10243,5444)]@17bd732d for TSProvider[#1]@330fef92
2014-03-25 08:15:33,648 [AuditThread] INFO TSAuditThread - AUDIT: removing agent TSAgent[TSAgentKey(5472,3995,10889)]@1cd5eb9 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00 constructed.
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00 constructed.
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> removeCallListener[CallListener listener]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- removeCallListener[CallListener listener]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00 constructed.
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> getTerminalConnections[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67568 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTASnapshotDevice ::=
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] DEBUG TsapiSession - snapshotObject "5472"
2014-03-25 08:15:38,531 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,578 [GetEventThread] INFO TsapiSession - Received invokeID 67568 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - CSTASnapshotDeviceConfEvent ::=
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - snapshotData
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - data 2 0 48 0 30 0
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - tsType 123
2014-03-25 08:15:38,578 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,578 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTASnapshotDeviceConfEvent]@7f6cec5d. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,578 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTASnapshotDeviceConfEvent]@7f6cec5d for TSProvider[#1]@330fef92
2014-03-25 08:15:38,578 [DistributeCSTAEvent] INFO LucentPrivateData - data PDU 72 not decoded
2014-03-25 08:15:38,578 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67568 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,578 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67568 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] INFO LucentPrivateData - data PDU 72 not decoded
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- getTerminalConnections[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> getAgents[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67569 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryAgentState ::=
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,578 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,640 [GetEventThread] INFO TsapiSession - Received invokeID 67569 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,640 [GetEventThread] DEBUG TsapiSession - CSTAQueryAgentStateConfEvent ::=
2014-03-25 08:15:38,640 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,640 [GetEventThread] DEBUG TsapiSession - agentState 1 < AG_NULL >
2014-03-25 08:15:38,640 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,640 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryAgentStateConfEvent]@199877e1. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,640 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryAgentStateConfEvent]@199877e1 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,640 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67569 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,640 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67569 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,640 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67570 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,640 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryDeviceInfo ::=
2014-03-25 08:15:38,640 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,640 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,640 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,702 [GetEventThread] INFO TsapiSession - Received invokeID 67570 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - CSTAQueryDeviceInfoConfEvent ::=
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - deviceType 0 < DT_STATION >
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - deviceClass 0x80000000 < DC_VOICE >
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - data 2 0 62 0 30 8 a 1 6 a 1 a 16 0
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - tsType 38
2014-03-25 08:15:38,702 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,702 [GetEventThread] DEBUG LucentPrivateData - LucentV5QueryDeviceInfoConfEvent ::=
2014-03-25 08:15:38,702 [GetEventThread] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,702 [GetEventThread] DEBUG LucentPrivateData - extensionClass 6 < EC_PROPRIETARY >
2014-03-25 08:15:38,702 [GetEventThread] DEBUG LucentPrivateData - associatedClass 10 < EC_OTHER >
2014-03-25 08:15:38,702 [GetEventThread] DEBUG LucentPrivateData - associatedDevice <null>
2014-03-25 08:15:38,702 [GetEventThread] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,702 [GetEventThread] INFO TSInvokeID - Handling INVOKE ID 67570 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,702 [GetEventThread] INFO TSInvokeID - DONE handling INVOKE ID 67570 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- getAgents[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentACDAddressImpl - com.avaya.jtapi.tsapi.impl.LucentACDAddressImpl@2a6e53a8 constructed.
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> addAgent[LucentAddress agentAddress, ACDAddress acdAddress, int initialState, int workMode, int reasonCode, String agentID, String password]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentAddressImpl - --> getTSDevice[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentAddressImpl - <-- getTSDevice[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentACDAddressImpl - --> getTSDevice[]: com.avaya.jtapi.tsapi.impl.LucentACDAddressImpl@2a6e53a8
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] TRACE LucentACDAddressImpl - <-- getTSDevice[]: com.avaya.jtapi.tsapi.impl.LucentACDAddressImpl@2a6e53a8
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG LucentPrivateData - LucentV5SetAgentState ::=
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG LucentPrivateData - workMode 1 < WM_AUX_WORK >
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG LucentPrivateData - reasonCode 0
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67571 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTASetAgentState ::=
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - agentMode 0 < AM_LOG_IN >
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - agentID "10889"
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - agentGroup "3995"
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - agentPassword <null>
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - data 2 0 57 0 30 6 a 1 1 2 1 0
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - tsType 89
2014-03-25 08:15:38,702 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,765 [GetEventThread] INFO TsapiSession - Received invokeID 67571 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - CSTASetAgentStateConfEvent ::=
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - NULL
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - data 2 0 67 0 30 3 1 1 0
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - tsType 50
2014-03-25 08:15:38,765 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,765 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTASetAgentStateConfEvent]@47f6de2d. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTASetAgentStateConfEvent]@47f6de2d for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [DistributeCSTAEvent] DEBUG LucentPrivateData - LucentSetAgentStateConfEvent ::=
2014-03-25 08:15:38,765 [DistributeCSTAEvent] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,765 [DistributeCSTAEvent] DEBUG LucentPrivateData - isPending FALSE
2014-03-25 08:15:38,765 [DistributeCSTAEvent] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,765 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67571 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67571 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] INFO TSAgent - constructing TSAgent with agentKey=TSAgentKey(5472,3995,10889) for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] INFO TSAgent - ParentAgent Object TSAgentKey(5472,null,10889) being created for provider TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG LucentPrivateData - LucentQueryAgentState ::=
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG LucentPrivateData - split "3995"
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67572 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryAgentState ::=
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - data 2 0 10 0 30 6 16 4 33 39 39 35
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - tsType 89
2014-03-25 08:15:38,765 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,827 [GetEventThread] INFO TsapiSession - Received invokeID 67572 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - CSTAQueryAgentStateConfEvent ::=
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - agentState 0 < AG_NOT_READY >
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - data 2 0 68 0 30 f a 1 1 a 1 1 2 1 0 a 1 ff 2 1 0
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - tsType 34
2014-03-25 08:15:38,827 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,827 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryAgentStateConfEvent]@40d2a801. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,827 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryAgentStateConfEvent]@40d2a801 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - LucentV6QueryAgentStateConfEvent ::=
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - workMode 1 < WM_AUX_WORK >
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - talkState 1 < TS_IDLE >
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - reasonCode 0
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - pendingWorkMode -1 < WM_NONE >
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - pendingReasonCode 0
2014-03-25 08:15:38,827 [DistributeCSTAEvent] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,827 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67572 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,827 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67572 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV7AgentImpl - com.avaya.jtapi.tsapi.impl.LucentV7AgentImpl@4613fae6 constructed.
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- addAgent[LucentAddress agentAddress, ACDAddress acdAddress, int initialState, int workMode, int reasonCode, String agentID, String password]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00 constructed.
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getTerminal[String name]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> getName[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- getName[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> addCallListener(CallListener listener): com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67573 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAMonitorDevice ::=
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - deviceID "5472"
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - monitorFilter
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - call 0x0 < >
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - feature 0x0 < >
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - agent 0x0 < >
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - maintenance 0x0 < >
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - privateFilter 0
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,827 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,858 [GetEventThread] INFO TsapiSession - Received invokeID 67573 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - CSTAMonitorConfEvent ::=
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - monitorCrossRefID 310
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - monitorFilter
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - call 0x80000000 < CF_CALL_CLEARED >
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - feature 0xf0000000 < FF_CALL_INFORMATION FF_DO_NOT_DISTURB FF_FORWARDING FF_MESSAGE_WAITING >
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - agent 0xfc000000 < AF_LOGGED_ON AF_LOGGED_OFF AF_NOT_READY AF_READY AF_WORK_NOT_READY AF_WORK_READY >
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - maintenance 0xc0000000 < MF_BACK_IN_SERVICE MF_OUT_OF_SERVICE >
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - privateFilter 0
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - data 2 0 5d 0 30 4 3 2 4 80
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - tsType 114
2014-03-25 08:15:38,858 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,858 [GetEventThread] INFO TSInvokeID - Handling INVOKE ID 67573 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,858 [GetEventThread] INFO TSInvokeID - DONE handling INVOKE ID 67573 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] INFO LucentPrivateData - data PDU 93 not decoded
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG LucentPrivateData - LucentQueryAgentState ::=
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG LucentPrivateData - split "3995"
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67574 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryAgentState ::=
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - data 2 0 10 0 30 6 16 4 33 39 39 35
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - tsType 89
2014-03-25 08:15:38,858 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,874 [GetEventThread] INFO TsapiSession - Received invokeID 67574 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - CSTAQueryAgentStateConfEvent ::=
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - agentState 0 < AG_NOT_READY >
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - data 2 0 68 0 30 f a 1 1 a 1 1 2 1 0 a 1 ff 2 1 0
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - tsType 34
2014-03-25 08:15:38,874 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,874 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryAgentStateConfEvent]@22dfc055. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,874 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryAgentStateConfEvent]@22dfc055 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - LucentV6QueryAgentStateConfEvent ::=
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - workMode 1 < WM_AUX_WORK >
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - talkState 1 < TS_IDLE >
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - reasonCode 0
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - pendingWorkMode -1 < WM_NONE >
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - pendingReasonCode 0
2014-03-25 08:15:38,874 [DistributeCSTAEvent] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,874 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67574 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,874 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67574 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,874 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67575 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,874 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryDeviceInfo ::=
2014-03-25 08:15:38,874 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,874 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,874 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,936 [GetEventThread] INFO TsapiSession - Received invokeID 67575 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - CSTAQueryDeviceInfoConfEvent ::=
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - deviceType 0 < DT_STATION >
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - deviceClass 0x80000000 < DC_VOICE >
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - data 2 0 62 0 30 d a 1 6 a 1 9 16 5 31 30 38 38 39
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - tsType 38
2014-03-25 08:15:38,936 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,936 [GetEventThread] DEBUG LucentPrivateData - LucentV5QueryDeviceInfoConfEvent ::=
2014-03-25 08:15:38,936 [GetEventThread] DEBUG LucentPrivateData - {
2014-03-25 08:15:38,936 [GetEventThread] DEBUG LucentPrivateData - extensionClass 6 < EC_PROPRIETARY >
2014-03-25 08:15:38,936 [GetEventThread] DEBUG LucentPrivateData - associatedClass 9 < EC_LOGICAL_AGENT >
2014-03-25 08:15:38,936 [GetEventThread] DEBUG LucentPrivateData - associatedDevice "10889"
2014-03-25 08:15:38,936 [GetEventThread] DEBUG LucentPrivateData - }
2014-03-25 08:15:38,936 [GetEventThread] INFO TSInvokeID - Handling INVOKE ID 67575 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,936 [GetEventThread] INFO TSInvokeID - DONE handling INVOKE ID 67575 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,936 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67576 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,936 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryDnd ::=
2014-03-25 08:15:38,936 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,936 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,936 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:38,999 [GetEventThread] INFO TsapiSession - Received invokeID 67576 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,999 [GetEventThread] DEBUG TsapiSession - CSTAQueryDndConfEvent ::=
2014-03-25 08:15:38,999 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:38,999 [GetEventThread] DEBUG TsapiSession - doNotDisturb FALSE
2014-03-25 08:15:38,999 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:38,999 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryDndConfEvent]@5bffff49. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,999 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryDndConfEvent]@5bffff49 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,999 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67576 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,999 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67576 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,999 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67577 for TSProvider[#1]@330fef92
2014-03-25 08:15:38,999 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryMwi ::=
2014-03-25 08:15:38,999 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:38,999 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:38,999 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:39,061 [GetEventThread] INFO TsapiSession - Received invokeID 67577 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - CSTAQueryMwiConfEvent ::=
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - messages FALSE
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - data 2 0 15 0 30 4 3 2 0 0
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - tsType 28
2014-03-25 08:15:39,061 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,061 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryMwiConfEvent]@1ef5d7fe. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,061 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryMwiConfEvent]@1ef5d7fe for TSProvider[#1]@330fef92
2014-03-25 08:15:39,061 [DistributeCSTAEvent] DEBUG LucentPrivateData - LucentQueryMwiConfEvent ::=
2014-03-25 08:15:39,061 [DistributeCSTAEvent] DEBUG LucentPrivateData - {
2014-03-25 08:15:39,061 [DistributeCSTAEvent] DEBUG LucentPrivateData - applicationType 0x0 < >
2014-03-25 08:15:39,061 [DistributeCSTAEvent] DEBUG LucentPrivateData - }
2014-03-25 08:15:39,061 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67577 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,061 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67577 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,061 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67578 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,061 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAQueryFwd ::=
2014-03-25 08:15:39,061 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:39,061 [http-nio-8080-exec-71] DEBUG TsapiSession - device "5472"
2014-03-25 08:15:39,061 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:39,124 [GetEventThread] INFO TsapiSession - Received invokeID 67578 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - CSTAQueryFwdConfEvent ::=
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - forward
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - forwardingType 0 < FWD_IMMEDIATE >
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - forwardingOn FALSE
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - forwardDN <null>
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,124 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,124 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAQueryFwdConfEvent]@4ac66e64. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,124 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAQueryFwdConfEvent]@4ac66e64 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,124 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67578 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,124 [DistributeCSTAEvent] TRACE TsapiCallControlForwarding - com.avaya.jtapi.tsapi.impl.TsapiCallControlForwarding@29798d96 constructed.
2014-03-25 08:15:39,124 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67578 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG LucentPrivateData - LucentQueryAgentLogin ::=
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG LucentPrivateData - {
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG LucentPrivateData - device "5472"
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG LucentPrivateData - }
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67579 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTAEscapeSvc ::=
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - NULL
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - data 2 0 d 0 30 6 16 4 35 34 37 32
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - tsType 89
2014-03-25 08:15:39,124 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:39,186 [GetEventThread] INFO TsapiSession - Received invokeID 67579 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,186 [GetEventThread] DEBUG TsapiSession - CSTAUniversalFailureConfEvent ::=
2014-03-25 08:15:39,186 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,186 [GetEventThread] DEBUG TsapiSession - error 12 < INVALID_CSTA_DEVICE_IDENTIFIER >
2014-03-25 08:15:39,186 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,186 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTAUniversalFailureConfEvent]@565ae23a. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,186 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTAUniversalFailureConfEvent]@565ae23a for TSProvider[#1]@330fef92
2014-03-25 08:15:39,186 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67579 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,186 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67579 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,186 [http-nio-8080-exec-71] INFO TsapiSession - Sent InvokeID 67580 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,186 [http-nio-8080-exec-71] DEBUG TsapiSession - CSTASnapshotDevice ::=
2014-03-25 08:15:39,186 [http-nio-8080-exec-71] DEBUG TsapiSession - {
2014-03-25 08:15:39,186 [http-nio-8080-exec-71] DEBUG TsapiSession - snapshotObject "5472"
2014-03-25 08:15:39,186 [http-nio-8080-exec-71] DEBUG TsapiSession - }
2014-03-25 08:15:39,248 [GetEventThread] INFO TsapiSession - Received invokeID 67580 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - CSTASnapshotDeviceConfEvent ::=
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - snapshotData
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - TsapiPrivate ::=
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - {
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - vendor "ECS"
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - data 2 0 48 0 30 0
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - tsType 123
2014-03-25 08:15:39,248 [GetEventThread] DEBUG TsapiSession - }
2014-03-25 08:15:39,248 [GetEventThread] INFO TsapiEventQueue - Putting event CSTAEvent[CSTASnapshotDeviceConfEvent]@7bbecf61. EVENT Q SIZE = 1 MAX Q SIZE = 11 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,248 [DistributeCSTAEvent] INFO TsapiEventQueue - Getting event CSTAEvent[CSTASnapshotDeviceConfEvent]@7bbecf61 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,248 [DistributeCSTAEvent] INFO LucentPrivateData - data PDU 72 not decoded
2014-03-25 08:15:39,248 [DistributeCSTAEvent] INFO TSInvokeID - Handling INVOKE ID 67580 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,248 [DistributeCSTAEvent] INFO TSInvokeID - DONE handling INVOKE ID 67580 for TSProvider[#1]@330fef92
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] INFO LucentPrivateData - data PDU 72 not decoded
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- addCallListener(CallListener listener): com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - --> addObserver[TerminalObserver observer]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiTerminalMonitor - Getting TsapiTerminalMonitor lock to deliver events for observer com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiTerminalMonitor - Getting TsapiTerminalMonitor lock to deliver events for observer com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiTerminalMonitor - meta event BEGIN: cause (110) metaCode (135) for com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00 constructed.
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiTerminalMonitor - TERMINALDONOTDISTURBEVENT for TSDevice[5472]@2b792a00 for observer com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiTerminalMonitor - meta event END for com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf eventList size=1
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentV5TerminalExImpl - <-- addObserver[TerminalObserver observer]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - --> getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:39,248 [pool-1-thread-3183] TRACE TsapiTerminalMonitor - --> run[]: com.avaya.jtapi.tsapi.impl.monitor.TsapiTerminalMonitor@13eaa2a9
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentV7ProviderImpl - <-- getAddress[String number]: com.avaya.jtapi.tsapi.impl.LucentV7ProviderImpl@330fef92
2014-03-25 08:15:39,248 [pool-1-thread-3183] DEBUG TsapiTerminalMonitor - Got syncObject for TerminalObserver - com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentAddressImpl - --> addObserver[AddressObserver observer]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3183] DEBUG TsapiTerminalMonitor - Got this for TerminalObserver - com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiAddressMonitor - Getting TsapiAddressMonitor lock to deliver events for observer com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3183] DEBUG TsapiTerminalMonitor - calling terminalChangedEvent in com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiAddressMonitor - meta event BEGIN: cause (110) metaCode (135) for com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3183] TRACE LucentV5TerminalExImpl - --> getName[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:39,248 [pool-1-thread-3183] TRACE LucentV5TerminalExImpl - <-- getName[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiAddressMonitor - ADDRESSDONOTDISTURBEVENT for TSDevice[5472]@2b792a00 for observer com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3183] TRACE LucentV5TerminalExImpl - --> getName[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:39,248 [pool-1-thread-3183] TRACE LucentV5TerminalExImpl - <-- getName[]: com.avaya.jtapi.tsapi.impl.LucentV5TerminalExImpl@2b792a00
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiAddressMonitor - ADDRESSMESSAGEWAITINGEVENT for TSDevice[5472]@2b792a00 for observer com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentAddressImpl - com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00 constructed.
2014-03-25 08:15:39,248 [pool-1-thread-3183] DEBUG TsapiTerminalMonitor - returned from terminalChangedEvent in com.interactcrm.telephony.observer.core.impl.TelephonyTerminalObserver@2c2128bf
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiAddressMonitor - ADDRESSFORWARDEVENT for TSDevice[5472]@2b792a00 for observer com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3183] TRACE TsapiTerminalMonitor - <-- run[]: com.avaya.jtapi.tsapi.impl.monitor.TsapiTerminalMonitor@13eaa2a9
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] DEBUG TsapiAddressMonitor - meta event END for com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76 eventList size=3
2014-03-25 08:15:39,248 [http-nio-8080-exec-71] TRACE LucentAddressImpl - <-- addObserver[AddressObserver observer]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE TsapiAddressMonitor - --> run[]: com.avaya.jtapi.tsapi.impl.monitor.TsapiAddressMonitor@3d08fb99
2014-03-25 08:15:39,248 [pool-1-thread-3217] DEBUG TsapiAddressMonitor - Got syncObject for Addressobserver - com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3217] DEBUG TsapiAddressMonitor - Got this for Addressobserver - com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3217] DEBUG TsapiAddressMonitor - calling addressChangedEvent in com.interactcrm.telephony.observer.core.impl.TelephonyAddressObserver@115d0f76
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - --> getName[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - <-- getName[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - --> getName[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - <-- getName[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - --> getName[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - <-- getName[]: com.avaya.jtapi.tsapi.impl.LucentAddressImpl@2b792a00
2014-03-25 08:15:39,248 [pool-1-thread-3217] TRACE LucentAddressImpl - --> getName[]: com.a