Conference Issue: Call connects but dialled party cant hear caller

[Guest miva]

Using VG7 on an E1 Dialogic Card.

Using Transfer Call module to Dial out and conference. VG answers and dials out successfully. When the Dialled party answers I can hear them but they can not hear me.

See extract from log below for more information. Tried to attach but couldn't find the button. )

 

Once we have the conference working correctly, we would like to add a recording function to this as well.

 

174929.468 4 load start [C:\Program Files\VoiceGuide\Scripts\MCR\2lineRec.vgs]

174929.468 4 LoadAnyUpdatedScripts ivrdev idx 1 VgsIdx= (1)

174929.468 4 LoadAnyUpdatedScripts ivrdev idx 11 VgsIdx= (1)

174929.468 4 LoadAnyUpdatedScripts ivrdev idx 12 VgsIdx= (1)

174929.468 4 loaded updated script, id=1 : C:\Program Files\VoiceGuide\Scripts\MCR\2lineRec.vgs

174929.468 4 Erasing Script (new loaded) Id 3

174938.140 9 2 ev Dialogic 2084,GCEV_OFFERED,2084,0,0,,,

174938.140 9 2 ScriptEventCode GCEV_OFFERED, code=2084, state=900

174938.140 9 2 LsAwaitingCalls EV_UNKNOWN_2084

174938.140 9 2 ev CallState hDevice=2, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_OFFERING, 2,0,,,]

174938.140 9 2 callstate: OFFERING 2,2,LINE_CALLSTATE-LINECALLSTATE_OFFERING,0,0

174938.140 9 2 script interpretor: vgEngine v7.0.2795.32865

174938.140 9 2 rings=0, min rings before answer=0 (iCallerIdHasArrived=0)

174938.140 9 2 ev lev_CallerID [,0299290442,84045900]

174938.140 9 2 cid LastCidMessage values [,0299290442,84045900]

174938.140 9 2 cid iCallerIdHasArrived=1

174938.140 9 2 rings=0, min rings before answer=0 (iCallerIdHasArrived=1)

174938.140 9 2 should answer as sLineType=[dlgc digital] and CallerID has arrived

174938.140 9 2 rv clear all

174938.140 9 2 LineState ResetAtStartOfNewCall.

174938.140 9 2 answer the call

174938.140 9 2 answering the call

174938.140 9 2 timer clear (force=False)

174938.218 9 2 ev Dialogic 2050,GCEV_ANSWERED,2050,0,0,,,

174938.218 9 2 ScriptEventCode GCEV_ANSWERED, code=2050, state=6001

174938.218 9 2 ev CallState hDevice=2, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_CONNECTED, 256,0,,,]

174938.218 9 2 callstate: CONNECTED 2,2,LINE_CALLSTATE-LINECALLSTATE_CONNECTED,0,0

174938.218 9 2 strWorkingModeScript=

174938.218 9 2 Inband detection not enabled

174938.218 9 2 StartLoadedVgs at 11/09/2007 5:49:38 PM 7.0.2795.32865

174938.218 9 2 StartLoadedVgs LineState.iVgsIdx=1

174938.218 9 2 rvns add [scriptPath]{C:\Program Files\VoiceGuide\Scripts\MCR\}

174938.218 9 2 rvns add [scriptsPath]{C:\Program Files\VoiceGuide\Scripts\MCR\}

174938.218 9 2 set sScriptToRunOnHangup=[] in StartLoadedVgs

174938.218 9 2 rv add [$RV_STARTTIME]{11/09/2007 5:49:38 PM}

174938.218 9 2 rv add [$RV_DEVICEID]{2}

174938.234 9 2 rv add [DlgcVoice]{dxxxB1C1}

174938.234 9 2 rv add [DlgcNetwork]{dtiB1T1}

174938.234 9 2 rv add [$RV_CIDNAME]{0299290442}

174938.234 9 2 rv add [$RV_DNIS]{84045900}

174938.234 9 2 rv add [DNIS]{84045900}

174938.234 9 2 rvns add [PathApp]{C:\Program Files\VoiceGuide\}

174938.234 9 2 rvns add [scriptsPath]{C:\Program Files\VoiceGuide\Scripts\MCR\}

174938.234 9 2 rv add [$RV_CIDNUMBER]{}

174938.234 9 2 RunModule vgm=44

174938.234 9 2 timer clear (force=False)

174938.234 9 2 fn RunModule start [Transfer Call,[Transfer Call 1],44]

174938.234 9 2 timer set 2 EV_TIMEOUT_READYTOBEGINTRANSFER

174940.406 4 2 timer fired EV_TIMEOUT_READYTOBEGINTRANSFER

174940.406 4 2 ScriptEventCode EV_TIMEOUT_READYTOBEGINTRANSFER, code=9012, state=1901

174940.406 4 2 LsXfer_1_Start :

 

9012(EV_TIMEOUT_READYTOBEGINTRANSFER),EV_TIMEOUT_READYTOBEGINTRANSFER,0,0,0,,,

174940.406 4 2 path {EV_TIMEOUT_READYTOBEGINTRANSFER} not found

174940.406 4 2 timeout on transfer attempt set by VG.INI [PBX] AnnouncedTransfersMaxWaitTime (30 sec)

174940.406 4 2 timer set 30 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

174940.406 4 2 state [Transfer Call 1] Blind Dial and Connect to 0412611619

174940.406 4 2 calling FindFreeLine

174940.406 4 0 Search for free lines in list [] in LineID range [0-25] src=XferDialAndConf

174940.406 4 2 dial busy: active call

174940.406 4 4 dial reserving: no list specified

174940.406 4 2 dial found free dev=2 (LineId=4)

174940.406 4 2 dial sCidSentThisCall= (pre RV replace)

174940.406 4 2 ERROR 7.0.2795.32865 RvProcessAndReplace : Object reference not set to an instance of an object.

at ..(Int32 iLineId, String& strIn)

174940.406 4 2 dial sCidSentThisCall= (post RV replace)

174940.406 4 2 play on-hold sound file

174940.406 4 2 PrepareAndPlayWavAndTTS sPlayFile=C:\Program Files\VoiceGuide\Scripts\MIVA

 

Demo\guesssong\bruce.wav

174940.406 4 2 state [Transfer Call 1] Playing wav(C:\Program Files\VoiceGuide\Scripts\MIVA

 

Demo\guesssong\bruce.wav)

174940.406 4 2 timer clear (force=False)

174941.343 4 2 play start ok, lPlayId=722062

174941.343 4 4 state dialing 0412611619 (for conference with dtiB1T1)

174941.343 4 2 setting CONNECT_IMMEDIATELY as iXferType = XT_DC_BLIND

174941.359 4 4 lineMakeCall(0412611619,CONNECT_IMMEDIATELY) =>

174941.359 4 2 timer set 3600 EV_TIMEOUT_HANGUP

174941.359 4 4 timer set 3600 EV_TIMEOUT_HANGUP

174941.359 4 2 outbound leg is dti device. Connect immediately.

174941.359 4 2 conf TwoCalls_Bridge 2<=>4 (dtiB1T1<=>dtiB1T2)

174941.406 4 2 play PlaySoundStop ok

174941.406 4 4 play PlaySoundStop ok

174941.406 4 2 rvns add [TsRoutedTo]{4}

174941.406 4 4 rvns add [TsRoutedTo]{2}

174941.406 4 4 rvns add [Conf_DevName_1]{dtiB1T1}

174941.406 4 4 rvns add [Conf_LineId_1]{2}

174941.406 4 4 rvns add [Conf_LineNbr_1]{1}

174941.406 4 4 rv add [Conf_DevName_2]{dtiB1T2}

174941.406 4 4 rv add [Conf_LineId_2]{4}

174941.406 4 4 rv add [Conf_LineNbr_2]{2}

174941.406 4 2 rvns add [Conf_DevName_1]{dtiB1T1}

174941.406 4 2 rvns add [Conf_LineId_1]{2}

174941.406 4 2 rvns add [Conf_LineNbr_1]{1}

174941.406 4 2 rv add [Conf_DevName_2]{dtiB1T2}

174941.406 4 2 rv add [Conf_LineId_2]{4}

174941.406 4 2 rv add [Conf_LineNbr_2]{2}

174941.406 4 2 TsRoute dtiB1T1<=>dtiB1T2 call

174941.421 9 2 ev PlayEnd 2 722062

174941.421 9 2 play end id=722062, (current ID)

174941.421 9 2 ScriptEventCode EV_PLAY_FINISHED, code=8001, state=1910

174941.421 9 2 LsXfer_8_WaitEndCall_InLeg : 8001(EV_PLAY_FINISHED),EV_PLAY_FINISHED,0,0,0,,, (iModuleIdx=44)

174941.421 9 2 path {ev_play_finished} not found

174941.421 9 2 ev Dialogic 129,TDX_PLAY,722062,0,0,,,

174941.421 9 2 ScriptEventCode TDX_PLAY, code=129, state=1910

174941.421 9 2 LsXfer_8_WaitEndCall_InLeg : 129(EV_UNKNOWN_129),TDX_PLAY,722062,0,0,,, (iModuleIdx=44)

174941.421 9 2 path {tdx_play} not found

174941.421 4 2 TsRoute dtiB1T1<=>dtiB1T2 SC_FULLDUP:

174941.421 4 2 state [Transfer Call 1] bridged with dtiB1T2 (incoming leg)

174941.421 4 4 state [Transfer Call 1] bridged with dtiB1T1 (outgoing leg)

174948.015 9 4 ev Dialogic 2081,GCEV_ALERTING,2081,0,0,,,

174948.015 9 4 state Ringing...

174948.015 9 4 ScriptEventCode GCEV_ALERTING, code=2081, state=1911

174948.015 9 4 LsXfer_8_WaitEndCall_OutLeg : 2081(), [GCEV_ALERTING], 2081,0,0,,,

174948.015 9 2 LsXfer_8_WaitEndCall_InLeg : 2081(EV_UNKNOWN_2081),gcev_alerting,2081,0,0,,, (iModuleIdx=44)

174948.015 9 2 path {gcev_alerting} not found

174955.359 9 4 ev Dialogic 2082,GCEV_CONNECTED,2082,0,0,,,

174955.359 9 4 ScriptEventCode GCEV_CONNECTED, code=2082, state=1911

174955.359 9 4 LsXfer_8_WaitEndCall_OutLeg : 2082(), [GCEV_CONNECTED], 2082,0,0,,,

174955.359 9 2 LsXfer_8_WaitEndCall_InLeg : 2082(EV_UNKNOWN_2082),gcev_connected,2082,0,0,,, (iModuleIdx=44)

174955.359 9 2 path {gcev_connected} not found

174955.359 9 4 ev CallState hDevice=4, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_CONNECTED, 256,0,,,]

174955.359 9 4 callstate: CONNECTED 4,2,LINE_CALLSTATE-LINECALLSTATE_CONNECTED,0,0

174955.359 9 2 ScriptEventCode CONNECTED, code=10256, state=1910

174955.359 9 2 LsXfer_8_WaitEndCall_InLeg : 10256(EV_UNKNOWN_10256),CONNECTED,256,0,0,,, (iModuleIdx=44)

174955.359 9 2 path {connected} not found

174955.359 9 4 strWorkingModeScript=

174955.359 9 4 connected event no action as: outgoing leg of call now awaits end of call

 

(state=waitendcall)

174955.359 9 4 set LineState().hCall = 4 in LineEvCallState_Connected 3

175002.906 9 2 ev Dialogic 2086,GCEV_DISCONNECTED,2086,0,0,GCRV_NORMAL,normal completion ,Normal clearing

175002.906 9 2 ScriptEventCode GCEV_DISCONNECTED, code=2086, state=1910

175002.906 9 2 LsXfer_8_WaitEndCall_InLeg :

 

2086(EV_UNKNOWN_2086),GCEV_DISCONNECTED,2086,0,0,GCRV_NORMAL,normal completion ,Normal clearing (iModuleIdx=44)

175002.906 9 2 TsReset call in LsXfer_8_WaitEndCall_InLeg line 120

175002.937 9 4 rv add [Hangup Time]{11/09/2007 5:50:02 PM}

175002.937 9 4 state Hanging up call... [LsXfer_8_WaitEndCall_InLeg line 190]

175002.937 9 4 HangupCall_Common hCall=4

175002.937 9 4 play PlaySoundStop ok

175002.937 9 4 timer set 1 EV_TIMEOUT_DOLINEDROP

175002.937 9 4 state Waiting for a call...

175002.937 9 4 fnHangupCall end

175002.937 9 2 path {gcev_disconnected} not found

175002.937 9 2 rv add [Hangup Time]{11/09/2007 5:50:02 PM}

175002.937 9 2 state Hanging up call... [LsXfer_8_WaitEndCall_InLeg No_Path_Matched]

175002.937 9 2 rvns add [TsRoutedTo]{}

175002.937 9 4 rvns add [TsRoutedTo]{}

175002.937 9 2 TsReset dtiB1T1</>dtiB1T2 MATCH_ call

175002.968 9 2 TsReset dtiB1T1</>dtiB1T2 MATCH_ => []

175002.968 9 4 rv add [Hangup Time]{11/09/2007 5:50:02 PM}

175002.968 9 4 state Hanging up call... [2nd leg (Hangup Call)]

175002.968 9 4 HangupCall_Common hCall=4

175002.968 9 4 play PlaySoundStop ok

175002.968 9 4 timer set 1 EV_TIMEOUT_DOLINEDROP

175002.968 9 4 state Waiting for a call...

175002.968 9 4 fnHangupCall end

175002.968 9 2 HangupCall_Common hCall=2

175002.968 9 2 play PlaySoundStop ok

175002.968 9 2 timer set 1 EV_TIMEOUT_DOLINEDROP

175002.968 9 2 fnHangupCall end

175002.968 9 2 ev CallState hDevice=2, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_DISCONNECTED, 16384,0,,,]

175002.968 9 2 callstate: DISCONNECTED 2,2,LINE_CALLSTATE-LINECALLSTATE_DISCONNECTED,0,0

175002.968 9 2 ScriptEventCode EV_REMOTEPARTY_DISCONNECT, code=9250, state=900

175002.968 9 2 LsAwaitingCalls EV_REMOTEPARTY_DISCONNECT

175002.968 9 2 linestate=DISCONNECTED. HangupCall ignored.

175002.968 9 2 atidle reinit : start

175002.968 9 2 atidle reinit iConferenceOtherLegLid=-1

175002.968 9 2 atidle reinit : reset all LineState variables

175002.968 9 2 timer set 2 EV_TIMEOUT_AFTERIDLE_ALLOWOUT

175002.968 9 2 timer clear ignored - waiting for line re-init to occur first (EV_TIMEOUT_DOLINEDROP)

175002.968 9 2 state Waiting for a call...

175002.968 9 2 ev CallState hDevice=2, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_IDLE, 1,0,,,]

175002.968 9 2 callstate: IDLE 2,2,LINE_CALLSTATE-LINECALLSTATE_IDLE,0,0

175002.968 9 2 gEventSourceInstanceObject.fireLineEvent(IDLE) call

175002.968 9 2 timer clear (force=False)

175002.968 9 2 timer clear ignored - waiting for line re-init to occur first (EV_TIMEOUT_DOLINEDROP)

175002.968 9 2 rec RecSoundStop ok

175002.968 9 2 play PlaySoundStop ok

175002.968 9 2 rv add [CallEndTime]{11/09/2007 5:50:02 PM}

175002.968 9 2 ScriptToRunOnHangup not used. set iVgsIdx=0

175002.968 9 2 timer set 1 EV_TIMEOUT_TIMETOREINITLINE

175002.968 9 2 ev Dialogic 2053,GCEV_DROPCALL,2053,0,0,,,

175002.968 9 2 ScriptEventCode GCEV_DROPCALL, code=2053, state=900

175002.968 9 2 LsAwaitingCalls EV_UNKNOWN_2053

175002.984 9 2 ev Dialogic 2137,GCEV_RELEASECALL,2137,0,0,,,

175002.984 9 2 ScriptEventCode GCEV_RELEASECALL, code=2137, state=900

175002.984 9 2 LsAwaitingCalls EV_UNKNOWN_2137

175002.984 9 2 ev CallState hDevice=2, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_IDLE, 1,0,,,]

175002.984 9 2 callstate: IDLE 2,2,LINE_CALLSTATE-LINECALLSTATE_IDLE,0,0

175002.984 9 2 gEventSourceInstanceObject.fireLineEvent(IDLE) call

175002.984 9 2 timer clear (force=False)

175002.984 9 2 timer clear ignored - waiting for line re-init to occur first (EV_TIMEOUT_TIMETOREINITLINE)

175002.984 9 2 LINECALLSTATE_IDLE: LineState[iLineId].iVgsIdx==0, reinit telephony.

175002.984 9 2 timer set 1 EV_TIMEOUT_TIMETOREINITLINE

175004.046 15 2 timer fired EV_TIMEOUT_TIMETOREINITLINE

175004.046 15 2 ScriptEventCode EV_TIMEOUT_TIMETOREINITLINE, code=9008, state=900

175004.046 15 2 atidle reinit : start

175004.046 15 2 atidle reinit iConferenceOtherLegLid=-1

175004.046 15 2 atidle reinit : reset all LineState variables

175004.046 15 2 timer set 2 EV_TIMEOUT_AFTERIDLE_ALLOWOUT

175004.046 15 2 state Waiting for a call...

175004.046 15 4 timer fired EV_TIMEOUT_DOLINEDROP

175004.046 15 4 ScriptEventCode EV_TIMEOUT_DOLINEDROP, code=9102, state=900

175004.046 15 4 timer set 2 EV_TIMEOUT_WAITFORIDLEAFTERLINEDROP

175004.109 9 4 ev Dialogic 2053,GCEV_DROPCALL,2053,0,0,,,

175004.109 9 4 ScriptEventCode GCEV_DROPCALL, code=2053, state=900

175004.109 9 4 LsAwaitingCalls EV_UNKNOWN_2053

175004.125 9 4 ev Dialogic 2137,GCEV_RELEASECALL,2137,0,0,,,

175004.125 9 4 ScriptEventCode GCEV_RELEASECALL, code=2137, state=900

175004.125 9 4 LsAwaitingCalls EV_UNKNOWN_2137

175004.125 9 4 ev CallState hDevice=4, iEvent=2, sEvent=LINE_CALLSTATE-LINECALLSTATE_IDLE, 1,0,,,]

175004.125 9 4 callstate: IDLE 4,2,LINE_CALLSTATE-LINECALLSTATE_IDLE,0,0

175004.125 9 4 gEventSourceInstanceObject.fireLineEvent(IDLE) call

175004.125 9 4 timer clear (force=False)

175004.125 9 4 timer clear ignored - waiting for line re-init to occur first

 

(EV_TIMEOUT_WAITFORIDLEAFTERLINEDROP)

175004.125 9 4 LINECALLSTATE_IDLE: LineState[iLineId].iVgsIdx==0, reinit telephony.

175004.125 9 4 timer set 1 EV_TIMEOUT_TIMETOREINITLINE

175005.140 15 4 timer fired EV_TIMEOUT_TIMETOREINITLINE

175005.140 15 4 ScriptEventCode EV_TIMEOUT_TIMETOREINITLINE, code=9008, state=900

175005.140 15 4 atidle reinit : start

175005.140 15 4 atidle reinit iConferenceOtherLegLid=-1

175005.140 15 4 atidle reinit : reset all LineState variables

175005.140 15 4 timer set 2 EV_TIMEOUT_AFTERIDLE_ALLOWOUT

175005.140 15 4 state Waiting for a call...

175006.234 15 2 timer fired EV_TIMEOUT_AFTERIDLE_ALLOWOUT

175006.234 15 2 ScriptEventCode EV_TIMEOUT_AFTERIDLE_ALLOWOUT, code=9013, state=900

175007.328 4 4 timer fired EV_TIMEOUT_AFTERIDLE_ALLOWOUT

175007.328 4 4 ScriptEventCode EV_TIMEOUT_AFTERIDLE_ALLOWOUT, code=9013, state=900

 

[SupportTeam]

Which E1 card is used on this system?

 

Which System Release drivers are used?

 

To diagnose this problem could we please get a 'ktTel' level trace from VoiceGuide which captures system startup and the test call. This is the trace which shows the commands and responses from the Dialogic card.

 

The file attachment box should be visible below the text edit window.

 

See screenshot below:

[Guest miva]

E1 card is D300/JCT

 

Dialogic System Release drivers are 6.0 PCI

 

I have attached the ktTel and the vgEngine from another pc that shows the attachment screen fine.

ktTel.txt

vgEngine.txt

[SupportTeam]

Could you please do the following:

1. uninstall VoiceGuide. (backup your config and scripts) then delete entire VG directory.
2. uninstall SR6.0
3. download latest SR6.0
4. install latest SR6.0
5. download latest VoiceGuide
6. install the just downloaded VoiceGuide.
7. restore the config and scripts & restart VoiceGuide to let us read in new the new config.xml file.

8. dial in and make a test "Dial and Conference" transfer (Blind).

Please .ZIP and post the traces if you are still encountering transfer problems.

[Guest miva]

Thanks for the response.

 

Following those steps fixed the issue regarding the connecting of callers and allowing them to talk.

 

The help file states that when doing a Dial and Conference Blind that VoiceGuide will take the success path if it is defined. At present, the DialandConf module is not following the success path on connection of the call. This may be that it does not see it as being successful. Based on this assumption, I added a Fail path to a Hang Up module but it did not follow this path either.

 

I have added the log files so that you may further interrogate. The log files were created, zipped and attached to this forum before I tried the fail path.

 

Attached is 0912_ktTel.txt and 0912_1033_vgEngine.txt as 0912_1033_vgEngine.zip

 

Ideally, what we would like to do is connect the calls and then record the conversation of both parties. This is the end result we would like to achieve.

0912_1033_vgEngine.zip

[SupportTeam]

The version just uploaded fixes the "success path not taken" issue. Please download and update to this latest version.

 

The attached script shows the basic 'transfer and record call' approach as it would be done on a Dial and Conference transfer. The 2 line recording is enabled on the Evaluation and Enterprise versions of VoiceGuide v7.

 

TransferAndRecordCall.vgs