Vg On D/4pci Doesn't Detect Busy Tone

[Guest Husam El.Din]

I have a very strange problem

 

I have a VG script running on a Windows XP machine having Dialogic D/4PCI card.

 

The problem is that I have a module called "Tansfer Call" that should perform a PBX announced transfer to an extension read from database. The transfer operation works fine if the called number is answerd or not answered. When the dialed extension is busy VG doesn't detect the busy state and it moves through the Success path which causes a Hang Up. When VG hangs up the caller is still on Hold and after a long while the script is restarted with the Welcome message being played.

 

Here's the Log for the part where the extension called by VG is busy:

 

 

 

 

 

154007.38 6 linedevstate 2048 0 0

154007.39 6 callstate OFFERING 66506 0 4

154007.41 6 rv clear

154007.41 6 Answer the call at 21/08/2005 03:40:07 م

154007.45 6 lineAnswer(66506) => 66130

154007.48 6 callinfo CALLEDID

154007.50 6 callinfo ORIGIN

154007.50 6 ring 0

154008.05 6 callstate CONNECTED 66506 1 0

154008.06 6 callstate CONNECTED 66506,1,0

154008.06 6 WorkingModeTAPI@Connected=

154008.08 6 WorkingModeScript@Connected=

154008.08 6 Inband detection not enabled

154008.09 6 StartLoadedVgs at 21/08/2005 03:40:08 م, v5.2.3063

154008.11 6 AddRVns [scriptsPath]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant\}

154008.11 6 AddRVns [scriptPath]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant}

154008.13 6 rv add [$RV_STARTTIME]{21/08/2005 03:40:08 م}

154008.14 6 rv add [$RV_DEVICEID]{6}

154008.14 6 rv add [$RV_CIDNAME]{}

154008.16 6 AddRVns [PathApp]{C:\Program Files\VoiceGuide\}

154008.18 6 rv add [$RV_CIDNUMBER]{}

154008.19 6 tapi Reply (LineEvReply) ok 66130 0

154008.20 6 callinfo MONITORMODES

154008.25 0 dial start any summary:|6:hc>0|7:idx=0|8:idx=0|9:idx=0|

154008.27 6 timer clear

154008.28 6 [Welcome] Playing

154008.28 6 [Welcome] Playing (welcomemusic.wav)

154008.30 6 play set playid=976625

154008.47 6 PlaySoundStart ok [C:\Program Files\VoiceGuide\Scripts\Auto Attendant\welcomemusic.wav]

154008.48 6 timer clear

154008.50 6 RunModule PLAY end

154008.52 6 wa(26108,97662500)

154008.55 6 callinfo MONITORMODES

154010.60 6 dtmf 9 (66506,57,2)

154010.61 6 ScriptEventCode 57 iLineState=1100

154010.61 6 LsPlayMsg 9

154010.72 6 PlaySoundStop err=0

154010.72 6 rv add [Welcome]{9}

154010.79 6 timer clear

154010.80 6 [GetExtension] Number Input

154010.82 6 [GetExtension] Playing (insert.wav)

154010.83 6 play set playid=979156

154010.96 6 PlaySoundStart ok [C:\Program Files\VoiceGuide\Scripts\Auto Attendant\insert.wav]

154010.97 6 timer clear

154010.99 6 wa(3700,97915600)

154011.00 6 callinfo MONITORMODES

154011.82 6 dtmf 4 (66506,52,2)

154011.83 6 ScriptEventCode 52 iLineState=1300

154011.85 6 LsGetNbrsPlayWelcMsg 4

154011.94 6 PlaySoundStop err=0

154011.96 6 [GetExtension] Number Input 4

154011.96 6 path {4} not found

154011.97 6 timer set 6 EV_TIMEOUT_ENTERDATA

154012.19 6 dtmf 1 (66506,49,2)

154012.21 6 ScriptEventCode 49 iLineState=1301

154012.22 6 LsGetNbrsRxDigits 1

154012.24 6 [GetExtension] Number Input 41

154012.25 6 path {41} not found

154012.27 6 timer set 6 EV_TIMEOUT_ENTERDATA

154012.36 6 dtmf 1 (66506,49,2)

154012.38 6 ScriptEventCode 49 iLineState=1301

154012.39 6 LsGetNbrsRxDigits 1

154012.41 6 [GetExtension] Number Input 411

154012.43 6 path {411} not found

154012.44 6 timer set 6 EV_TIMEOUT_ENTERDATA

154012.66 6 dtmf 3 (66506,51,2)

154012.66 6 ScriptEventCode 51 iLineState=1301

154012.68 6 LsGetNbrsRxDigits 3

154012.69 6 [GetExtension] Number Input 4113

154012.71 6 path {4113} not found

154012.72 6 timer set 6 EV_TIMEOUT_ENTERDATA

154012.74 6 timer clear

154012.75 6 rv add [GetExtension]{4113}

154012.77 6 path {4113} not found

154012.77 6 AddRVns [GetExtension_PathTaken]{success}

154012.79 6 timer clear

154012.80 6 [sqlGetRealExtension] DB Query

154012.82 6 db ODBC mode used

154012.89 6 rv replace start: [select VoiceMailNameWavFile,ExtensionId from voicemails where VoiceMailID = $RV[GetExtension]]

154012.91 6 rv ns [PathSysVoice]{C:\Program Files\VoiceGuide\system\voice\}[PathApp]{C:\Program Files\VoiceGuide\}[PathDataVm]{C:\Program Files\VoiceGuide\data\}[PathVgSys]{C:\Program Files\VoiceGuide\system\}[scriptsPath]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant\}[scriptPath]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant}[$RV_STARTTIME]{21/08/2005 03:40:08 م}[$RV_DEVICEID]{6}[$RV_CIDNAME]{}[PathApp]{C:\Program Files\VoiceGuide\}[$RV_CIDNUMBER]{}[Welcome]{9}[GetExtension]{4113}[GetExtension_PathTaken]{suc

ess}

154012.93 6 rv replace end: [select VoiceMailNameWavFile,ExtensionId from voicemails where VoiceMailID = 4113]

154012.94 6 db About to execute a Retrieve type operation [select VoiceMailNameWavFile,ExtensionId from voicemails where VoiceMailID = 4113]

154012.96 6 db [sqlGetRealExtension] row count=1

154012.97 6 rv add [sqlGetRealExtension_RowCount]{1}

154012.99 6 db get RecordsetGetRowsMax

154013.00 6 db get 999 records. (row count=1)

154013.02 6 db update RVs start

154013.04 6 db update RVs cols=2 rows=1

154013.05 6 db test vRetData(0, 0)=C:\Program Files\VoiceGuide\Scripts\Auto Attendant\1101091859_6_.wav

154013.07 6 db test CStr(vRetData(0, 0))=C:\Program Files\VoiceGuide\Scripts\Auto Attendant\1101091859_6_.wav

154013.08 6 db about to close dbDbqDatabase

154013.10 6 db going down path [True]

154013.11 6 timer clear

154013.13 6 timer set 0.4 EV_TIMEOUT_READYTOBEGINTRANSFER

154013.55 6 timer fired EV_TIMEOUT_READYTOBEGINTRANSFER

154013.57 6 ScriptEventCode 9012 iLineState=1900

154013.58 6 LsXferStart EV_TIMEOUT_READYTOBEGINTRANSFER

154013.58 6 timer set 10 EV_TIMEOUT_ANNOUNCED_TRANSFER_ATTEMPT_TOOK_TOO_LONG

154013.60 6 rv replace start: [$RV[sqlGetRealExtension_2_1]]

154013.61 6 rv ns [PathSysVoice]{C:\Program Files\VoiceGuide\system\voice\}[PathApp]{C:\Program Files\VoiceGuide\}[PathDataVm]{C:\Program Files\VoiceGuide\data\}[PathVgSys]{C:\Program Files\VoiceGuide\system\}[scriptsPath]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant\}[scriptPath]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant}[$RV_STARTTIME]{21/08/2005 03:40:08 م}[$RV_DEVICEID]{6}[$RV_CIDNAME]{}[PathApp]{C:\Program Files\VoiceGuide\}[$RV_CIDNUMBER]{}[Welcome]{9}[GetExtension]{4113}[GetExtension_PathTaken]{suc

ess}[sqlGetRealExtension_RowCount]{1}[sqlGetRealExtension_1_1]{C:\Program Files\VoiceGuide\Scripts\Auto Attendant\1101091859_6_.wav}[sqlGetRealExtension_2_1]{411}

154013.64 6 rv replace end: [411]

154013.66 6 [Transfer Call] Announced Transfer to 411 (Generate)

154013.68 6 tapic lineGenerateDigits(66506,!,100) => 0

154014.38 6 generate LINEGENERATETERM_DONE

154014.39 6 timer set 1 EV_TAPI_GENERATE

154015.45 6 timer fired EV_TAPI_GENERATE

154015.45 6 ScriptEventCode 9602 iLineState=1900

154015.46 6 LsXferStart EV_TAPI_GENERATE

154015.48 6 timer set 1 EV_HOOKFLASHFINISHED

154016.59 6 timer fired EV_HOOKFLASHFINISHED

154016.59 6 ScriptEventCode 9200 iLineState=1905

154016.60 6 LsXferPlayVts EV_HOOKFLASHFINISHED

154016.63 6 tapic lineGenerateDigits(66506,411,100) => 0

154017.20 6 generate LINEGENERATETERM_DONE

154017.21 6 timer set 1 EV_TAPI_GENERATE

154018.21 6 timer fired EV_TAPI_GENERATE

154018.21 6 ScriptEventCode 9602 iLineState=1905

154018.23 6 LsXferPlayVts EV_TAPI_GENERATE

154018.24 6 fn PlaySoundStartNumbers [TsfrCallFrom.wav],[TsfrAskAccept.wav],[],Digits

154018.27 6 sVbsFunctionToUse=Digits

154018.46 6 Started SayNumber VBScript OK. (C:\Program Files\VoiceGuide\data\vbs_6_SayNumber.vbs)

154018.63 6 cl Play_Start C:\Program Files\VoiceGuide\system\voice\TsfrCallFrom.wav,,C:\Program Files\VoiceGuide\system\voice\TsfrAskAccept.wav

154018.66 6 play set playid=986984

154018.85 6 PlaySoundStart ok [C:\Program Files\VoiceGuide\system\voice\TsfrCallFrom.wav,C:\Program Files\VoiceGuide\system\voice\TsfrAskAccept.wav]

154018.87 6 timer clear

154018.90 6 wa(1845,98698400)

154018.91 6 callinfo MONITORMODES

154019.13 6 callstate DISCONNECTED 66506 0 0

154019.13 6 ScriptEventCode 9250 iLineState=1906

154019.15 6 LsXferPlayAnn EV_REMOTEPARTY_DISCONNECT

154019.16 6 timer set 1 EV_PLAY_FINISHED

154019.26 6 PlaySoundStop err=0

154020.32 6 timer fired EV_PLAY_FINISHED

154020.34 6 ScriptEventCode 8001 iLineState=1906

154020.34 6 LsXferPlayAnn EV_PLAY_FINISHED

154020.35 6 tapic lineGenerateDigits(66506,!,100) => LINEERR_INVALCALLSTATE [8000001C]

154020.37 6 rv add [Hangup Time]{21/08/2005 03:40:20 م}

154020.38 6 Hanging up call... [lineGenerateDigits ret=-2147483620]

154020.41 6 RecSoundStop ok

154020.45 6 PlaySoundStop err=0

154020.46 6 timer set 2 EV_TIMEOUT_WAITFORIDLEAFTERLINEDROP

154020.52 6 fnHangupCall end

154020.57 6 linedevstate 2048 0 0

154020.59 6 callstate IDLE 66506 0 0

154020.60 6 WorkingMode@Idle=

154020.62 6 timer clear

154020.65 6 timer set 1 EV_TIMEOUT_TIMETOREINITLINE

154020.66 6 tapi Reply (LineEvReply) ok 65635 0

154021.66 6 timer fired EV_TIMEOUT_TIMETOREINITLINE

154021.68 6 ScriptEventCode 9008 iLineState=900

154021.70 6 LsAwaitingCalls EV_TIMEOUT_TIMETOREINITLINE

154021.70 6 ReinitTelephony due to IDLE

154021.73 6 tapic lineDeallocateCall(MainCall:66506) 0

154022.04 6 lineOpen(6)=>

154022.06 6 Waiting for a call...

154022.07 6 LineHandle=65788

154022.09 6 timer set 3 EV_TIMEOUT_ATERIDLE_ALLOWOUT

154022.59 0 dial start any summary:|6:rdy=0|7:idx=0|8:idx=0|9:idx=0|

154025.39 6 timer fired EV_TIMEOUT_ATERIDLE_AL0LOWOUT

154025.40 6 ScriptEventCode 9013 iLineState=900

154025.65 0 dial start any summary:|6:idx=0|7:idx=0|8:idx=0|9:idx=0|

[SupportTeam]

after a long while the script is restarted with the Welcome message being played.

The trace provided did not show this happening.

 

Please change to using VG for Dialogic (see our Downloads page).

The call transfers are better handled under VG for Dialogic.