VoiceGuide IVR Software Main Page
Jump to content

Call Dropouts

By Guest miva, in General

Recommended Posts

Guest miva   

Posted

We've got two identical servers (vgEngine v7.0.3292.22230 (Mon 05/01/2009 12:21:00.31) exhibiting the same problem with regular call dropouts for "dialout and conference - monitored" cals and with silencedetectlvl set as 0. Some calls can go for an hour or more. This may have been happening for some time and we weren't aware of it, but we have confirmed that it is occurring multiple times over the course of the day.

 

The log files are quite large so I've included what I believe is the relevant sections below specific to one known example:

 

143656.203  6  34       rvns  add [bR-CS-CheckOutbound_Input]{2>0}
143656.203  6  34       rvns  add [bR-CS-CheckOutbound]{True}
143656.203  6  34       Eval Expr result:[True]
143656.203  6  34       path {True} found (at offset 3)
143656.203  6  34       FindNextVgmTitleInPathList: next module title is=[QRecord-BR-CS]
143656.203  6  34 t     clear (force=False)
143656.203  6  34       RunModule start [Play,[QRecord-BR-CS],137]
143656.203  6  34       [QRecord-BR-CS] VGMTYPE_PLAY run start
143656.203  6  34 state [QRecord-BR-CS] Playing
143656.203  6  34       asr   no grammar file found [C:\Program Files\VoiceGuide\Scripts\MCR\BioRad\1BRCustomerService\srgs_QRecord-BR-CS_12.gram][C:\Program Files\VoiceGuide\Scripts\MCR\BioRad\1BRCustomerService\srgs_QRecord-BR-CS.gram][C:\Program Files\VoiceGuide\Scripts\MCR\BioRad\1BRCustomerService\srgs_QRecord-BR-CS_12.txt][C:\Program Files\VoiceGuide\Scripts\MCR\BioRad\1BRCustomerService\srgs_QRecord-BR-CS.txt]
143656.203  6  34       PrepareAndPlayWavAndTts start iModuleIdx=137, iPlayFileIdx=1, bMakeTtsFile=True, sSoundFileIs=
143656.203  6  34       PrepareAndPlayWavAndTTS sPlayFile=none
143656.203  6  34 state [QRecord-BR-CS] Playing wav (none)
143656.203  6  34       qScr  add   evScriptEvent 8001 EV_PLAY_FINISHED
143656.203  6  34       qScr  run   evScriptEvent EV_PLAY_FINISHED, iActionID=0, crn=0[0|0|0|0|0][|||||]
143656.203  6  34       ScriptEvent EV_PLAY_FINISHED  ||
143656.203  6  34       LsPlayMsg EV_PLAY_FINISHED,EV_PLAY_FINISHED
143656.203  6  34       path {EV_PLAY_FINISHED} not found
143656.203  6  34       iCurrReplayCount=0, iMaxReplayCount=0
143656.218  6  34 t     set 10  EV_TIMEOUT_HANGUP
143656.218  6  34 t     set 4  EV_TIMEOUT_GOTOMODULE
143656.359 18  13 ev    CallState sEvent=LINECALLSTATE_CONNECTED, crn=20080e0, iEvent=2 ,256,2,4,,,]. vgEngine v7.0.3292.22230 (Mon 05/01/2009 12:21:00.31)
143656.359 18  13       qScr  add   evCallState 2 LINECALLSTATE_CONNECTED
143656.359  6  13       qScr  run   evCallState LINECALLSTATE_CONNECTED, iActionID=0, crn=20080e0[256|2|4|0|0][|||||]
143656.359  6  13       callstate: CONNECTED crn=20080e0,ev=2,LINECALLSTATE_CONNECTED,2, sParam1=
143656.359  6   7       qScr  add   evScriptEvent 0 OTHER_LEG_CONNECTED
143656.359  6  13       Set_hCall crn=20080e0, called from LINECALLSTATE_CONNECTED
143656.359  6  13       LineEvCallState_Connected_OutBound crn=20080e0, WorkingModeScript=Running_Dialing
143656.359  6  13       connected event :  outgoing leg of call now awaits end of call (state=waitendcall)
143656.359  6  13       Set_hCall crn=20080e0, called from LineEvCallState_Connected_OutBound
143656.359  6  13       qScr  add   evScriptEvent -1 CONNECTED
143656.359  6   7       qScr  run   evScriptEvent OTHER_LEG_CONNECTED, iActionID=0, crn=0[256|2|4|0|0][|||||]
143656.359  6   7       ScriptEvent OTHER_LEG_CONNECTED  ||
143656.359  6   7       LsPlayMsgFinished EV_UNKNOWN_0,OTHER_LEG_CONNECTED, [ ], [ ], []
143656.359  6   7       path {OTHER_LEG_CONNECTED} not found
143656.359  6  13       qScr  run   evScriptEvent CONNECTED, iActionID=0, crn=0[0|0|0|0|0][|||||]
143656.359  6  13       ScriptEvent CONNECTED  ||
143656.359  6  13       LsXfer_9_WaitEndCall_OutLeg : -1(), [CONNECTED], 0,0,0,,,
143656.359  6   7       qScr  add   evScriptEvent -1 OTHER_LEG_CONNECTED
143656.359  6   7       qScr  run   evScriptEvent OTHER_LEG_CONNECTED, iActionID=0, crn=0[0|0|0|0|0][|||||]
143656.359  6   7       ScriptEvent OTHER_LEG_CONNECTED  ||
143656.359  6   7       LsPlayMsgFinished EV_UNKNOWN_-1,OTHER_LEG_CONNECTED, [ ], [ ], []
143656.359  6   7       path {OTHER_LEG_CONNECTED} not found
143658.062 22  10       db    oledb connection open returned.
143658.062 25  34       oVgmDbQuery_AdoNetCommon_Completed SqlQueryType=NONQUERY, RowsCount=1
143658.062 25  34       HangupCall ('and any associated'=False), source=oVgmDbQuery_AdoNetCommon_Completed PathNotDefined, linestate=[CONNECTED]
143658.062 25  34 state Hanging up... [oVgmDbQuery_AdoNetCommon_Completed PathNotDefined]
143658.062 25  34       rv    add [Hangup Source]{oVgmDbQuery_AdoNetCommon_Completed PathNotDefined}
143658.062 25  34       RecSoundStop begin trunc100ms=0, sCaller=Line_Hangup_Main
143658.062 25  34       tqTel que cmd_RecordStop [0,0,0,0,0][||||]
143658.062 25  34       DropCall_ScriptRunStateAware start (crn=20080d9)
143658.062 25  34 t     set 40  EV_TIMEOUT_WAITFORIDLEAFTERDropCall
143658.062 25  34       tqTel que cmd_DropCall [0,0,0,0,0][||||]
143658.062 25  34       DropCall_ScriptRunStateAware end
143658.062  7  34       tqTel run cmd_RecordStop
143658.062 25  34       db    oledb ConnectAndRun_OleDb completed.
143658.093  7  34       tqTel run cmd_DropCall
143658.109 18  34 ev    Dialogic 130,TDX_RECORD, crn=20080d9, 0,0,0,TM_USRSTOP,,
143658.109 18  34       qScr  add   evScriptEvent 130 TDX_RECORD
143658.109  6  34       qScr  run   evScriptEvent TDX_RECORD, iActionID=0, crn=0[0|0|0|0|0][TM_USRSTOP|||||]
143658.109  6  34       ScriptEvent TDX_RECORD  TM_USRSTOP||
143658.109  6  34       LsEndingCall TDX_RECORD
143658.109 18  34       qScr  add   evScriptEvent 8003 EV_REC_FINISHED
143658.109  6  34       qScr  run   evScriptEvent EV_REC_FINISHED, iActionID=0, crn=0[0|0|0|0|0][|||||]
143658.109  6  34       ScriptEvent EV_REC_FINISHED  ||
143658.109  6  34       LsEndingCall EV_REC_FINISHED
143658.203 18  34 ev    Dialogic 2053,GCEV_DROPCALL, crn=20080d9, 2053,0,0,,,
143658.203 18  34       qScr  add   evScriptEvent 2053 GCEV_DROPCALL
143658.203 18  34 ev    CallState sEvent=LINECALLSTATE_IDLE, crn=20080d9, iEvent=2 ,1,0,32,,,]. vgEngine v7.0.3292.22230 (Mon 05/01/2009 12:21:00.31)
143658.203  6  34       qScr  run   evScriptEvent GCEV_DROPCALL, iActionID=0, crn=0[2053|0|0|0|0][|||||]
143658.203 18  34       qScr  add   evCallState 2 LINECALLSTATE_IDLE
143658.203  6  34       ScriptEvent GCEV_DROPCALL  ||
143658.203  6  34       LsEndingCall GCEV_DROPCALL
143658.203  6  34       qScr  run   evCallState LINECALLSTATE_IDLE, iActionID=0, crn=20080d9[1|0|32|0|0][|||||]
143658.203  6  34       callstate: IDLE crn=20080d9,ev=2,LINECALLSTATE_IDLE,0, sParam1=
143658.203  6   2       qScr  add   evScriptEvent 0 OTHER_LEG_IDLE
143658.203  6  34 t     clear (force=True)
143658.203  6  34       CallData.dateCallStartTime=14/01/2010 2:32:06 PM
143658.203  6  34       rv    add [CallHangupTime]{2010-01-14 14:36:58}
143658.203  6  34       WriteCDRlogs: begin (campaign=, CallData.iLineId=0)
143658.203  6  34       writing CDR logs

 

and ktTel

 

143650.218 2888   9       CtEventProcess (from store) idx=569, evtdev=9, crn=00000000, evttype=134, data=084BE070, len=4 (store: evinque=0, maxever=1)
143650.218 2888   9 ev    TDX_CST (CST Event Received)
143650.218 2888   9       TDX_CST DE_DIGITS data=48 [0], SpeedVolKeyControlsUsed=0
143650.218 2888   7 raise dtmf 0
143650.218 2664   7 fn    PlayStop(iLineId=7, iActionID=0, iParam1=0, iParam1=0, sParam1=, sParam1=)
143650.218 2664   7       PlayStop(hLine=7, iPlayId=0(0x0), iParam1=0, iParam2=0, zsParam1=, zsParam2=)
143650.218 2664   7       dx_stopch call in PlayStop
143650.218 2664   7       dx_stopch 9 ok
143650.218 2888   9       CtEventProcess (from store) idx=570, evtdev=9, crn=00000000, evttype=129, data=084BE070, len=0 (store: evinque=0, maxever=1)
143650.218 2888   9 ev    TDX_PLAY (Play Completed)
143650.218 2888   7       EvHandler_TDX_PLAY  hPlayRec_IottChainStart=0x158b0770, hPlayRec_IottChainStart_Copy=0x158b0748
143650.218 2888   7       play  free(0x8dc6ae0, 0x158b0770) eot
143650.218 2888   7       cleared dwPlayId: hli=00F49DA8, hli->dwPlayId=0(0x0)
143650.218 2888   7       CTelProxy::Event_PlayEnd begin
143650.218 2888   7 raise PlayEnd 979343
143650.218 2888   7       CTelProxy::Event_PlayEnd end
143650.625 2664  13 fn    LineMakeCall(iLineId=13, iCallRequestId=0 (ignored), strNumberToCall=[0283145402], callprog=CONNECT_IMMEDIATELY, timeout=60, params:0,0,cid=[(null)],opt=[<calltype>DialAndConf</calltype>])
143650.625 2664  13       makecall protocol is: ISDN
143650.640 2664  13       TelDriver_LineMakeCall hli->Dial_zsOtherCallProgressSettings=[<calltype>DialAndConf</calltype>]
143650.640 2664  13       Set_DX_CAP_ca_intflg zDial_DxCap.ca_intflg=DX_OPTDIS (CONNECT_IMMEDIATELY case)
143650.640 2664  13       CallProgressOption=[CONNECT_IMMEDIATELY] ca_intflg=222526832
143650.640 2664           MakeCall select driver. strDti=[dtiB1T5]
143650.640 2664           MakeCall driver non-HMP version used strDti=[dtiB1T5]
143650.640 2664  13       gc_MakeCall initialisation (SR)
143650.656 2664  13       set outgoing cid(13, []) ok
143650.656 2664  13       set outgoing CallerID name here.
143650.656 2664  13       makecall defsrc none ()
143650.656 2664  13       gc_MakeCall [0283145402] call (SR60)
143650.656 2664  13       gc_MakeCall ok. crn=020080E0
143650.656 2664  13       call progress detection not enabled as ca_intflg == DX_OPTDIS (2)
143650.656 2664  13       TelDriver_LineMakeCall returned 0, hli_Returned=0D425FF0
143650.656 2664  13       TelDriver_LineMakeCall returned hli_Returned->crn_lastMakeCall=020080E0
143650.656 2664  13 raise generic ktTel_Completion|10000  Completion_MakeCall|0  33587424 (33587424|0|0|0283145402|<calltype>DialAndConf</calltype>|<result>ok</result><crn>33587424</crn>)
143650.656 2664  13       LineMakeCall TelDriver_LineMakeCall zsResult=[<result>ok</result><crn>33587424</crn>]
143650.656 2664   7 fn    PlayStop(iLineId=7, iActionID=0, iParam1=0, iParam1=0, sParam1=, sParam1=)
143650.656 2664   7       PlayStop(hLine=7, iPlayId=0(0x0), iParam1=0, iParam2=0, zsParam1=, zsParam2=)
143650.656 2664   7       dx_stopch call in PlayStop
143650.656 2664   7       dx_stopch 9 ok
143650.656 2664  13 fn    PlayStop(iLineId=13, iActionID=0, iParam1=0, iParam1=0, sParam1=, sParam1=)
143650.656 2664  13       PlayStop(hLine=13, iPlayId=0(0x0), iParam1=0, iParam2=0, zsParam1=, zsParam2=)
143650.656 2664  13       dx_stopch call in PlayStop
143650.656 2664  13       dx_stopch 15 ok
143650.656 2664     fn    TsRoute(sDev1Name=dtiB1T3, sDev1Type=, sDev2Name=dtiB1T5, sDev2Type=, sConnectionType=SC_FULLDUP
143650.656 2664     fn    TsRoute [dtiB1T3][][dtiB1T5][][sC_FULLDUP], iDlgcBoardCount_DTI=1
143650.656 2664           set DevType1 = DTI, DevType2 = DTI
143650.656 2664           dt_open (dtiB1T3, 0) call
143650.656 2664           opened dt dtiB1T3 as devh=37
143650.656 2664           dt_open(dtiB1T5, 0) call
143650.671 2664           opened dt dtiB1T5 as devh=39
143650.671 2664           nr_scroute(37, 3, 39, 3, 0) call
143650.671 2888  13       CtEventProcess (from store) idx=571, evtdev=13, crn=020080E0, evttype=2145, data=0C407490, len=28 (store: evinque=0, maxever=1)
143650.671 2888  13 ev    GCEV_DIALING crn=020080E0=33587424 crn_lastMakeCall=020080E0=33587424
143650.671 2888  13       CTelProxy::Event_CallState LINECALLSTATE_DIALING iLineCallState=16, hCall=33587424 m_pktTelProxyClient=006519D0
143650.671 2888  13 raise CallState LINECALLSTATE_DIALING
143650.765 2888  13       CtEventProcess (from store) idx=572, evtdev=13, crn=020080E0, evttype=2087, data=0C32DF60, len=28 (store: evinque=0, maxever=1)
143650.765 2888  13 ev    GCEV_PROCEEDING crn=020080E0=33587424 lastMakeCall=0x20080e0 (33587424) hli->crn=020080E0
143650.765 2888  13       ResultInfo gcValue=137(0x89) gcMsg=[CCLIB specific] ccLibId=2 ccLibName=[GC_ISDN_LIB] ccValue=[0x24|EGC_CCLIBSPECIFIC|cclib specific - a catchall] ccMsg=[Received PROCEEDING message] additionalinfo=
143652.250 2888  13       CtEventProcess (from store) idx=573, evtdev=13, crn=020080E0, evttype=2081, data=0C3EEA60, len=28 (store: evinque=0, maxever=1)
143652.250 2888  13 ev    GCEV_ALERTING crn=020080E0 (ktTel_SR60 v7.0.9, Jan  4 2009 10:50:37)
143652.250 2888  13 raise Dialogic  GCEV_ALERTING 2081 (2081 0 0   )
143656.359 2888  13       CtEventProcess (from store) idx=574, evtdev=13, crn=020080E0, evttype=2082, data=0C407490, len=28 (store: evinque=0, maxever=1)
143656.359 2888  13 ev    GCEV_CONNECTED (ktTel_SR60 v7.0.9, Jan  4 2009 10:50:37)
143656.359 2888  13       not routing voice to network as Dial_zsOtherCallProgressSettings=[<calltype>DialAndConf</calltype>]
143656.359 2888  13       call progress: not enabled as zDial_DxCap.ca_intflg=DX_OPTDIS
143656.359 2888  13       GCEV_CONNECTED gc_GetCallInfo >> ATDX_CONNTYPE=0, iRet=0, strConstName=[GCCT_NA], strRet=[]
143656.359 2888  13       ResultInfo gcValue=0(0x0) gcMsg=[success] ccLibId=2 ccLibName=[GC_ISDN_LIB] ccValue=[0x0|GC_SUCCESS|GC_SUCCESS] ccMsg=[No error] additionalinfo=
143656.359 2888  13       CTelProxy::Event_CallState LINECALLSTATE_CONNECTED iLineCallState=256, hCall=33587424 m_pktTelProxyClient=006519D0
143656.359 2888  13 raise CallState LINECALLSTATE_CONNECTED
143658.062 2664  34 fn    RecordStop(iLineId=34, iActionID=0, sFileName=, iTruncTimeMs=0, iTruncBytes=0, sXMLOptions=)
143658.062 2664  34       TelDriver_RecStop lTruncMs=0, lTruncBytes=0
143658.062 2664  36       dx_stopch call in RecStopTruncate
143658.062 2664  36       dx_stopch 36 ok in RecStopTruncate
143658.093 2664  34 fn    DropCall(sLineId=34, sXMLOptions=[], iParam1=0)
143658.093 2664  34       TelDriver_DropCall(sXMLOptions=[])
143658.093 2664  34       gc_DropCall crn=020080D9 cause=16:GC_NORMAL_CLEARING (nocausetag)
143658.093 2664  34       gc_DropCall ok
143658.093 2888  36       CtEventProcess (from store) idx=575, evtdev=36, crn=00000000, evttype=130, data=084BE070, len=0 (store: evinque=0, maxever=1)
143658.093 2888  36 ev    TDX_RECORD (Record Completed)
143658.093 2888  36       termmask=TM_USRSTOP
143658.093 2888  36       TDX_RECORD, TERMMSK=TM_USRSTOP
143658.093 2888  34 raise Dialogic  TDX_RECORD 130 (0 0 0 TM_USRSTOP  )
143658.109 2888  34       file close 6 ok
143658.109 2888     
143658.109 2888           cut   CreateFile(D:\Recordings\1BRCustomerService\100114_14324552365.922.wav, OPEN_EXISTING) => hFile=8288
143658.109 2888           cut filesize=2012878, cut=0, hdrlen=0
143658.109 2888  34       cut keep length at 2012878. iSoundDataLen=2012878
143658.109 2888  34       UpdateWavHeaderInFile begin len=2012878, format=7, hz=8000, name=[D:\Recordings\1BRCustomerService\100114_14324552365.922.wav]
143658.109 2888  34       UpdateWavHeaderInFile after PrepareWavHeader
143658.109 2888  34       DumpFirst64bytesTotrace not enabled in this version
143658.109 2888  34       _close call
143658.109 2888  34       fopen call D:\Recordings\1BRCustomerService\100114_14324552365.922.wav
143658.109 2888  34       fread call
143658.109 2888  34       DumpFirst64bytesTotrace not enabled in this version
143658.109 2888  34       wav: format=7, channels=1, hz=8000, bytes/sec=8000, bytes/sample=1, bits/sample=8, DataBlockSize=2012834(0x1eb6a2)
143658.109 2888  34       write end: wav header datalen=2012878, format=7, hdrlen=1
143658.109 2888  34       CTelProxy::Event_RecEnd begin D:\Recordings\1BRCustomerService\100114_14324552365.922.wav zsParam1= zsParam2= (m_pktTelProxyClient=0x6519d0)
143658.109 2888  34 raise RecEnd
143658.109 2888  34       CTelProxy::Event_RecEnd end
143658.109 2888  34       rec   exit ctEventProcess
143658.203 2888  34       CtEventProcess (from store) idx=576, evtdev=34, crn=020080D9, evttype=2053, data=0C3EEA60, len=28 (store: evinque=0, maxever=1)
143658.203 2888  34 ev    GCEV_DROPCALL crn=020080D9
143658.203 2888  34 raise Dialogic  GCEV_DROPCALL 2053 (2053 0 0   )
143658.203 2888  34       CTelProxy::Event_CallState LINECALLSTATE_IDLE iLineCallState=1, hCall=33587417 m_pktTelProxyClient=006519D0
143658.203 2888  34 raise CallState LINECALLSTATE_IDLE
143658.203 2888  34       ec    ec_stream not enabled. ec_stopch not called
143658.218 2664   2 fn    DropCall(sLineId=2, sXMLOptions=[], iParam1=0)
143658.218 2664   2       TelDriver_DropCall(sXMLOptions=[])
143658.218 2664   2       gc_DropCall crn=020080DA cause=16:GC_NORMAL_CLEARING (nocausetag)
143658.218 2664   2       gc_DropCall ok
143658.312 2888   2       CtEventProcess (from store) idx=577, evtdev=2, crn=020080DA, evttype=2053, data=0060E490, len=28 (store: evinque=0, maxever=1)
143658.312 2888   2 ev    GCEV_DROPCALL crn=020080DA
143658.312 2888   2 raise Dialogic  GCEV_DROPCALL 2053 (2053 0 0   )
143658.312 2888   2       CTelProxy::Event_CallState LINECALLSTATE_IDLE iLineCallState=1, hCall=33587418 m_pktTelProxyClient=006519D0
143658.312 2888   2 raise CallState LINECALLSTATE_IDLE
143658.328 2888   2       ec    ec_stream not enabled. ec_stopch not called
143658.328 2664   2 fn    ReleaseCall(sLineId=2, crn=020080DA, Param1=0)
143658.328 2664   2       gc_ReleaseCallEx crn=020080DA (hli->crn=020080DA) in TelDriver_ReleaseCall 
143658.328 2664   2       gc_ReleaseCallEx ok
143658.343 2888   2       CtEventProcess (from store) idx=578, evtdev=2, crn=020080DA, evttype=2137, data=0C32DF60, len=28 (store: evinque=0, maxever=1)
143658.343 2888   2 ev    GCEV_RELEASECALL crn=020080DA
143658.343 2888   2       CTelProxy::Event_CallState GCEV_RELEASECALL iLineCallState=0, hCall=33587418 m_pktTelProxyClient=006519D0
143658.343 2888   2 raise CallState GCEV_RELEASECALL
143706.875 2664     fn    TsReset(sDev1Name=dtiB1T12, sDev1Type=, sDev2Name=dtiB1T1, sDev2Type=, sDisconnectionType=MATCH_
143706.875 2664           TsSlotInfo_Get sDevName = DTI as sDevName=dtiB1T12
143706.890 2664  37       opened dt dtiB1T12 as devh=37
143706.890 2664           TsSlotInfo_Get sDevName = DTI as sDevName=dtiB1T1
143706.906 2664  39       opened dt dtiB1T1 as devh=39
143706.906 2664           unroute(37, 3, 39, 3, 0) call
143706.906 2664  37       dt_close(37, dtiB1T12) returned ok
143706.906 2664  39       dt_close(39, dtiB1T1) returned ok
143706.906 2664           route resources (dtiB1T12) call
143706.906 2664  34       Route_VoiceResource_To_dti begin dxxxB3C4:36 to dtiB1T12:34 (linedev=34)
143706.906 2664           route resources (dtiB1T1) call
143706.906 2664   2       Route_VoiceResource_To_dti begin dxxxB1C1:3 to dtiB1T1:2 (linedev=2)
143706.921 2664           tsreset (nr_sc) completed for dtiB1T12 and dtiB1T1)
143706.921 2664  34 fn    ReleaseCall(sLineId=34, crn=020080D9, Param1=0)
143706.921 2664  34       gc_ReleaseCallEx crn=020080D9 (hli->crn=020080D9) in TelDriver_ReleaseCall 
143706.921 2664  34       gc_ReleaseCallEx ok
143706.921 2888  34       CtEventProcess (from store) idx=579, evtdev=34, crn=020080D9, evttype=2137, data=0C40D088, len=28 (store: evinque=0, maxever=1)
143706.921 2888  34 ev    GCEV_RELEASECALL crn=020080D9
143706.921 2888  34       CTelProxy::Event_CallState GCEV_RELEASECALL iLineCallState=0, hCall=33587417 m_pktTelProxyClient=006519D0
143706.921 2888  34 raise CallState GCEV_RELEASECALL

 

If you need more information then please just let me know.

 

Help would be greatly appreciated.

Share this post

Link to post

Guest miva   

Posted

This line:

 

143658.062 25 34 state Hanging up... [oVgmDbQuery_AdoNetCommon_Completed PathNotDefined]

 

Shows a DB error that we've seen in the log files lately since we've started looking for the dropped calls and may be related.

Share this post

Link to post

SupportTeam   

Posted

Is there a database query module used just before the [QRecord-BR-CS] module?

 

It seems that some database query has completed and the result arrived later then expected, and this was not handled well by the script event handler, so the call was ended.

 

Please post the vgEngine trace excerpt (.ZIPed) capturing the full call.

 

143658.062 25 34 oVgmDbQuery_AdoNetCommon_Completed SqlQueryType=NONQUERY, RowsCount=1

143658.062 25 34 HangupCall ('and any associated'=False), source=oVgmDbQuery_AdoNetCommon_Completed PathNotDefined, linestate=[CONNECTED]

143658.062 25 34 state Hanging up... [oVgmDbQuery_AdoNetCommon_Completed PathNotDefined]

Share this post

Link to post

Guest miva   

Posted

Thanks for the response.

 

Yes there is a database query followed by an evaluate expression then the [QRecord-BR-CS] module. The problem appears to be that we had a timeout in the database module, which waited for a few seconds and then effectively took a fail path, processing the call accordingly so that callers did not hear any long periods of silence. Obviously when the database or connection to the database experienced lag this was causing a problem.

 

As a temporary solution we've removed the timeout from the module. Is there a way to send a stop query or to better handle database responses which are delayed?

Share this post

Link to post

SupportTeam   

Posted

Please post the vgEngine trace excerpt (.ZIPed) capturing the full call on which the problem occurred. We can then see what happened during the call and what lead up to this error.

Share this post

Link to post

SupportTeam   

Posted

Please update system to this version of VoiceGuide v7.

This version better handles situations where the database response is delayed beyond that what is allowed for in the DB Query type module.

 

[old link removed]

Please post traces as before if you still encounter any script problems.

Share this post

Link to post

Guest miva   

Posted

We just tried to use the updated version provided but after installing the service would not start. We went into "Services" through the control panel and tried to start it that way but it simply said that the service started and then stopped almost immediately.

 

Installed over the top initially and then uninstalled VG to do a clean install, both times could not start the service.

 

When we re-installed the previous version the service started without a problem and is working again.

Share this post

Link to post

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
Go To Topic Listing General
×