Team,
Routed from :
https://devconnect.avaya.com/public/forum/d_forum_3.jsp?t=9479&f=6
We are having an issue with the CTI Connector Dial. We are not getting response for Dial within 15 seconds and hence the application is proceeding with BadFetch flow.
Details:
******
DD : 5.0.0.1603
Voice Portal : 5.0 & 5.1
Note: JTAPI logs for 5.1 attached here. Since Voice portal 5.0 JTAPI logs are huge, please let me know the email ID where I can send the log for avp 5.0
Application Flow:
*************
1. Call Agent(using CCXML)
2. Play him the customer details(Using DD app)
3. Based on his confirmation, call customer customer and join them.(using CTI Held, Call and Join).
Issue:
*****
We are having the issue while dialing the customer. And hence Bad Fetch error is thrown.
Please find below the extended JTAPI Trace logs for Voice
******************************************
Portal 5.1:
********
06/28/11 11:19:51.047 {Thread-1} = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = =
06/28/11 11:19:51.047 {Thread-1} Switched JTAPI trace output to alternate Trace file tsapi_trace.txt
06/28/11 11:19:51.047 {Thread-1} = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = = =
06/28/11 11:19:51.052 {Thread-1} JTAPI Package Version: 4.2.1 Build 338
06/28/11 11:19:51.055 {Thread-1} browser: GENERIC
06/28/11 11:19:55.829 {Thread-1} AvayaJtapiThread - thread created: name=GetEventThread#1, hash= @1797462
06/28/11 11:19:55.901 {Thread-1} Sent InvokeID 1 for TSProvider[#1]@52cdcc
06/28/11 11:19:55.901 {Thread-1} ACSNameSrvRequest ::=
06/28/11 11:19:55.901 {Thread-1} {
06/28/11 11:19:55.902 {Thread-1} streamType 1 < ST_CSTA >
06/28/11 11:19:55.902 {Thread-1} }
06/28/11 11:19:55.914 <GetEventThread#1> Received invokeID 1 for TSProvider[#1]@52cdcc
06/28/11 11:19:55.915 <GetEventThread#1> ACSNameSrvReply ::=
06/28/11 11:19:55.915 <GetEventThread#1> {
06/28/11 11:19:55.915 <GetEventThread#1> more FALSE
06/28/11 11:19:55.915 <GetEventThread#1> list
06/28/11 11:19:55.915 <GetEventThread#1> {
06/28/11 11:19:55.915 <GetEventThread#1> {
06/28/11 11:19:55.915 <GetEventThread#1> serverName "AVAYA#S8720#CSTA#AES"
06/28/11 11:19:55.915 <GetEventThread#1> serverAddr 2 0 4 1a ac 10 1a 15 0 0 0 0 0 0 0 0
06/28/11 11:19:55.915 <GetEventThread#1> }
06/28/11 11:19:55.915 <GetEventThread#1> {
06/28/11 11:19:55.915 <GetEventThread#1> serverName "AVAYA#S8720#CSTA-S#AES"
06/28/11 11:19:55.915 <GetEventThread#1> serverAddr 2 0 4 2a ac 10 1a 15 0 0 0 0 0 0 0 0
06/28/11 11:19:55.915 <GetEventThread#1> }
06/28/11 11:19:55.915 <GetEventThread#1> }
06/28/11 11:19:55.915 <GetEventThread#1> }
06/28/11 11:19:55.916 <GetEventThread#1> Handling INVOKE ID 1 for TSProvider[#1]@52cdcc
06/28/11 11:19:55.917 <GetEventThread#1> DONE handling INVOKE ID 1 for TSProvider[#1]@52cdcc
06/28/11 11:19:55.918 {Thread-1} Sent InvokeID 2 for TSProvider[#1]@52cdcc
06/28/11 11:19:55.918 {Thread-1} ACSAbortStream ::=
06/28/11 11:19:55.918 {Thread-1} {
06/28/11 11:19:55.918 {Thread-1} NULL
06/28/11 11:19:55.918 {Thread-1} }
06/28/11 11:19:55.919 {Thread-1} browser: GENERIC
06/28/11 11:19:55.919 <GetEventThread#1> Call Control: no handler for session
06/28/11 11:19:55.919 <GetEventThread#1> Exception received: java.net.SocketException: socket closed
06/28/11 11:19:55.920 <GetEventThread#1> java.net.SocketException: socket closed at java.net.SocketInputStream.socketRead0(Native Method)
06/28/11 11:19:55.920 <GetEventThread#1> at java.net.SocketInputStream.read(Unknown Source)
06/28/11 11:19:55.920 <GetEventThread#1> at com.avaya.java.tsapiInterface.streams.c.a(SourceFile:49)
06/28/11 11:19:55.920 <GetEventThread#1> at com.avaya.java.tsapiInterface.streams.c.a(SourceFile:60)
06/28/11 11:19:55.920 <GetEventThread#1> at com.avaya.java.tsapiInterface.oio.j.run(SourceFile:219)
06/28/11 11:20:00.422 {Thread-1} AvayaJtapiThread - thread created: name=GetEventThread#2, hash= @11620092
06/28/11 11:20:00.423 {Thread-1} AvayaJtapiThread - thread created: name=DistributeCSTAEvent#3, hash= @14693632
06/28/11 11:20:00.424 {Thread-1} Sent InvokeID 1 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.424 {Thread-1} ACSKeyRequest ::=
06/28/11 11:20:00.424 {Thread-1} {
06/28/11 11:20:00.424 {Thread-1} loginID "servion"
06/28/11 11:20:00.424 {Thread-1} }
06/28/11 11:20:00.424 {Thread-1} TsapiPrivate ::=
06/28/11 11:20:00.424 {Thread-1} {
06/28/11 11:20:00.424 {Thread-1} vendor "NT_TCP"
06/28/11 11:20:00.425 {Thread-1} data 80 1 1 1 3 1 1
06/28/11 11:20:00.425 {Thread-1} tsType 0
06/28/11 11:20:00.425 {Thread-1} }
06/28/11 11:20:00.453 <GetEventThread#2> Received invokeID 1 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.453 <GetEventThread#2> ACSAuthReplyTwo ::=
06/28/11 11:20:00.453 <GetEventThread#2> {
06/28/11 11:20:00.453 <GetEventThread#2> objectID 0
06/28/11 11:20:00.453 <GetEventThread#2> key 77 6a 41 21 d5 8f fd 6b
06/28/11 11:20:00.453 <GetEventThread#2> authInfo
06/28/11 11:20:00.453 <GetEventThread#2> {
06/28/11 11:20:00.453 <GetEventThread#2> authType 2 < NEED_LOGIN_ID_AND_PASSWD >
06/28/11 11:20:00.453 <GetEventThread#2> authLoginID "servion"
06/28/11 11:20:00.453 <GetEventThread#2> }
06/28/11 11:20:00.453 <GetEventThread#2> encodeType 3 < WIN_NT_LOCAL >
06/28/11 11:20:00.453 <GetEventThread#2> pipe <null>
06/28/11 11:20:00.453 <GetEventThread#2> }
06/28/11 11:20:00.454 <GetEventThread#2> Handling INVOKE ID 1 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.454 <GetEventThread#2> DONE handling INVOKE ID 1 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.456 {Thread-1} Sent InvokeID 2 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.456 {Thread-1} ACSOpenStream ::=
06/28/11 11:20:00.456 {Thread-1} {
06/28/11 11:20:00.456 {Thread-1} streamType 1 < ST_CSTA >
06/28/11 11:20:00.456 {Thread-1} serverID "AVAYA#S8720#CSTA#AES"
06/28/11 11:20:00.456 {Thread-1} loginID "servion"
06/28/11 11:20:00.457 {Thread-1} cryptPass bb 3 9e b7 ed f3 35 73 3c 31 72 f4 2e 77 19 67 25 1d 53 f4 2e 77 19 67 25 1d 53 f4 2e 77 19 67 25 1d 53 f4 2e 77 19 67
06/28/11 11:20:00.457 {Thread-1} applicationName "Jtapi Client"
06/28/11 11:20:00.458 {Thread-1} level 1 < ACS_LEVEL1 >
06/28/11 11:20:00.459 {Thread-1} apiVer "TS1:2"
06/28/11 11:20:00.459 {Thread-1} libVer "AES4.2.1 Build 338"
06/28/11 11:20:00.459 {Thread-1} tsrvVer ""
06/28/11 11:20:00.459 {Thread-1} }
06/28/11 11:20:00.459 {Thread-1} TsapiPrivate ::=
06/28/11 11:20:00.459 {Thread-1} {
06/28/11 11:20:00.459 {Thread-1} vendor "VERSION"
06/28/11 11:20:00.459 {Thread-1} data 0 45 43 53 23 34 2d 38 23 41 54 26 54 20 44 65 66 69 6e 69 74 79 20 47 33 23 34 2d 38 0
06/28/11 11:20:00.459 {Thread-1} tsType 0
06/28/11 11:20:00.462 {Thread-1} }
06/28/11 11:20:00.478 <GetEventThread#2> ACSClientHeartbeatEvent ::=
06/28/11 11:20:00.478 <GetEventThread#2> {
06/28/11 11:20:00.478 <GetEventThread#2> }
06/28/11 11:20:00.478 <GetEventThread#2> Putting event CSTAEvent[n]@12b24bc. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.478 <GetEventThread#2> Received invokeID 2 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.478 <GetEventThread#2> ACSOpenStreamConfEvent ::=
06/28/11 11:20:00.478 <GetEventThread#2> {
06/28/11 11:20:00.478 <GetEventThread#2> apiVer "ST2"
06/28/11 11:20:00.478 <GetEventThread#2> libVer "AES4.2.1 Build 338"
06/28/11 11:20:00.478 <GetEventThread#2> tsrvVer "4.2.1 Build 338"
06/28/11 11:20:00.478 <GetEventThread#2> drvrVer "4.2.1 Build 338"
06/28/11 11:20:00.478 <GetEventThread#2> }
06/28/11 11:20:00.478 <GetEventThread#2> TsapiPrivate ::=
06/28/11 11:20:00.478 <GetEventThread#2> {
06/28/11 11:20:00.478 <GetEventThread#2> vendor "ECS"
06/28/11 11:20:00.478 <GetEventThread#2> data 0 38 0
06/28/11 11:20:00.478 <GetEventThread#2> tsType 2
06/28/11 11:20:00.478 <GetEventThread#2> }
06/28/11 11:20:00.478 <GetEventThread#2> Handling INVOKE ID 2 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.478 <GetEventThread#2> DONE handling INVOKE ID 2 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.514 {Thread-1} AvayaJtapiThread - thread created: name=AuditThread#4, hash= @12688046
06/28/11 11:20:00.516 {Thread-1} Sent InvokeID 3 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.516 {Thread-1} CSTAGetAPICaps ::=
06/28/11 11:20:00.516 {Thread-1} {
06/28/11 11:20:00.516 {Thread-1} NULL
06/28/11 11:20:00.516 {Thread-1} }
06/28/11 11:20:00.516 <DistributeCSTAEvent#3> Getting event CSTAEvent[n]@12b24bc for TSProvider[#1]@52cdcc
06/28/11 11:20:00.517 <DistributeCSTAEvent#3> Handling ACS_CLIENT_HEARTBEAT event for TSProvider[#1]@52cdcc
06/28/11 11:20:00.517 <DistributeCSTAEvent#3> Enabling the TSAPI heartbeat with a heartbeat interval of 20 seconds.
06/28/11 11:20:00.519 <GetEventThread#2> Received invokeID 3 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.519 <GetEventThread#2> CSTAGetAPICapsConfEvent ::=
06/28/11 11:20:00.519 <GetEventThread#2> {
06/28/11 11:20:00.519 <GetEventThread#2> alternateCall 1
06/28/11 11:20:00.519 <GetEventThread#2> answerCall 1
06/28/11 11:20:00.519 <GetEventThread#2> callCompletion 0
06/28/11 11:20:00.519 <GetEventThread#2> clearCall 1
06/28/11 11:20:00.519 <GetEventThread#2> clearConnection 1
06/28/11 11:20:00.519 <GetEventThread#2> conferenceCall 1
06/28/11 11:20:00.519 <GetEventThread#2> consultationCall 1
06/28/11 11:20:00.519 <GetEventThread#2> deflectCall 1
06/28/11 11:20:00.521 <GetEventThread#2> pickupCall 1
06/28/11 11:20:00.521 <GetEventThread#2> groupPickupCall 0
06/28/11 11:20:00.521 <GetEventThread#2> holdCall 1
06/28/11 11:20:00.521 <GetEventThread#2> makeCall 1
06/28/11 11:20:00.521 <GetEventThread#2> makePredictiveCall 1
06/28/11 11:20:00.521 <GetEventThread#2> queryMwi 1
06/28/11 11:20:00.521 <GetEventThread#2> queryDnd 1
06/28/11 11:20:00.521 <GetEventThread#2> queryFwd 1
06/28/11 11:20:00.521 <GetEventThread#2> queryAgentState 1
06/28/11 11:20:00.521 <GetEventThread#2> queryLastNumber 0
06/28/11 11:20:00.521 <GetEventThread#2> queryDeviceInfo 1
06/28/11 11:20:00.521 <GetEventThread#2> reconnectCall 1
06/28/11 11:20:00.521 <GetEventThread#2> retrieveCall 1
06/28/11 11:20:00.521 <GetEventThread#2> setMwi 1
06/28/11 11:20:00.521 <GetEventThread#2> setDnd 1
06/28/11 11:20:00.521 <GetEventThread#2> setFwd 1
06/28/11 11:20:00.521 <GetEventThread#2> setAgentState 1
06/28/11 11:20:00.521 <GetEventThread#2> transferCall 1
06/28/11 11:20:00.521 <GetEventThread#2> eventReport 1
06/28/11 11:20:00.521 <GetEventThread#2> callClearedEvent 1
06/28/11 11:20:00.521 <GetEventThread#2> conferencedEvent 1
06/28/11 11:20:00.521 <GetEventThread#2> connectionClearedEvent 1
06/28/11 11:20:00.521 <GetEventThread#2> deliveredEvent 1
06/28/11 11:20:00.521 <GetEventThread#2> divertedEvent 1
06/28/11 11:20:00.521 <GetEventThread#2> establishedEvent 1
06/28/11 11:20:00.521 <GetEventThread#2> failedEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> heldEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> networkReachedEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> originatedEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> queuedEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> retrievedEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> serviceInitiatedEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> transferredEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> callInformationEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> doNotDisturbEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> forwardingEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> messageWaitingEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> loggedOnEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> loggedOffEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> notReadyEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> readyEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> workNotReadyEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> workReadyEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> backInServiceEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> outOfServiceEvent 0
06/28/11 11:20:00.522 <GetEventThread#2> privateEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> routeRequestEvent 1
06/28/11 11:20:00.522 <GetEventThread#2> reRoute 0
06/28/11 11:20:00.523 <GetEventThread#2> routeSelect 1
06/28/11 11:20:00.523 <GetEventThread#2> routeUsedEvent 1
06/28/11 11:20:00.523 <GetEventThread#2> routeEndEvent 1
06/28/11 11:20:00.523 <GetEventThread#2> monitorDevice 1
06/28/11 11:20:00.523 <GetEventThread#2> monitorCall 1
06/28/11 11:20:00.523 <GetEventThread#2> monitorCallsViaDevice 1
06/28/11 11:20:00.523 <GetEventThread#2> changeMonitorFilter 1
06/28/11 11:20:00.523 <GetEventThread#2> monitorStop 1
06/28/11 11:20:00.523 <GetEventThread#2> monitorEnded 1
06/28/11 11:20:00.523 <GetEventThread#2> snapshotDeviceReq 1
06/28/11 11:20:00.523 <GetEventThread#2> snapshotCallReq 1
06/28/11 11:20:00.523 <GetEventThread#2> escapeService 1
06/28/11 11:20:00.523 <GetEventThread#2> privateStatusEvent 1
06/28/11 11:20:00.523 <GetEventThread#2> escapeServiceEvent 0
06/28/11 11:20:00.523 <GetEventThread#2> escapeServiceConf 1
06/28/11 11:20:00.523 <GetEventThread#2> sendPrivateEvent 0
06/28/11 11:20:00.523 <GetEventThread#2> sysStatReq 1
06/28/11 11:20:00.523 <GetEventThread#2> sysStatStart 1
06/28/11 11:20:00.523 <GetEventThread#2> sysStatStop 1
06/28/11 11:20:00.523 <GetEventThread#2> changeSysStatFilter 1
06/28/11 11:20:00.524 <GetEventThread#2> sysStatReqEvent 0
06/28/11 11:20:00.524 <GetEventThread#2> sysStatReqConf 0
06/28/11 11:20:00.524 <GetEventThread#2> sysStatEvent 1
06/28/11 11:20:00.524 <GetEventThread#2> }
06/28/11 11:20:00.524 <GetEventThread#2> TsapiPrivate ::=
06/28/11 11:20:00.524 <GetEventThread#2> {
06/28/11 11:20:00.524 <GetEventThread#2> vendor "ECS"
06/28/11 11:20:00.524 <GetEventThread#2> data 2 0 7f 0 30 5c 16 5 47 33 56 31 35 1 1 ff 1 1 ff 1 1 ff 1 1 0 1 1 0 1 1 0 1 1 0 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 2 1 1 16 2 31 35 16 10 52 30 31 35 78 2e 30 31 2e 31 2e 34 31 35 2e 31 16 4 73 72 61 79 16 7 64 6c 33 38 35 67 31
06/28/11 11:20:00.524 <GetEventThread#2> tsType 125
06/28/11 11:20:00.524 <GetEventThread#2> }
06/28/11 11:20:00.524 <GetEventThread#2> Handling INVOKE ID 3 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.524 <GetEventThread#2> DONE handling INVOKE ID 3 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.526 {Thread-1} LucentV7GetAPICapsConfEvent ::=
06/28/11 11:20:00.526 {Thread-1} {
06/28/11 11:20:00.526 {Thread-1} switchVersion "G3V15"
06/28/11 11:20:00.526 {Thread-1} sendDTMFTone TRUE
06/28/11 11:20:00.526 {Thread-1} enteredDigitsEvent TRUE
06/28/11 11:20:00.526 {Thread-1} queryDeviceName TRUE
06/28/11 11:20:00.527 {Thread-1} queryAgentMeas FALSE
06/28/11 11:20:00.527 {Thread-1} querySplitSkillMeas FALSE
06/28/11 11:20:00.527 {Thread-1} queryTrunkGroupMeas FALSE
06/28/11 11:20:00.527 {Thread-1} queryVdnMeas FALSE
06/28/11 11:20:00.527 {Thread-1} singleStepConference TRUE
06/28/11 11:20:00.527 {Thread-1} selectiveListeningHold TRUE
06/28/11 11:20:00.527 {Thread-1} selectiveListeningRetrieve TRUE
06/28/11 11:20:00.527 {Thread-1} setBillingRate TRUE
06/28/11 11:20:00.527 {Thread-1} queryUCID TRUE
06/28/11 11:20:00.527 {Thread-1} chargeAdviceEvent TRUE
06/28/11 11:20:00.527 {Thread-1} singleStepTransfer TRUE
06/28/11 11:20:00.527 {Thread-1} monitorCallsViaDevice TRUE
06/28/11 11:20:00.527 {Thread-1} max_device_history_count 1
06/28/11 11:20:00.527 {Thread-1} administered_switch_software_version "15"
06/28/11 11:20:00.527 {Thread-1} switch_software_version "R015x.01.1.415.1"
06/28/11 11:20:00.527 {Thread-1} offer_type "sray"
06/28/11 11:20:00.527 {Thread-1} server_type "dl385g1"
06/28/11 11:20:00.527 {Thread-1} }
06/28/11 11:20:00.528 {Thread-1} Sent InvokeID 4 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.528 {Thread-1} CSTAQueryCallMonitor ::=
06/28/11 11:20:00.528 {Thread-1} {
06/28/11 11:20:00.528 {Thread-1} NULL
06/28/11 11:20:00.528 {Thread-1} }
06/28/11 11:20:00.528 <DistributeCSTAEvent#3> DONE handling ACS_CLIENT_HEARTBEAT event for TSProvider[#1]@52cdcc
06/28/11 11:20:00.530 <GetEventThread#2> Received invokeID 4 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.530 <GetEventThread#2> CSTAQueryCallMonitorConfEvent ::=
06/28/11 11:20:00.530 <GetEventThread#2> {
06/28/11 11:20:00.530 <GetEventThread#2> callMonitor TRUE
06/28/11 11:20:00.530 <GetEventThread#2> }
06/28/11 11:20:00.530 <GetEventThread#2> Handling INVOKE ID 4 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.530 <GetEventThread#2> DONE handling INVOKE ID 4 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.532 {Thread-1} AvayaJtapiThread - thread created: name=ProviderInitialization#5, hash= @15742686
06/28/11 11:20:00.533 {Thread-1} ThreadPool: keep: about to keepThreads - has 0 threads
06/28/11 11:20:00.533 {Thread-1} ThreadPool: keepThreads: plugged the drain
06/28/11 11:20:00.540 {Thread-1} Sent InvokeID 5 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.540 {Thread-1} ACSRequestPrivileges ::=
06/28/11 11:20:00.540 {Thread-1} {
06/28/11 11:20:00.540 {Thread-1} }
06/28/11 11:20:00.543 <GetEventThread#2> Received invokeID 5 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.543 <GetEventThread#2> ACSUniversalFailureConfEvent ::=
06/28/11 11:20:00.543 <GetEventThread#2> {
06/28/11 11:20:00.543 <GetEventThread#2> error 120 < TSERVER_UNAUTHORIZED_CONNECTION >
06/28/11 11:20:00.543 <GetEventThread#2> }
06/28/11 11:20:00.562 <ProviderInitialization#5> Sent InvokeID 6 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.562 <ProviderInitialization#5> CSTAGetDeviceList ::=
06/28/11 11:20:00.562 <ProviderInitialization#5> {
06/28/11 11:20:00.562 <ProviderInitialization#5> index -1
06/28/11 11:20:00.563 <ProviderInitialization#5> level 1 < CSTA_HOME_WORK_TOP >
06/28/11 11:20:00.563 <ProviderInitialization#5> }
06/28/11 11:20:00.563 <GetEventThread#2> Putting event CSTAEvent[A]@1decc8c. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.563 <DistributeCSTAEvent#3> Getting event CSTAEvent[A]@1decc8c for TSProvider[#1]@52cdcc
06/28/11 11:20:00.563 <DistributeCSTAEvent#3> Handling INVOKE ID 5 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.563 <DistributeCSTAEvent#3> DONE handling INVOKE ID 5 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.571 {Thread-1} TSProvider.shutdown - attempting shutdown
06/28/11 11:20:00.571 {Thread-1} TSProvider.shutdown - Starting
06/28/11 11:20:00.573 {Thread-1} tsapi.shutdown() called (inService = true) for TSProvider[#1]@52cdcc
06/28/11 11:20:00.573 {Thread-1} Sent InvokeID 7 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.573 {Thread-1} ACSAbortStream ::=
06/28/11 11:20:00.573 {Thread-1} {
06/28/11 11:20:00.573 {Thread-1} NULL
06/28/11 11:20:00.573 {Thread-1} }
06/28/11 11:20:00.573 {Thread-1} Handling INVOKE ID 6 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.573 {Thread-1} DONE handling INVOKE ID 6 for TSProvider[#1]@52cdcc
06/28/11 11:20:00.583 {Thread-1} ThreadPool: about to drain, has 0 threads
06/28/11 11:20:00.583 {Thread-1} ThreadPool: draining done
06/28/11 11:20:00.583 {Thread-1} TSProvider.shutdown - Done
06/28/11 11:20:00.583 {Thread-1} TSProvider.shutdown - attempting shutdown
06/28/11 11:20:00.583 {Thread-1} TSProvider.shutdown - Starting
06/28/11 11:20:00.583 {Thread-1} tsapi.shutdown() called (inService = false) for TSProvider[#1]@52cdcc
06/28/11 11:20:00.585 {Thread-1} TSProvider.shutdown - Done
06/28/11 11:20:00.585 {Thread-1} TSProvider: version '4.2.1 Build 338 [production build]', for TSProvider[#2]@3e0d14
06/28/11 11:20:00.585 {Thread-1} TSProvider: calling acsOpenStream serverID=AVAYA#S8720#CSTA#AES loginID=servion passwd=******* for TSProvider[#2]@3e0d14
06/28/11 11:20:00.585 {Thread-1} browser: GENERIC
06/28/11 11:20:00.586 {Thread-1} AvayaJtapiThread - thread created: name=GetEventThread#6, hash= @30191004
06/28/11 11:20:00.587 {Thread-1} Sent InvokeID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:00.587 {Thread-1} ACSNameSrvRequest ::=
06/28/11 11:20:00.587 {Thread-1} {
06/28/11 11:20:00.587 {Thread-1} streamType 1 < ST_CSTA >
06/28/11 11:20:00.587 {Thread-1} }
06/28/11 11:20:00.609 <GetEventThread#6> Received invokeID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:00.611 <GetEventThread#6> ACSNameSrvReply ::=
06/28/11 11:20:00.611 <GetEventThread#6> {
06/28/11 11:20:00.611 <GetEventThread#6> more FALSE
06/28/11 11:20:00.611 <GetEventThread#6> list
06/28/11 11:20:00.612 <GetEventThread#6> {
06/28/11 11:20:00.612 <GetEventThread#6> {
06/28/11 11:20:00.612 <GetEventThread#6> serverName "AVAYA#S8720#CSTA#AES"
06/28/11 11:20:00.613 <GetEventThread#6> serverAddr 2 0 4 1a ac 10 1a 15 0 0 0 0 0 0 0 0
06/28/11 11:20:00.613 <GetEventThread#6> }
06/28/11 11:20:00.613 <GetEventThread#6> {
06/28/11 11:20:00.613 <GetEventThread#6> serverName "AVAYA#S8720#CSTA-S#AES"
06/28/11 11:20:00.614 <GetEventThread#6> serverAddr 2 0 4 2a ac 10 1a 15 0 0 0 0 0 0 0 0
06/28/11 11:20:00.614 <GetEventThread#6> }
06/28/11 11:20:00.614 <GetEventThread#6> }
06/28/11 11:20:00.614 <GetEventThread#6> }
06/28/11 11:20:00.616 <GetEventThread#6> Handling INVOKE ID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:00.616 <GetEventThread#6> DONE handling INVOKE ID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:00.621 {Thread-1} Sent InvokeID 2 for TSProvider[#2]@3e0d14
06/28/11 11:20:00.621 {Thread-1} ACSAbortStream ::=
06/28/11 11:20:00.621 {Thread-1} {
06/28/11 11:20:00.621 {Thread-1} NULL
06/28/11 11:20:00.622 {Thread-1} }
06/28/11 11:20:00.627 {Thread-1} browser: GENERIC
06/28/11 11:20:00.633 <GetEventThread#6> Call Control: no handler for session
06/28/11 11:20:00.637 <GetEventThread#6> Exception received: java.net.SocketException: socket closed
06/28/11 11:20:00.637 <GetEventThread#6> java.net.SocketException: socket closed at java.net.SocketInputStream.socketRead0(Native Method)
06/28/11 11:20:00.638 <GetEventThread#6> at java.net.SocketInputStream.read(Unknown Source)
06/28/11 11:20:00.638 <GetEventThread#6> at com.avaya.java.tsapiInterface.streams.c.a(SourceFile:49)
06/28/11 11:20:00.638 <GetEventThread#6> at com.avaya.java.tsapiInterface.streams.c.a(SourceFile:60)
06/28/11 11:20:00.638 <GetEventThread#6> at com.avaya.java.tsapiInterface.oio.j.run(SourceFile:219)
06/28/11 11:20:05.148 {Thread-1} AvayaJtapiThread - thread created: name=GetEventThread#7, hash= @2729041
06/28/11 11:20:05.148 {Thread-1} AvayaJtapiThread - thread created: name=DistributeCSTAEvent#8, hash= @28299220
06/28/11 11:20:05.148 {Thread-1} Sent InvokeID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.148 {Thread-1} ACSKeyRequest ::=
06/28/11 11:20:05.148 {Thread-1} {
06/28/11 11:20:05.148 {Thread-1} loginID "servion"
06/28/11 11:20:05.148 {Thread-1} }
06/28/11 11:20:05.148 {Thread-1} TsapiPrivate ::=
06/28/11 11:20:05.148 {Thread-1} {
06/28/11 11:20:05.148 {Thread-1} vendor "NT_TCP"
06/28/11 11:20:05.148 {Thread-1} data 80 1 1 1 3 1 1
06/28/11 11:20:05.149 {Thread-1} tsType 0
06/28/11 11:20:05.149 {Thread-1} }
06/28/11 11:20:05.191 <GetEventThread#7> Received invokeID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.191 <GetEventThread#7> ACSAuthReplyTwo ::=
06/28/11 11:20:05.191 <GetEventThread#7> {
06/28/11 11:20:05.191 <GetEventThread#7> objectID 0
06/28/11 11:20:05.191 <GetEventThread#7> key 4d d6 9a f9 34 3f 68 7e
06/28/11 11:20:05.191 <GetEventThread#7> authInfo
06/28/11 11:20:05.191 <GetEventThread#7> {
06/28/11 11:20:05.191 <GetEventThread#7> authType 2 < NEED_LOGIN_ID_AND_PASSWD >
06/28/11 11:20:05.191 <GetEventThread#7> authLoginID "servion"
06/28/11 11:20:05.191 <GetEventThread#7> }
06/28/11 11:20:05.191 <GetEventThread#7> encodeType 3 < WIN_NT_LOCAL >
06/28/11 11:20:05.192 <GetEventThread#7> pipe <null>
06/28/11 11:20:05.192 <GetEventThread#7> }
06/28/11 11:20:05.192 <GetEventThread#7> Handling INVOKE ID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.192 <GetEventThread#7> DONE handling INVOKE ID 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.193 {Thread-1} Sent InvokeID 2 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.193 {Thread-1} ACSOpenStream ::=
06/28/11 11:20:05.193 {Thread-1} {
06/28/11 11:20:05.193 {Thread-1} streamType 1 < ST_CSTA >
06/28/11 11:20:05.193 {Thread-1} serverID "AVAYA#S8720#CSTA#AES"
06/28/11 11:20:05.193 {Thread-1} loginID "servion"
06/28/11 11:20:05.193 {Thread-1} cryptPass 52 1b a0 8 42 8 8f 8f 20 d4 2f a7 a5 e9 c4 7 75 69 d7 a7 a5 e9 c4 7 75 69 d7 a7 a5 e9 c4 7 75 69 d7 a7 a5 e9 c4 7
06/28/11 11:20:05.193 {Thread-1} applicationName "Jtapi Client"
06/28/11 11:20:05.193 {Thread-1} level 1 < ACS_LEVEL1 >
06/28/11 11:20:05.193 {Thread-1} apiVer "TS1:2"
06/28/11 11:20:05.193 {Thread-1} libVer "AES4.2.1 Build 338"
06/28/11 11:20:05.193 {Thread-1} tsrvVer ""
06/28/11 11:20:05.194 {Thread-1} }
06/28/11 11:20:05.194 {Thread-1} TsapiPrivate ::=
06/28/11 11:20:05.194 {Thread-1} {
06/28/11 11:20:05.194 {Thread-1} vendor "VERSION"
06/28/11 11:20:05.194 {Thread-1} data 0 45 43 53 23 34 2d 38 23 41 54 26 54 20 44 65 66 69 6e 69 74 79 20 47 33 23 34 2d 38 0
06/28/11 11:20:05.194 {Thread-1} tsType 0
06/28/11 11:20:05.200 {Thread-1} }
06/28/11 11:20:05.215 <GetEventThread#7> ACSClientHeartbeatEvent ::=
06/28/11 11:20:05.215 <GetEventThread#7> {
06/28/11 11:20:05.215 <GetEventThread#7> }
06/28/11 11:20:05.215 <GetEventThread#7> Putting event CSTAEvent[n]@1d85ab9. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.215 <GetEventThread#7> Received invokeID 2 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.215 <GetEventThread#7> ACSOpenStreamConfEvent ::=
06/28/11 11:20:05.215 <GetEventThread#7> {
06/28/11 11:20:05.215 <GetEventThread#7> apiVer "ST2"
06/28/11 11:20:05.215 <GetEventThread#7> libVer "AES4.2.1 Build 338"
06/28/11 11:20:05.215 <GetEventThread#7> tsrvVer "4.2.1 Build 338"
06/28/11 11:20:05.215 <GetEventThread#7> drvrVer "4.2.1 Build 338"
06/28/11 11:20:05.215 <GetEventThread#7> }
06/28/11 11:20:05.215 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.215 <GetEventThread#7> {
06/28/11 11:20:05.215 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.215 <GetEventThread#7> data 0 38 0
06/28/11 11:20:05.215 <GetEventThread#7> tsType 2
06/28/11 11:20:05.215 <GetEventThread#7> }
06/28/11 11:20:05.215 <GetEventThread#7> Handling INVOKE ID 2 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.215 <GetEventThread#7> DONE handling INVOKE ID 2 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.216 {Thread-1} AvayaJtapiThread - thread created: name=AuditThread#9, hash= @19680655
06/28/11 11:20:05.216 {Thread-1} Sent InvokeID 3 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.216 {Thread-1} CSTAGetAPICaps ::=
06/28/11 11:20:05.216 {Thread-1} {
06/28/11 11:20:05.216 {Thread-1} NULL
06/28/11 11:20:05.216 {Thread-1} }
06/28/11 11:20:05.216 <DistributeCSTAEvent#8> Getting event CSTAEvent[n]@1d85ab9 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.216 <DistributeCSTAEvent#8> Handling ACS_CLIENT_HEARTBEAT event for TSProvider[#2]@3e0d14
06/28/11 11:20:05.216 <DistributeCSTAEvent#8> Enabling the TSAPI heartbeat with a heartbeat interval of 20 seconds.
06/28/11 11:20:05.217 <DistributeCSTAEvent#8> DONE handling ACS_CLIENT_HEARTBEAT event for TSProvider[#2]@3e0d14
06/28/11 11:20:05.218 <GetEventThread#7> Received invokeID 3 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.218 <GetEventThread#7> CSTAGetAPICapsConfEvent ::=
06/28/11 11:20:05.218 <GetEventThread#7> {
06/28/11 11:20:05.218 <GetEventThread#7> alternateCall 1
06/28/11 11:20:05.218 <GetEventThread#7> answerCall 1
06/28/11 11:20:05.218 <GetEventThread#7> callCompletion 0
06/28/11 11:20:05.218 <GetEventThread#7> clearCall 1
06/28/11 11:20:05.218 <GetEventThread#7> clearConnection 1
06/28/11 11:20:05.218 <GetEventThread#7> conferenceCall 1
06/28/11 11:20:05.218 <GetEventThread#7> consultationCall 1
06/28/11 11:20:05.218 <GetEventThread#7> deflectCall 1
06/28/11 11:20:05.218 <GetEventThread#7> pickupCall 1
06/28/11 11:20:05.218 <GetEventThread#7> groupPickupCall 0
06/28/11 11:20:05.218 <GetEventThread#7> holdCall 1
06/28/11 11:20:05.219 <GetEventThread#7> makeCall 1
06/28/11 11:20:05.219 <GetEventThread#7> makePredictiveCall 1
06/28/11 11:20:05.219 <GetEventThread#7> queryMwi 1
06/28/11 11:20:05.219 <GetEventThread#7> queryDnd 1
06/28/11 11:20:05.219 <GetEventThread#7> queryFwd 1
06/28/11 11:20:05.219 <GetEventThread#7> queryAgentState 1
06/28/11 11:20:05.219 <GetEventThread#7> queryLastNumber 0
06/28/11 11:20:05.219 <GetEventThread#7> queryDeviceInfo 1
06/28/11 11:20:05.219 <GetEventThread#7> reconnectCall 1
06/28/11 11:20:05.219 <GetEventThread#7> retrieveCall 1
06/28/11 11:20:05.219 <GetEventThread#7> setMwi 1
06/28/11 11:20:05.219 <GetEventThread#7> setDnd 1
06/28/11 11:20:05.219 <GetEventThread#7> setFwd 1
06/28/11 11:20:05.219 <GetEventThread#7> setAgentState 1
06/28/11 11:20:05.219 <GetEventThread#7> transferCall 1
06/28/11 11:20:05.219 <GetEventThread#7> eventReport 1
06/28/11 11:20:05.219 <GetEventThread#7> callClearedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> conferencedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> connectionClearedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> deliveredEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> divertedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> establishedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> failedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> heldEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> networkReachedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> originatedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> queuedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> retrievedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> serviceInitiatedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> transferredEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> callInformationEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> doNotDisturbEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> forwardingEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> messageWaitingEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> loggedOnEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> loggedOffEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> notReadyEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> readyEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> workNotReadyEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> workReadyEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> backInServiceEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> outOfServiceEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> privateEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> routeRequestEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> reRoute 0
06/28/11 11:20:05.219 <GetEventThread#7> routeSelect 1
06/28/11 11:20:05.219 <GetEventThread#7> routeUsedEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> routeEndEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> monitorDevice 1
06/28/11 11:20:05.219 <GetEventThread#7> monitorCall 1
06/28/11 11:20:05.219 <GetEventThread#7> monitorCallsViaDevice 1
06/28/11 11:20:05.219 <GetEventThread#7> changeMonitorFilter 1
06/28/11 11:20:05.219 <GetEventThread#7> monitorStop 1
06/28/11 11:20:05.219 <GetEventThread#7> monitorEnded 1
06/28/11 11:20:05.219 <GetEventThread#7> snapshotDeviceReq 1
06/28/11 11:20:05.219 <GetEventThread#7> snapshotCallReq 1
06/28/11 11:20:05.219 <GetEventThread#7> escapeService 1
06/28/11 11:20:05.219 <GetEventThread#7> privateStatusEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> escapeServiceEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> escapeServiceConf 1
06/28/11 11:20:05.219 <GetEventThread#7> sendPrivateEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> sysStatReq 1
06/28/11 11:20:05.219 <GetEventThread#7> sysStatStart 1
06/28/11 11:20:05.219 <GetEventThread#7> sysStatStop 1
06/28/11 11:20:05.219 <GetEventThread#7> changeSysStatFilter 1
06/28/11 11:20:05.219 <GetEventThread#7> sysStatReqEvent 0
06/28/11 11:20:05.219 <GetEventThread#7> sysStatReqConf 0
06/28/11 11:20:05.219 <GetEventThread#7> sysStatEvent 1
06/28/11 11:20:05.219 <GetEventThread#7> }
06/28/11 11:20:05.219 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.219 <GetEventThread#7> {
06/28/11 11:20:05.219 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.220 <GetEventThread#7> data 2 0 7f 0 30 5c 16 5 47 33 56 31 35 1 1 ff 1 1 ff 1 1 ff 1 1 0 1 1 0 1 1 0 1 1 0 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 1 1 ff 2 1 1 16 2 31 35 16 10 52 30 31 35 78 2e 30 31 2e 31 2e 34 31 35 2e 31 16 4 73 72 61 79 16 7 64 6c 33 38 35 67 31
06/28/11 11:20:05.220 <GetEventThread#7> tsType 125
06/28/11 11:20:05.220 <GetEventThread#7> }
06/28/11 11:20:05.220 <GetEventThread#7> Handling INVOKE ID 3 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.220 <GetEventThread#7> DONE handling INVOKE ID 3 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.220 {Thread-1} LucentV7GetAPICapsConfEvent ::=
06/28/11 11:20:05.220 {Thread-1} {
06/28/11 11:20:05.220 {Thread-1} switchVersion "G3V15"
06/28/11 11:20:05.220 {Thread-1} sendDTMFTone TRUE
06/28/11 11:20:05.220 {Thread-1} enteredDigitsEvent TRUE
06/28/11 11:20:05.220 {Thread-1} queryDeviceName TRUE
06/28/11 11:20:05.220 {Thread-1} queryAgentMeas FALSE
06/28/11 11:20:05.221 {Thread-1} querySplitSkillMeas FALSE
06/28/11 11:20:05.221 {Thread-1} queryTrunkGroupMeas FALSE
06/28/11 11:20:05.221 {Thread-1} queryVdnMeas FALSE
06/28/11 11:20:05.221 {Thread-1} singleStepConference TRUE
06/28/11 11:20:05.221 {Thread-1} selectiveListeningHold TRUE
06/28/11 11:20:05.221 {Thread-1} selectiveListeningRetrieve TRUE
06/28/11 11:20:05.221 {Thread-1} setBillingRate TRUE
06/28/11 11:20:05.221 {Thread-1} queryUCID TRUE
06/28/11 11:20:05.221 {Thread-1} chargeAdviceEvent TRUE
06/28/11 11:20:05.221 {Thread-1} singleStepTransfer TRUE
06/28/11 11:20:05.221 {Thread-1} monitorCallsViaDevice TRUE
06/28/11 11:20:05.221 {Thread-1} max_device_history_count 1
06/28/11 11:20:05.221 {Thread-1} administered_switch_software_version "15"
06/28/11 11:20:05.221 {Thread-1} switch_software_version "R015x.01.1.415.1"
06/28/11 11:20:05.221 {Thread-1} offer_type "sray"
06/28/11 11:20:05.221 {Thread-1} server_type "dl385g1"
06/28/11 11:20:05.221 {Thread-1} }
06/28/11 11:20:05.221 {Thread-1} Sent InvokeID 4 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.221 {Thread-1} CSTAQueryCallMonitor ::=
06/28/11 11:20:05.221 {Thread-1} {
06/28/11 11:20:05.221 {Thread-1} NULL
06/28/11 11:20:05.221 {Thread-1} }
06/28/11 11:20:05.224 <GetEventThread#7> Received invokeID 4 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.224 <GetEventThread#7> CSTAQueryCallMonitorConfEvent ::=
06/28/11 11:20:05.224 <GetEventThread#7> {
06/28/11 11:20:05.224 <GetEventThread#7> callMonitor TRUE
06/28/11 11:20:05.224 <GetEventThread#7> }
06/28/11 11:20:05.224 <GetEventThread#7> Handling INVOKE ID 4 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.224 <GetEventThread#7> DONE handling INVOKE ID 4 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.224 {Thread-1} AvayaJtapiThread - thread created: name=ProviderInitialization#10, hash= @1095323
06/28/11 11:20:05.224 {Thread-1} ThreadPool: keep: about to keepThreads - has 0 threads
06/28/11 11:20:05.224 {Thread-1} ThreadPool: keepThreads: plugged the drain
06/28/11 11:20:05.240 {Thread-1} Constructing device TSDevice[54990]@1243618 with name 54990 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.241 {Thread-1} Sent InvokeID 5 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.241 {Thread-1} CSTAQueryDeviceInfo ::=
06/28/11 11:20:05.241 {Thread-1} {
06/28/11 11:20:05.241 {Thread-1} device "54990"
06/28/11 11:20:05.241 {Thread-1} }
06/28/11 11:20:05.245 {Thread-1} getDeviceType() for TSDevice[54990]@1243618
06/28/11 11:20:05.245 {Thread-1} TSDevice[54990]@1243618 waiting for initialization to complete
06/28/11 11:20:05.248 <ProviderInitialization#10> Sent InvokeID 6 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.249 <ProviderInitialization#10> CSTAGetDeviceList ::=
06/28/11 11:20:05.249 <ProviderInitialization#10> {
06/28/11 11:20:05.249 <ProviderInitialization#10> index -1
06/28/11 11:20:05.249 <ProviderInitialization#10> level 1 < CSTA_HOME_WORK_TOP >
06/28/11 11:20:05.249 <ProviderInitialization#10> }
06/28/11 11:20:05.265 <GetEventThread#7> Received invokeID 5 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.265 <GetEventThread#7> CSTAQueryDeviceInfoConfEvent ::=
06/28/11 11:20:05.265 <GetEventThread#7> {
06/28/11 11:20:05.265 <GetEventThread#7> device "54990"
06/28/11 11:20:05.265 <GetEventThread#7> deviceType 0 < DT_STATION >
06/28/11 11:20:05.266 <GetEventThread#7> deviceClass 0x80000000 < DC_VOICE >
06/28/11 11:20:05.266 <GetEventThread#7> }
06/28/11 11:20:05.266 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.266 <GetEventThread#7> {
06/28/11 11:20:05.266 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.266 <GetEventThread#7> data 2 0 62 0 30 b a 1 6 a 1 9 16 3 31 37 37
06/28/11 11:20:05.266 <GetEventThread#7> tsType 38
06/28/11 11:20:05.266 <GetEventThread#7> }
06/28/11 11:20:05.267 <GetEventThread#7> LucentV5QueryDeviceInfoConfEvent ::=
06/28/11 11:20:05.267 <GetEventThread#7> {
06/28/11 11:20:05.268 <GetEventThread#7> extensionClass 6 < EC_PROPRIETARY >
06/28/11 11:20:05.268 <GetEventThread#7> associatedClass 9 < EC_LOGICAL_AGENT >
06/28/11 11:20:05.268 <GetEventThread#7> associatedDevice "177"
06/28/11 11:20:05.268 <GetEventThread#7> }
06/28/11 11:20:05.268 <GetEventThread#7> Handling INVOKE ID 5 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.270 <GetEventThread#7> Initialization complete for TSDevice TSDevice[54990]@1243618 - making values available - for TSProvider[#2]@3e0d14
06/28/11 11:20:05.270 <GetEventThread#7> DONE handling INVOKE ID 5 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.272 <GetEventThread#7> Received invokeID 6 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.272 <GetEventThread#7> CSTAGetDeviceListConfEvent ::=
06/28/11 11:20:05.273 <GetEventThread#7> {
06/28/11 11:20:05.273 <GetEventThread#7> driverSdbLevel 1 < ACS_ONLY >
06/28/11 11:20:05.273 <GetEventThread#7> level 1 < CSTA_HOME_WORK_TOP >
06/28/11 11:20:05.273 <GetEventThread#7> index -1
06/28/11 11:20:05.273 <GetEventThread#7> devList
06/28/11 11:20:05.273 <GetEventThread#7> {
06/28/11 11:20:05.273 <GetEventThread#7> }
06/28/11 11:20:05.273 <GetEventThread#7> }
06/28/11 11:20:05.292 {Thread-1} Getting TsapiCallObserver lock to deliver events for observer com.avaya.sce.cticonnector.servlet.server.CTIConnectorManager$CTICallObserver@f4104f
06/28/11 11:20:05.294 {Thread-1} Sent InvokeID 7 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.294 {Thread-1} CSTAMonitorDevice ::=
06/28/11 11:20:05.294 {Thread-1} {
06/28/11 11:20:05.294 {Thread-1} deviceID "54990"
06/28/11 11:20:05.294 {Thread-1} monitorFilter
06/28/11 11:20:05.294 {Thread-1} {
06/28/11 11:20:05.295 {Thread-1} call 0x0 < >
06/28/11 11:20:05.295 {Thread-1} feature 0x0 < >
06/28/11 11:20:05.296 {Thread-1} agent 0x0 < >
06/28/11 11:20:05.297 {Thread-1} maintenance 0x0 < >
06/28/11 11:20:05.297 {Thread-1} privateFilter 0
06/28/11 11:20:05.297 {Thread-1} }
06/28/11 11:20:05.297 {Thread-1} }
06/28/11 11:20:05.297 <GetEventThread#7> Handling INVOKE ID 6 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.297 <GetEventThread#7> DONE handling INVOKE ID 6 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.298 <ProviderInitialization#10> Sent InvokeID 8 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.298 <ProviderInitialization#10> CSTAGetDeviceList ::=
06/28/11 11:20:05.298 <ProviderInitialization#10> {
06/28/11 11:20:05.298 <ProviderInitialization#10> index -1
06/28/11 11:20:05.298 <ProviderInitialization#10> level 6 < CSTA_ROUTING >
06/28/11 11:20:05.298 <ProviderInitialization#10> }
06/28/11 11:20:05.299 {Finalizer} AvayaJtapiThread - thread finalized: name=GetEventThread#6, hash= @30191004
06/28/11 11:20:05.339 <GetEventThread#7> Received invokeID 8 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.339 <GetEventThread#7> CSTAGetDeviceListConfEvent ::=
06/28/11 11:20:05.339 <GetEventThread#7> {
06/28/11 11:20:05.339 <GetEventThread#7> driverSdbLevel 1 < ACS_ONLY >
06/28/11 11:20:05.339 <GetEventThread#7> level 6 < CSTA_ROUTING >
06/28/11 11:20:05.339 <GetEventThread#7> index -1
06/28/11 11:20:05.339 <GetEventThread#7> devList
06/28/11 11:20:05.339 <GetEventThread#7> {
06/28/11 11:20:05.339 <GetEventThread#7> }
06/28/11 11:20:05.339 <GetEventThread#7> }
06/28/11 11:20:05.339 <GetEventThread#7> Handling INVOKE ID 8 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.339 <GetEventThread#7> DONE handling INVOKE ID 8 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.442 <GetEventThread#7> Received invokeID 7 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.443 <GetEventThread#7> CSTAMonitorConfEvent ::=
06/28/11 11:20:05.443 <GetEventThread#7> {
06/28/11 11:20:05.443 <GetEventThread#7> monitorCrossRefID 1
06/28/11 11:20:05.443 <GetEventThread#7> monitorFilter
06/28/11 11:20:05.443 <GetEventThread#7> {
06/28/11 11:20:05.443 <GetEventThread#7> call 0x80000000 < CF_CALL_CLEARED >
06/28/11 11:20:05.443 <GetEventThread#7> feature 0xf0000000 < FF_CALL_INFORMATION FF_DO_NOT_DISTURB FF_FORWARDING FF_MESSAGE_WAITING >
06/28/11 11:20:05.443 <GetEventThread#7> agent 0xfc000000 < AF_LOGGED_ON AF_LOGGED_OFF AF_NOT_READY AF_READY AF_WORK_NOT_READY AF_WORK_READY >
06/28/11 11:20:05.443 <GetEventThread#7> maintenance 0xc0000000 < MF_BACK_IN_SERVICE MF_OUT_OF_SERVICE >
06/28/11 11:20:05.443 <GetEventThread#7> privateFilter 0
06/28/11 11:20:05.443 <GetEventThread#7> }
06/28/11 11:20:05.443 <GetEventThread#7> }
06/28/11 11:20:05.443 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.443 <GetEventThread#7> {
06/28/11 11:20:05.443 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.443 <GetEventThread#7> data 2 0 5d 0 30 4 3 2 6 80
06/28/11 11:20:05.443 <GetEventThread#7> tsType 114
06/28/11 11:20:05.443 <GetEventThread#7> }
06/28/11 11:20:05.443 <GetEventThread#7> Handling INVOKE ID 7 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.443 <GetEventThread#7> DONE handling INVOKE ID 7 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.443 {Thread-1} data PDU 93 not decoded
06/28/11 11:20:05.445 {Thread-1} Sent InvokeID 9 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.445 {Thread-1} CSTAQueryAgentState ::=
06/28/11 11:20:05.445 {Thread-1} {
06/28/11 11:20:05.445 {Thread-1} device "54990"
06/28/11 11:20:05.445 {Thread-1} }
06/28/11 11:20:05.463 <GetEventThread#7> Received invokeID 9 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.464 <GetEventThread#7> CSTAQueryAgentStateConfEvent ::=
06/28/11 11:20:05.464 <GetEventThread#7> {
06/28/11 11:20:05.464 <GetEventThread#7> agentState 2 < AG_READY >
06/28/11 11:20:05.464 <GetEventThread#7> }
06/28/11 11:20:05.464 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.464 <GetEventThread#7> {
06/28/11 11:20:05.464 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.464 <GetEventThread#7> data 2 0 68 0 30 f a 1 3 a 1 1 2 1 0 a 1 ff 2 1 0
06/28/11 11:20:05.464 <GetEventThread#7> tsType 34
06/28/11 11:20:05.464 <GetEventThread#7> }
06/28/11 11:20:05.464 <GetEventThread#7> Putting event CSTAEvent[CSTAQueryAgentStateConfEvent]@b20a31. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.464 <DistributeCSTAEvent#8> Getting event CSTAEvent[CSTAQueryAgentStateConfEvent]@b20a31 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.466 <DistributeCSTAEvent#8> LucentV6QueryAgentStateConfEvent ::=
06/28/11 11:20:05.466 <DistributeCSTAEvent#8> {
06/28/11 11:20:05.466 <DistributeCSTAEvent#8> workMode 3 < WM_AUTO_IN >
06/28/11 11:20:05.466 <DistributeCSTAEvent#8> talkState 1 < TS_IDLE >
06/28/11 11:20:05.467 <DistributeCSTAEvent#8> reasonCode 0
06/28/11 11:20:05.467 <DistributeCSTAEvent#8> pendingWorkMode -1 < WM_NONE >
06/28/11 11:20:05.467 <DistributeCSTAEvent#8> pendingReasonCode 0
06/28/11 11:20:05.467 <DistributeCSTAEvent#8> }
06/28/11 11:20:05.467 <DistributeCSTAEvent#8> Handling INVOKE ID 9 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.467 <DistributeCSTAEvent#8> DONE handling INVOKE ID 9 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.467 {Thread-1} LucentQueryCallClassifier ::=
06/28/11 11:20:05.467 {Thread-1} {
06/28/11 11:20:05.467 {Thread-1} NULL
06/28/11 11:20:05.467 {Thread-1} }
06/28/11 11:20:05.468 {Thread-1} Sent InvokeID 10 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.468 {Thread-1} CSTAQueryDeviceInfo ::=
06/28/11 11:20:05.468 {Thread-1} {
06/28/11 11:20:05.468 {Thread-1} device "54990"
06/28/11 11:20:05.468 {Thread-1} }
06/28/11 11:20:05.468 {Thread-1} TsapiPrivate ::=
06/28/11 11:20:05.468 {Thread-1} {
06/28/11 11:20:05.468 {Thread-1} vendor "ECS"
06/28/11 11:20:05.468 {Thread-1} data 2 0 12 0 30 2 5 0
06/28/11 11:20:05.468 {Thread-1} tsType 89
06/28/11 11:20:05.468 {Thread-1} }
06/28/11 11:20:05.512 <GetEventThread#7> Received invokeID 10 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.512 <GetEventThread#7> CSTAQueryDeviceInfoConfEvent ::=
06/28/11 11:20:05.512 <GetEventThread#7> {
06/28/11 11:20:05.512 <GetEventThread#7> device "177"
06/28/11 11:20:05.512 <GetEventThread#7> deviceType 0 < DT_STATION >
06/28/11 11:20:05.512 <GetEventThread#7> deviceClass 0x80000000 < DC_VOICE >
06/28/11 11:20:05.512 <GetEventThread#7> }
06/28/11 11:20:05.512 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.512 <GetEventThread#7> {
06/28/11 11:20:05.512 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.512 <GetEventThread#7> data 2 0 62 0 30 b a 1 6 a 1 9 16 3 31 37 37
06/28/11 11:20:05.512 <GetEventThread#7> tsType 38
06/28/11 11:20:05.512 <GetEventThread#7> }
06/28/11 11:20:05.512 <GetEventThread#7> LucentV5QueryDeviceInfoConfEvent ::=
06/28/11 11:20:05.512 <GetEventThread#7> {
06/28/11 11:20:05.512 <GetEventThread#7> extensionClass 6 < EC_PROPRIETARY >
06/28/11 11:20:05.512 <GetEventThread#7> associatedClass 9 < EC_LOGICAL_AGENT >
06/28/11 11:20:05.512 <GetEventThread#7> associatedDevice "177"
06/28/11 11:20:05.512 <GetEventThread#7> }
06/28/11 11:20:05.512 <GetEventThread#7> Handling INVOKE ID 10 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.512 <GetEventThread#7> DONE handling INVOKE ID 10 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.518 {Thread-1} constructing TSAgent with agentKey=TSAgentKey(54990,null,177) for TSProvider[#2]@3e0d14
06/28/11 11:20:05.519 {Thread-1} Sent InvokeID 11 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.519 {Thread-1} CSTAQueryDnd ::=
06/28/11 11:20:05.519 {Thread-1} {
06/28/11 11:20:05.519 {Thread-1} device "54990"
06/28/11 11:20:05.519 {Thread-1} }
06/28/11 11:20:05.562 <GetEventThread#7> Received invokeID 11 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.562 <GetEventThread#7> CSTAQueryDndConfEvent ::=
06/28/11 11:20:05.562 <GetEventThread#7> {
06/28/11 11:20:05.562 <GetEventThread#7> doNotDisturb FALSE
06/28/11 11:20:05.562 <GetEventThread#7> }
06/28/11 11:20:05.562 <GetEventThread#7> Putting event CSTAEvent[CSTAQueryDndConfEvent]@1177565. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.563 <DistributeCSTAEvent#8> Getting event CSTAEvent[CSTAQueryDndConfEvent]@1177565 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.563 <DistributeCSTAEvent#8> Handling INVOKE ID 11 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.563 <DistributeCSTAEvent#8> DONE handling INVOKE ID 11 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.564 {Thread-1} Sent InvokeID 12 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.564 {Thread-1} CSTAQueryMwi ::=
06/28/11 11:20:05.564 {Thread-1} {
06/28/11 11:20:05.564 {Thread-1} device "54990"
06/28/11 11:20:05.564 {Thread-1} }
06/28/11 11:20:05.612 <GetEventThread#7> Received invokeID 12 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.612 <GetEventThread#7> CSTAQueryMwiConfEvent ::=
06/28/11 11:20:05.612 <GetEventThread#7> {
06/28/11 11:20:05.612 <GetEventThread#7> messages FALSE
06/28/11 11:20:05.612 <GetEventThread#7> }
06/28/11 11:20:05.612 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.612 <GetEventThread#7> {
06/28/11 11:20:05.612 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.612 <GetEventThread#7> data 2 0 15 0 30 4 3 2 0 0
06/28/11 11:20:05.612 <GetEventThread#7> tsType 28
06/28/11 11:20:05.612 <GetEventThread#7> }
06/28/11 11:20:05.613 <GetEventThread#7> Putting event CSTAEvent[CSTAQueryMwiConfEvent]@10e3c8c. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.613 <DistributeCSTAEvent#8> Getting event CSTAEvent[CSTAQueryMwiConfEvent]@10e3c8c for TSProvider[#2]@3e0d14
06/28/11 11:20:05.614 <DistributeCSTAEvent#8> LucentQueryMwiConfEvent ::=
06/28/11 11:20:05.614 <DistributeCSTAEvent#8> {
06/28/11 11:20:05.614 <DistributeCSTAEvent#8> applicationType 0x0 < >
06/28/11 11:20:05.614 <DistributeCSTAEvent#8> }
06/28/11 11:20:05.614 <DistributeCSTAEvent#8> Handling INVOKE ID 12 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.614 <DistributeCSTAEvent#8> DONE handling INVOKE ID 12 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.615 {Thread-1} Sent InvokeID 13 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.615 {Thread-1} CSTAQueryFwd ::=
06/28/11 11:20:05.615 {Thread-1} {
06/28/11 11:20:05.615 {Thread-1} device "54990"
06/28/11 11:20:05.615 {Thread-1} }
06/28/11 11:20:05.665 <GetEventThread#7> Received invokeID 13 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.665 <GetEventThread#7> CSTAQueryFwdConfEvent ::=
06/28/11 11:20:05.666 <GetEventThread#7> {
06/28/11 11:20:05.666 <GetEventThread#7> forward
06/28/11 11:20:05.666 <GetEventThread#7> {
06/28/11 11:20:05.666 <GetEventThread#7> {
06/28/11 11:20:05.666 <GetEventThread#7> forwardingType 0 < FWD_IMMEDIATE >
06/28/11 11:20:05.666 <GetEventThread#7> forwardingOn FALSE
06/28/11 11:20:05.666 <GetEventThread#7> forwardDN <null>
06/28/11 11:20:05.666 <GetEventThread#7> }
06/28/11 11:20:05.666 <GetEventThread#7> }
06/28/11 11:20:05.666 <GetEventThread#7> }
06/28/11 11:20:05.666 <GetEventThread#7> Putting event CSTAEvent[CSTAQueryFwdConfEvent]@2ab836. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.666 <DistributeCSTAEvent#8> Getting event CSTAEvent[CSTAQueryFwdConfEvent]@2ab836 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.666 <DistributeCSTAEvent#8> Handling INVOKE ID 13 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.667 <DistributeCSTAEvent#8> DONE handling INVOKE ID 13 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.668 {Thread-1} LucentQueryAgentLogin ::=
06/28/11 11:20:05.668 {Thread-1} {
06/28/11 11:20:05.668 {Thread-1} device "54990"
06/28/11 11:20:05.668 {Thread-1} }
06/28/11 11:20:05.668 {Thread-1} Sent InvokeID 14 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.668 {Thread-1} CSTAEscapeSvc ::=
06/28/11 11:20:05.668 {Thread-1} {
06/28/11 11:20:05.668 {Thread-1} NULL
06/28/11 11:20:05.668 {Thread-1} }
06/28/11 11:20:05.668 {Thread-1} TsapiPrivate ::=
06/28/11 11:20:05.668 {Thread-1} {
06/28/11 11:20:05.668 {Thread-1} vendor "ECS"
06/28/11 11:20:05.668 {Thread-1} data 2 0 d 0 30 7 16 5 35 34 39 39 30
06/28/11 11:20:05.668 {Thread-1} tsType 89
06/28/11 11:20:05.669 {Thread-1} }
06/28/11 11:20:05.714 <GetEventThread#7> Received invokeID 14 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.714 <GetEventThread#7> CSTAUniversalFailureConfEvent ::=
06/28/11 11:20:05.714 <GetEventThread#7> {
06/28/11 11:20:05.714 <GetEventThread#7> error 12 < INVALID_CSTA_DEVICE_IDENTIFIER >
06/28/11 11:20:05.714 <GetEventThread#7> }
06/28/11 11:20:05.714 <GetEventThread#7> Putting event CSTAEvent[CSTAUniversalFailureConfEvent]@be6d81. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.714 <DistributeCSTAEvent#8> Getting event CSTAEvent[CSTAUniversalFailureConfEvent]@be6d81 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.714 <DistributeCSTAEvent#8> Handling INVOKE ID 14 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.714 <DistributeCSTAEvent#8> DONE handling INVOKE ID 14 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.715 {Thread-1} Sent InvokeID 15 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.715 {Thread-1} CSTASnapshotDevice ::=
06/28/11 11:20:05.715 {Thread-1} {
06/28/11 11:20:05.715 {Thread-1} snapshotObject "54990"
06/28/11 11:20:05.715 {Thread-1} }
06/28/11 11:20:05.764 <GetEventThread#7> Received invokeID 15 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.764 <GetEventThread#7> CSTASnapshotDeviceConfEvent ::=
06/28/11 11:20:05.764 <GetEventThread#7> {
06/28/11 11:20:05.764 <GetEventThread#7> snapshotData
06/28/11 11:20:05.764 <GetEventThread#7> {
06/28/11 11:20:05.764 <GetEventThread#7> }
06/28/11 11:20:05.764 <GetEventThread#7> }
06/28/11 11:20:05.764 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.764 <GetEventThread#7> {
06/28/11 11:20:05.764 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.764 <GetEventThread#7> data 2 0 48 0 30 0
06/28/11 11:20:05.764 <GetEventThread#7> tsType 123
06/28/11 11:20:05.764 <GetEventThread#7> }
06/28/11 11:20:05.765 <GetEventThread#7> Putting event CSTAEvent[CSTASnapshotDeviceConfEvent]@18f307. EVENT Q SIZE = 1 MAX Q SIZE = 1 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.765 <DistributeCSTAEvent#8> Getting event CSTAEvent[CSTASnapshotDeviceConfEvent]@18f307 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.765 <DistributeCSTAEvent#8> data PDU 72 not decoded
06/28/11 11:20:05.765 <DistributeCSTAEvent#8> Handling INVOKE ID 15 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.765 <DistributeCSTAEvent#8> DONE handling INVOKE ID 15 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.765 {Thread-1} data PDU 72 not decoded
06/28/11 11:20:05.778 {Thread-31} Constructing device TSDevice[54992]@bf6ec3 with name 54992 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.778 {Thread-31} Sent InvokeID 16 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.778 {Thread-31} CSTAQueryDeviceInfo ::=
06/28/11 11:20:05.778 {Thread-31} {
06/28/11 11:20:05.778 {Thread-31} device "54992"
06/28/11 11:20:05.778 {Thread-31} }
06/28/11 11:20:05.778 {Thread-31} getDeviceType() for TSDevice[54992]@bf6ec3
06/28/11 11:20:05.778 {Thread-31} TSDevice[54992]@bf6ec3 waiting for initialization to complete
06/28/11 11:20:05.812 <GetEventThread#7> Received invokeID 16 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.812 <GetEventThread#7> CSTAQueryDeviceInfoConfEvent ::=
06/28/11 11:20:05.812 <GetEventThread#7> {
06/28/11 11:20:05.812 <GetEventThread#7> device "54992"
06/28/11 11:20:05.812 <GetEventThread#7> deviceType 0 < DT_STATION >
06/28/11 11:20:05.812 <GetEventThread#7> deviceClass 0x80000000 < DC_VOICE >
06/28/11 11:20:05.812 <GetEventThread#7> }
06/28/11 11:20:05.812 <GetEventThread#7> TsapiPrivate ::=
06/28/11 11:20:05.812 <GetEventThread#7> {
06/28/11 11:20:05.812 <GetEventThread#7> vendor "ECS"
06/28/11 11:20:05.812 <GetEventThread#7> data 2 0 62 0 30 d a 1 6 a 1 9 16 5 35 31 34 39 36
06/28/11 11:20:05.812 <GetEventThread#7> tsType 38
06/28/11 11:20:05.812 <GetEventThread#7> }
06/28/11 11:20:05.812 <GetEventThread#7> LucentV5QueryDeviceInfoConfEvent ::=
06/28/11 11:20:05.812 <GetEventThread#7> {
06/28/11 11:20:05.812 <GetEventThread#7> extensionClass 6 < EC_PROPRIETARY >
06/28/11 11:20:05.812 <GetEventThread#7> associatedClass 9 < EC_LOGICAL_AGENT >
06/28/11 11:20:05.812 <GetEventThread#7> associatedDevice "51496"
06/28/11 11:20:05.812 <GetEventThread#7> }
06/28/11 11:20:05.812 <GetEventThread#7> Handling INVOKE ID 16 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.815 <GetEventThread#7> Initialization complete for TSDevice TSDevice[54992]@bf6ec3 - making values available - for TSProvider[#2]@3e0d14
06/28/11 11:20:05.815 <GetEventThread#7> DONE handling INVOKE ID 16 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.817 {Thread-31} Getting TsapiCallObserver lock to deliver events for observer com.avaya.sce.cticonnector.servlet.server.CTIConnectorManager$CTICallObserver@1f04078
06/28/11 11:20:05.817 {Thread-31} Sent InvokeID 17 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.817 {Thread-31} CSTAMonitorDevice ::=
06/28/11 11:20:05.817 {Thread-31} {
06/28/11 11:20:05.817 {Thread-31} deviceID "54992"
06/28/11 11:20:05.817 {Thread-31} monitorFilter
06/28/11 11:20:05.817 {Thread-31} {
06/28/11 11:20:05.817 {Thread-31} call 0x0 < >
06/28/11 11:20:05.817 {Thread-31} feature 0x0 < >
06/28/11 11:20:05.817 {Thread-31} agent 0x0 < >
06/28/11 11:20:05.817 {Thread-31} maintenance 0x0 < >
06/28/11 11:20:05.817 {Thread-31} privateFilter 0
06/28/11 11:20:05.817 {Thread-31} }
06/28/11 11:20:05.817 {Thread-31} }
06/28/11 11:20:05.825 {Thread-33} Constructing device TSDevice[54993]@14af6e7 with name 54993 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.825 {Thread-33} Sent InvokeID 18 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.825 {Thread-33} CSTAQueryDeviceInfo ::=
06/28/11 11:20:05.825 {Thread-33} {
06/28/11 11:20:05.825 {Thread-33} device "54993"
06/28/11 11:20:05.825 {Thread-33} }
06/28/11 11:20:05.825 {Thread-33} getDeviceType() for TSDevice[54993]@14af6e7
06/28/11 11:20:05.825 {Thread-33} TSDevice[54993]@14af6e7 waiting for initialization to complete
06/28/11 11:20:05.876 {Thread-34} Constructing device TSDevice[54994]@15bfd47 with name 54994 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.876 {Thread-34} Sent InvokeID 19 for TSProvider[#2]@3e0d14
06/28/11 11:20:05.876 {Thread-34} CSTAQueryDeviceInfo ::=
06/28/11 11:20:05.876 {Thread-34} {
06/28/11 11:20:05.876 {Thread-34} device "54994"
06/28/11 11:20:05.876 {Thread-34} }
06/28/11 11:20:05.876 {Thread-34} getDeviceTy
