Products Products
Support & Forums Support & Forums
Compliance Testing Compliance Testing
Labs & Sandboxes Labs & Sandboxes
Program Program
Co-Marketing Co-Marketing
Avaya Experience Platform Avaya Enterprise Cloud Avaya Client SDK Avaya Aura Platform See All Products Find Developer Resources

Avaya Experience Platform

Overview Interfaces Learning Support Options Compliance Testing

Avaya Enterprise Cloud

Overview Interfaces Learning Support Options Compliance Testing

Avaya Client SDK

Overview Programming Docs Developer Downloads Licensing Support & Testing

Avaya Aura Platform

Application Enablement Services Communication Manager Presence Services Snap-in Session Manager System Manager Session Border Controller
About DevConnect Support Submit Support Tickets Support Forums Other Support Options

About DevConnect Support

Support Options Support FAQs Supported Platforms and Interfaces

Submit Support Tickets

Procured System Support
For procurement issues or questions Remote Lab Support
For issues and questions related to DevConnect remote labs Membership & Program Support
For membership and program benefits questions General Support
For general issues not covered by the other support tickets

Support Forums

Avaya Client SDK AEServices DMCC APIs AEServices JTAPI AEServices Web Services Avaya Workspaces Avaya Experience Platform Orchestration Designer All Forums

Other Support Options

Product Notices Non-DevConnect Support Resources

Compliance Testing

About Compliance Testing Compliance Tested Solutions

About Compliance Testing

Compliance Testing Overview Avaya Interfaces Eligible For Testing Compliance Testing FAQs Compliance Testing Guide(s) (PDF)

Compliance Tested Solutions

DevConnect Marketplace Search Applications Notes

Labs & Sandboxes

Remote Labs Procurement Benefits

Remote Labs

Remote Labs Overview Avaya Aura Session Manager Avaya Aura AE Services & Communication Manager Self Services (Experience Portal) Avaya Proactive Outreach Manager Avaya Contact Center Elite

Procurement Benefits

About DevConnect Procurement Access/View Procurement Catalog Procurement FAQs DevConnect Procured System Support

Program

Program Overview Program Benefits Membership Options

Program Overview

DevConnect Membership Levels DevConnect Program Guide (PDF) DevConnect Program FAQs

Program Benefits

Membership Benefits DevConnect Procurement Co-marketing

Membership Options

Manage My Portfolio/Solutions Manage My Profile

Co-Marketing

Co-Marketing Benefits Relationship Benefits

Co-Marketing Benefits

Co-Marketing Overview Logos Marketplace Co-branded Collateral Select Product Program

Relationship Benefits

Social Media 8-and-Out Podcasts Sponsorships Advertising

Author Message
21/09/2015 13:17:46
Subject: AAOD Got error "error:null" when send CTI disconnect to AES Server
#1
chukiatdenkongpon
Joined: Nov 7, 2013
Messages: 97
Offline
Hi

we have problem that first call with IVR Channel:65115 and it can get CTI with call id, but when send CTI disconnect to AES Server, AAOD Got error "error:null". [Call 1]

For the second call with same IVR Channel: 65115, AAOD Cannot get CTI with call id and got error "CallInfo.doGetCallInfoInitialCall: No call info available for extension 65115" [ Call 2]



However, we found same scenario as above with first call with IVR Channel 65164, got same error "error:null" during send CTI disconnect to AES Server. [Call 3]
But the second call with same IVR Channel: 65164 [ Call 4]

Remark: This AAOD App set manual request CTI in data node.

Please help us to investigate this case. And we cannot open CTIC log because when open debug log, it will got JVM on Websphere down with peak CPU.

This is log file:


----- Start Call 1 -----
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Using SCESession VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow servlet : Initialize
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videonearfmtp to complex: session:videonearfmtp as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___vprdnis to complex: session:vprdnis as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :redirectinfo___uri to complex: redirectinfo:uri as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :redirectinfo___presentationinfo to complex: redirectinfo:presentationinfo as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___channel to complex: session:channel as [65115]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :shareduui___value to complex: shareduui:value as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___sessionlabel to complex: session:sessionlabel as [10001094321441608302]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :shareduui___id to complex: shareduui:id as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :redirectinfo___reason to complex: redirectinfo:reason as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___vpcalledextension to complex: session:vpcalledextension as [65115]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___ani to complex: session:ani as [xxxxxxxxx]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videoheight to complex: session:videoheight as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videocodec to complex: session:videocodec as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videofarfmtp to complex: session:videofarfmtp as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___mediatype to complex: session:mediatype as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___protocolname to complex: session:protocolname as [H323]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :redirectinfo___screeninginfo to complex: redirectinfo:screeninginfo as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___ucid to complex: session:ucid as [10001094321441608302]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videofps to complex: session:videofps as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___vpcoveragereason to complex: session:vpcoveragereason as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videoformat to complex: session:videoformat as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videoenabled to complex: session:videoenabled as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___sharedmode to complex: session:sharedmode as [serviceprovider]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___calltag to complex: session:calltag as [AYCAP01IVR-MPP01-65115-2015250064309]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___dnis to complex: session:dnis as [26789]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :_sipcallid to simple: _sipcallid as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___vpcoveragetype to complex: session:vpcoveragetype as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___uui to complex: session:uui as []
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videobitrate to complex: session:videobitrate as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___videowidth to complex: session:videowidth as [unknown]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___protocolversion to complex: session:protocolversion as [1.0]
07/09/2015 13:41:58 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Storing :session___aai to complex: session:aai as []
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEcjyrrng8pQB0Iufz6JTTrXa
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/CallInfoInitialCall?extension%3D65115&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEcjyrrng8pQB0Iufz6JTTrXa
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: setting session cookie to VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow
07/09/2015 13:41:58 INFO - Eo_f-eOg56xUDJkn16xQ98o:/DYIVRCallFlow : Using SCESession Eo_f-eOg56xUDJkn16xQ98o:/DYIVRCallFlow servlet : LoadConfigObj-ChkSytemStatus
07/09/2015 13:41:58 INFO - Eo_f-eOg56xUDJkn16xQ98o:/DYIVRCallFlow : Assigning [DB] to [ERROR_STATUS]
07/09/2015 13:41:58 INFO - Eo_f-eOg56xUDJkn16xQ98o:/DYIVRCallFlow : [condition1] Expression [SystemFlag:DBFlag] String Not Equal Ignorecase [E]
07/09/2015 13:41:58 DEBUG - Eo_f-eOg56xUDJkn16xQ98o:/DYIVRCallFlow : Executing DB statement : [SELECT MW_SYSTEM_STATUS.SYSTEM_CODE, MW_SYSTEM_STATUS.ERROR_STATUS, MW_SYSTEM_STATUS.REMARK, MW_SYSTEM_STATUS.ERROR_COUNT, MW_SYSTEM_STATUS.MAX_ERROR, MW_SYSTEM_STATUS.START_DATE, MW_SYSTEM_STATUS.MONITOR_TIME, MW_SYSTEM_STATUS.CLOSE_FLAG FROM DYIVR_AYCAP_MW.MW_SYSTEM_STATUS WHERE ( MW_SYSTEM_STATUS.ERROR_COUNT > 0 )]
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: callinfo from Manager is callid=9432&ani=xxxxxxxxx&dnis=26789&extension=65115&ucID=10001094321441608302&uui= &state=established
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.processCallInfoResults: rawResponse: callid=9432&ani=xxxxxxxxx&dnis=26789&extension=65115&ucID=10001094321441608302&uui=+&state=established
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CallInfo.doGetCallInfo: Populating call info variable values...
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Call ID 9432
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Calling # (ANI) xxxxxxxxx
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Called # (DNIS) 26789
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Ext 65115
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: UCID 10001094321441608302
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: UUI
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: State established
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : session id:AYCAP01IVR-MPP01-2015250064309-53 | DYIVRCallFlow:ChkUUI | ###START UUI### | cticallinfo:uui :
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : session id:AYCAP01IVR-MPP01-2015250064309-53 | DYIVRCallFlow:ChkUUI | ###START ANI### | cticallinfo:ani : xxxxxxxxx
07/09/2015 13:41:58 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : session id:AYCAP01IVR-MPP01-2015250064309-53 | DYIVRCallFlow:ChkUUI | ###START DNIS### | cticallinfo:dnis : 26789

----- End Call 1 -----
07/09/2015 13:45:15 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Using SCESession VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow servlet : CTIDisconnect
07/09/2015 13:45:15 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Assigning [Disconnect] to [ERROR_STATUS]
07/09/2015 13:45:15 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : [condition1] Expression [CTIConnectorFlag] String Equal Ignorecase [Y]
07/09/2015 13:45:15 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEcjWvIzHxvTnIYufz6JTTrXa
07/09/2015 13:45:15 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : VariableUtil.getVariableValue: Variable value is 9432
07/09/2015 13:45:15 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/Disconnect?callid%3D9432%26extension%3D65115&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEcjWvIzHxvTnIYufz6JTTrXa
07/09/2015 13:45:15 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: setting session cookie to VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow
07/09/2015 13:45:15 DEBUG - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : CTICommand.execute: callinfo from Manager is error:null
07/09/2015 13:45:15 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Capturing exception [com.avaya.sce.runtimecommon.SCERuntimeException]. Message [null]
07/09/2015 13:45:15 INFO - VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow : Using SCESession VxC5cCv6iebLoQNoPQFH17p:/DYIVRCallFlow servlet : Return


----- Start Call 2 -----
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videonearfmtp to complex: session:videonearfmtp as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___vprdnis to complex: session:vprdnis as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :redirectinfo___uri to complex: redirectinfo:uri as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :redirectinfo___presentationinfo to complex: redirectinfo:presentationinfo as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___channel to complex: session:channel as [65115]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :shareduui___value to complex: shareduui:value as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___sessionlabel to complex: session:sessionlabel as [10001121361441608602]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :shareduui___id to complex: shareduui:id as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :redirectinfo___reason to complex: redirectinfo:reason as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___vpcalledextension to complex: session:vpcalledextension as [65115]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___ani to complex: session:ani as [xxxxxxxxx]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videoheight to complex: session:videoheight as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videocodec to complex: session:videocodec as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videofarfmtp to complex: session:videofarfmtp as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___mediatype to complex: session:mediatype as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___protocolname to complex: session:protocolname as [H323]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :redirectinfo___screeninginfo to complex: redirectinfo:screeninginfo as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___ucid to complex: session:ucid as [10001121361441608602]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videofps to complex: session:videofps as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___vpcoveragereason to complex: session:vpcoveragereason as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videoformat to complex: session:videoformat as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videoenabled to complex: session:videoenabled as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___sharedmode to complex: session:sharedmode as [serviceprovider]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___calltag to complex: session:calltag as [AYCAP01IVR-MPP01-65115-2015250064809]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___dnis to complex: session:dnis as [26789]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :_sipcallid to simple: _sipcallid as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___vpcoveragetype to complex: session:vpcoveragetype as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___uui to complex: session:uui as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videobitrate to complex: session:videobitrate as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___videowidth to complex: session:videowidth as [unknown]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___protocolversion to complex: session:protocolversion as [1.0]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Storing :session___aai to complex: session:aai as []
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Using SCESession OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow servlet : ChkUUI
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Assigning [] to [ERROR_STATUS]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Assigning [START] to [CTI_ERROR]
07/09/2015 13:47:00 DEBUG - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEchryQabpiGlg4ufz6JTTrXa
07/09/2015 13:47:00 DEBUG - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/CallInfoInitialCall?extension%3D65115&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEchryQabpiGlg4ufz6JTTrXa
07/09/2015 13:47:00 DEBUG - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : CTICommand.execute: setting session cookie to OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Using SCESession OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow servlet : ChkUUI
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Assigning [] to [ERROR_STATUS]
07/09/2015 13:47:00 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Assigning [START] to [CTI_ERROR]
07/09/2015 13:47:00 DEBUG - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEchryQabpiGlg4ufz6JTTrXa
07/09/2015 13:47:00 DEBUG - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/CallInfoInitialCall?extension%3D65115&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEchryQabpiGlg4ufz6JTTrXa
07/09/2015 13:47:00 DEBUG - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : CTICommand.execute: setting session cookie to OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow
07/09/2015 13:47:05 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Capturing exception [com.avaya.sce.runtimecommon.SCERuntimeException]. Message [CallInfo.doGetCallInfoInitialCall: No call info available for extension 65115]
07/09/2015 13:47:05 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Using SCESession OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow servlet : SetLogCTICallStartError
07/09/2015 13:47:05 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Assigning [E000003] to [transaction:checkpoint]
07/09/2015 13:47:05 INFO - OnzjC6nVhA6yT-UNcwMYK-G:/DYIVRCallFlow : Assigning [CTI CallStart Error] to [transaction:result]

Call 3
----- Start Call 3 -----
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :redirectinfo___uri to complex: redirectinfo:uri as []
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :redirectinfo___presentationinfo to complex: redirectinfo:presentationinfo as []
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___channel to complex: session:channel as [65164]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :shareduui___value to complex: shareduui:value as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___sessionlabel to complex: session:sessionlabel as [10001072411441608068]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :shareduui___id to complex: shareduui:id as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :redirectinfo___reason to complex: redirectinfo:reason as []
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___vpcalledextension to complex: session:vpcalledextension as [65164]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___ani to complex: session:ani as [xxxxxxxxx]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___videoheight to complex: session:videoheight as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___videocodec to complex: session:videocodec as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___videofarfmtp to complex: session:videofarfmtp as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___mediatype to complex: session:mediatype as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___protocolname to complex: session:protocolname as [H323]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :redirectinfo___screeninginfo to complex: redirectinfo:screeninginfo as []
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___ucid to complex: session:ucid as [10001072411441608068]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___videofps to complex: session:videofps as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___vpcoveragereason to complex: session:vpcoveragereason as []
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___videoformat to complex: session:videoformat as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___videoenabled to complex: session:videoenabled as [unknown]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Storing :session___sharedmode to complex: session:sharedmode as [serviceprovider]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Assigning [] to [ERROR_STATUS]
07/09/2015 13:38:04 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Assigning [START] to [CTI_ERROR]
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEchsBZhT1B7jv4ufz6JTTrXa
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/CallInfoInitialCall?extension%3D65164&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEchsBZhT1B7jv4ufz6JTTrXa
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: setting session cookie to xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: callinfo from Manager is callid=7241&ani=959473615&dnis=26789&extension=65164&ucID=10001072411441608068&uui= &state=established
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.processCallInfoResults: rawResponse: callid=7241&ani=959473615&dnis=26789&extension=65164&ucID=10001072411441608068&uui=+&state=established
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CallInfo.doGetCallInfo: Populating call info variable values...
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Call ID 7241
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Calling # (ANI) xxxxxxxxx
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Called # (DNIS) 26789
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Ext 65164
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: UCID 10001072411441608068
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: UUI
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: State established
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : session id:AYCAP01IVR-MPP02-2015250063915-39 | DYIVRCallFlow:ChkUUI | ###START UUI### | cticallinfo:uui :
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : session id:AYCAP01IVR-MPP02-2015250063915-39 | DYIVRCallFlow:ChkUUI | ###START ANI### | cticallinfo:ani : xxxxxxxxx
07/09/2015 13:38:04 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : session id:AYCAP01IVR-MPP02-2015250063915-39 | DYIVRCallFlow:ChkUUI | ###START DNIS### | cticallinfo:dnis : 26789

----- End Call 3 -----
07/09/2015 13:39:39 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : [condition1] Expression [CTIConnectorFlag] String Equal Ignorecase [Y]
07/09/2015 13:39:39 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEch7ZSzYxhafcIufz6JTTrXa
07/09/2015 13:39:39 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : VariableUtil.getVariableValue: Variable value is 7241
07/09/2015 13:39:39 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/Disconnect?callid%3D7241%26extension%3D65164&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEch7ZSzYxhafcIufz6JTTrXa
07/09/2015 13:39:39 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: setting session cookie to xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow
07/09/2015 13:39:39 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTICommand.execute: callinfo from Manager is error:null
07/09/2015 13:39:39 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Capturing exception [com.avaya.sce.runtimecommon.SCERuntimeException]. Message [null]
07/09/2015 13:39:39 INFO - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : Using SCESession xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow servlet : Return
07/09/2015 13:39:39 DEBUG - xDGhO2PQZy5NWjJee54_ySx:/DYIVRCallFlow : CTIEnd.execute:65164 callid is 7241

Call 4

07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :redirectinfo___presentationinfo to complex: redirectinfo:presentationinfo as []
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___channel to complex: session:channel as [65164]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :shareduui___value to complex: shareduui:value as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___sessionlabel to complex: session:sessionlabel as [10001091991441608272]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :shareduui___id to complex: shareduui:id as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :redirectinfo___reason to complex: redirectinfo:reason as []
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___vpcalledextension to complex: session:vpcalledextension as [65164]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___ani to complex: session:ani as [xxxxxxxxx]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___videoheight to complex: session:videoheight as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___videocodec to complex: session:videocodec as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___videofarfmtp to complex: session:videofarfmtp as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___mediatype to complex: session:mediatype as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___protocolname to complex: session:protocolname as [H323]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :redirectinfo___screeninginfo to complex: redirectinfo:screeninginfo as []
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___ucid to complex: session:ucid as [10001091991441608272]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___videofps to complex: session:videofps as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___vpcoveragereason to complex: session:vpcoveragereason as []
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___videoformat to complex: session:videoformat as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___videoenabled to complex: session:videoenabled as [unknown]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___sharedmode to complex: session:sharedmode as [serviceprovider]
07/09/2015 13:41:29 INFO - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : Storing :session___calltag to complex: session:calltag as [AYCAP01IVR-MPP02-65164-2015250064240]
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.execute: encrypted value is VJ/LB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEciU3x2fyJx5Doufz6JTTrXa
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.execute: request to manager is http://cluster3.aycap.bayad.co.th:8070/aesconnector/CallInfoInitialCall?extension%3D65164&k=VJ%2FLB6Bb5NjTZnb4DQhyaMg0XJA8KvyDv6nI4X4UEciU3x2fyJx5Doufz6JTTrXa
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.execute: setting session cookie to _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.execute: callinfo from Manager is callid=9199&ani=818853776&dnis=26789&extension=65164&ucID=10001091991441608272&uui= &state=established
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.processCallInfoResults: rawResponse: callid=9199&ani=818853776&dnis=26789&extension=65164&ucID=10001091991441608272&uui=+&state=established
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CallInfo.doGetCallInfo: Populating call info variable values...
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Call ID 9199
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Calling # (ANI) xxxxxxxxx
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Called # (DNIS) 26789
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: Ext 65164
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: UCID 10001091991441608272
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: UUI
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : CTICommand.setCallInfoVariableValues: State established
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : session id:AYCAP01IVR-MPP02-2015250064240-3 | DYIVRCallFlow:ChkUUI | ###START UUI### | cticallinfo:uui :
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : session id:AYCAP01IVR-MPP02-2015250064240-3 | DYIVRCallFlow:ChkUUI | ###START ANI### | cticallinfo:ani : xxxxxxxxx
07/09/2015 13:41:29 DEBUG - _3PFzATMbMCG8ANyc1WW1fs:/DYIVRCallFlow : session id:AYCAP01IVR-MPP02-2015250064240-3 | DYIVRCallFlow:ChkUUI | ###START DNIS### | cticallinfo:dnis : 26789




PM
21/09/2015 13:22:02
Subject: Re:AAOD Got error "error:null" when send CTI disconnect to AES Server
#2
NeilGoldsmith
Joined: Nov 6, 2013
Messages: 902
Offline
You are going to have to include an AESC log in order to debug this. The app log is not enough.
PM
21/09/2015 13:26:37
Subject: Re:AAOD Got error "error:null" when send CTI disconnect to AES Server
#3
chukiatdenkongpon
Joined: Nov 7, 2013
Messages: 97
Offline
Hi NeilGoldsmith,

Thank you for response.

However, when we enable debug AESC log, CPU on JVM will grow up and cause AAOD App cannot get CTI with Call ID.

Can you please suggestion on this case?

Chukiat D.

PM
21/09/2015 14:58:48
Subject: Re:AAOD Got error "error:null" when send CTI disconnect to AES Server
#4
NeilGoldsmith
Joined: Nov 6, 2013
Messages: 902
Offline
If I had to guess, you are using a load balancer and the request is going to the wrong AESC.
PM
22/09/2015 06:38:58
Subject: Re:AAOD Got error "error:null" when send CTI disconnect to AES Server
#5
chukiatdenkongpon
Joined: Nov 7, 2013
Messages: 97
Offline
Hi Neil,

Yes, it is load balance with two AES.

So how can we fixed this case?

Do we need to resend CTI disconnect when got error:null?

Do we send CTI disconect in next call in case we got error cannot monitor cti?

Please advice.

Thank you.

Best Regards,
Chukiat D.
PM
22/09/2015 09:53:31
Subject: Re:AAOD Got error "error:null" when send CTI disconnect to AES Server
#6
NeilGoldsmith
Joined: Nov 6, 2013
Messages: 902
Offline
On AESC plugin properties in your application properties page, there is a checkbox to use localhost instead of the IP address passed in via the HTTP Request. In a load balanced scenario, you should always check that box (and put in the port manually on that page too). This will bypass the issues of getting the wrong IP from the load balancer.
PM
Go to:   
Mobile view