Vg Hangs Up During Voice Mail Recording

[Guest Tomcatt]

I have set up an evaluate expression module to user caller ID to send callers to specific modules. When a caller is sent to voice mail and is asked to press "1" the voice mail welcome prompt is heard. As the caller is recording a message VG hangs up. 9 seconds every time. I have VG successfully installed on another computer and have never had this problem. Please help! The trace log is below:

 

 

001908.93 0 tapi callstate OFFERING 4343296 0 4

001908.93 0 ring 1

001909.86 0 ev Lev_CallerID [6127890299,CHRISTENSEN T J,]

001909.97 dial start any summary:|0:hc>0|

001914.80 0 ring 2

001914.80 0 rv clear

001914.80 0 Terminating process (new call).

001914.80 0 answer the call at 12/8/2006 12:19:14 AM

001914.80 0 lineAnswer(4343296) => 7

001914.80 0 tapi Reply (LineEvReply) ok 7 0 LineCallState=OFFERING

001914.80 0 tapi callstate ACCEPTED 4343296 0 0

001916.07 0 tapi callstate CONNECTED 4343296 0 0

001916.07 0 callstate CONNECTED 4343296,0,0

001916.07 0 WorkingModeTAPI@Connected=

001916.07 0 WorkingModeScript@Connected=

001916.07 0 Inband detection not enabled

001916.07 0 startLoadedVgs at 12/8/2006 12:19:16 AM, script interpretor VGMULTI v5.2.5049 0

001916.07 0 rv ns add [scriptsPath]{C:\Data\1Adams\}

001916.07 0 rv ns add [scriptPath]{C:\Data\1Adams}

001916.07 0 rv lg add [$RV_STARTTIME]{12/8/2006 12:19:16 AM}

001916.07 0 rv lg add [$RV_DEVICEID]{0}

001916.07 0 rv lg add [$RV_CIDNAME]{CHRISTENSEN T J}

001916.07 0 rv ns add [PathApp]{C:\PROGRAM FILES\VOICEGUIDE\}

001916.07 0 rv lg add [$RV_CIDNUMBER]{6127890299}

001916.12 0 rv lg add [$RV_DNIS]{}

001916.12 0 rv lg add [DNIS]{}

001916.12 0 timer clear

001916.12 0 state [Evaluate 4] Evaluate [$RV_CIDNUMBER]

001916.12 0 rv replace start: [$RV_CIDNUMBER]

001916.12 0 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:\Data\1Adams\}[scriptPath]{C:\Data\1Adams}[$RV_STARTTIME]{12/8/2006 12:19:16 AM}[$RV_DEVICEID]{0}[$RV_CIDNAME]{CHRISTENSEN T J}[PathApp]{C:\PROGRAM FILES\VOICEGUIDE\}[$RV_CIDNUMBER]{6127890299}[$RV_DNIS]{}[DNIS]{}

001916.12 0 rv replace end: [6127890299]

001916.12 0 .Eval(6127890299)

001916.12 0 rv ns add [Evaluate 4_Input]{6127890299}

001916.18 0 rv ns add [Evaluate 4]{6127890299}

001916.18 0 Eval Expr result:[6127890299]

001916.18 0 timer clear

001916.18 0 state [Play 2] Playing

001916.18 0 state [Play 2] Playing (C:\Program Files\VoiceGuide\system\voice\prs1torecmssg.wav)

001916.18 0 play set playid=932139

001916.23 0 PlaySoundStart ok [C:\Program Files\VoiceGuide\system\voice\prs1torecmssg.wav]

001916.23 0 timer clear

001916.23 0 RunModule PLAY end

001918.32 0 play end current play (playid=932139)

001918.32 0 ScriptEventCode 8001 iLineState=1100

001918.37 0 LsPlayMsg EV_PLAY_FINISHED

001918.37 0 eng set timer EV_TIMEOUT_REPLAYMSG time=2

001918.37 0 timer set 2 EV_TIMEOUT_REPLAYMSG

001918.76 0 dtmf 1 (4343296,49,2)

001918.76 0 ScriptEventCode 49 iLineState=1101

001918.76 0 LsPlayMsgFinished 1

001918.76 0 FindVoicemailSysEntryPoint(Voicemail Box 0001,

on {time...,,)

001918.76 0 rv lg add [Play 2]{1}

001918.76 0 timer clear

001918.76 0 RunVmModule called strVmObjectType=[Voicemail Box], strVmId=[0001]

001918.81 0 timer clear

001918.81 0 voicemail used: vgs

001918.81 2 tr NewVgsVgm_Goto C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLm.vgs,VmLmStart,[PathSysVoice]{C:\PROGRAM FILES\VOICEGUIDE\system\voice\}[PathApp]{C:\PROGRAM FILES\VOICEGUIDE\}[PathDataVm]{C:\PROGRAM FILES\VOICEGUIDE\data\}[PathVgSys]{C:\PROGRAM FILES\VOICEGUIDE\system\}[VmbId]{0001},,,0

001918.81 0 rv lg add [scriptEnd_Time]{12/8/2006 12:19:18 AM}

001918.81 0 rv lg add [scriptEnd_Goto_Script]{C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLm.vgs}

001918.81 0 rv lg add [scriptEnd_Goto_Module]{VmLmStart}

001918.81 0 WriteToLogFiles_CurrScriptOnly start

001918.81 WriteToLogFiles_DoWrite start (C:\Data\1Adams\dammit)

001918.81 0 rv lg add [scriptStart_Time]{12/8/2006 12:19:18 AM}

001918.87 0 rv lg add [scriptStart_CalledFrom_Script]{C:\Data\1Adams\dammit.vgs}

001918.87 0 rv lg add [scriptStart_CalledFrom_Module]{Play 2}

001918.87 0 LoadedVgs_Find C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLm.vgs at idx=2

001918.87 0 rv ns add [scriptsPath]{C:\PROGRAM FILES\VOICEGUIDE\system\vm\}

001918.87 0 rv lg add [PathSysVoice]{C:\PROGRAM FILES\VOICEGUIDE\system\voice\}

001918.87 0 rv lg add [PathApp]{C:\PROGRAM FILES\VOICEGUIDE\}

001918.87 0 rv lg add [PathDataVm]{C:\PROGRAM FILES\VOICEGUIDE\data\}

001918.87 0 rv lg add [PathVgSys]{C:\PROGRAM FILES\VOICEGUIDE\system\}

001918.92 0 rv lg add [VmbId]{0001}

001918.92 0 timer clear

001918.92 0 state [VmLmStart] Running vb script:[VmLmHangup.vgs]

001934.47 0 LoadedVgs_Find C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLmHangup.vgs at idx=3

001934.47 0 tapi Reply (LineEvReply) ok 8 0 LineCallState=IDLE

001934.47 0 timer clear

001934.52 0 state [VmLmHangup_ForwardLastMsg] Running VB Script...

001934.52 0 rv replace start (strlen>500)

001934.52 0 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:\Data\1Adams\}[scriptPath]{C:\Data\1Adams}[$RV_STARTTIME]{12/8/2006 12:19:16 AM}[$RV_DEVICEID]{0}[$RV_CIDNAME]{CHRISTENSEN T J}[PathApp]{C:\PROGRAM FILES\VOICEGUIDE\}[$RV_CIDNUMBER]{6127890299}[$RV_DNIS]{}[DNIS]{}[Evaluate 4_Input]{6127890299}[Evaluate 4]{6127890299}[Play 2]{1}[scriptEnd_Time]{12/8/2006 12:19:18 AM}[scriptEnd_Goto_Script]{C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLm.vgs}[scriptEnd_Goto_Module]{VmLmStart}[scriptStart_Time]{12/8/2006 12:19:18 AM}[scriptStart_CalledFrom_Script]{C:\Data\1Adams\dammit.vgs}[scriptStart_CalledFrom_Module]{Play 2}[scriptsPath]{C:\PROGRAM FILES\VOICEGUIDE\system\vm\}[PathSysVoice]{C:\PROGRAM FILES\VOICEGUIDE\system\voice\}[PathApp]{C:\PROGRAM FILES\VOICEGUIDE\}[PathDataVm]{C:\PROGRAM FILES\VOICEGUIDE\data\}[PathVgSys]{C:\PROGRAM FILES\VOICEGUIDE\system\}[VmbId]{0001}[Key_VmLmStopRecAndPlay]{1}[Key_VmLmDelRecRecAgain]{2}[Key_Vm

mSaveAndPlayGreeting]{3}[Key_VmLmDeleteGoGroupPrevious]{4}[Key_VmLmDeleteAndPlay

reeting]{5}[Key_VmLmDeleteGoGroupNext]{6}[Key_VmLmSaveGoVmLogin]{8}[Key_VmLmSave

mExit]{0}[Key_VmLmSaveGoLmRecMsgMenu]{#}[RecMessage]{}[VmbWelcMsg]{C:\PROGRAM FILES\VOICEGUIDE\system\voice\VmbWelcomeMsgDefault.wav}[VmLmWelc]{timeout}[VmLmRecFilename]{0001_12080019

2_1_0_6127890299_.wav}[MsgLenMax]{18000}[Vmb_Name]{}[VmLmRec]{C:\PROGRAM FILES\VOICEGUIDE\data\VmSave\0001_1208001922_1_0_6127890299_.wav}[VmLmRec_RecLen100ms]{31}[VmLmRec_EndRe

Cause]{silence}[Hangup Time]{12/8/2006 12:19:29 AM}

001934.58 0 eng run vbs [wscript "C:\PROGRAM FILES\VOICEGUIDE\temp\vbs_0_3_1208001934.vbs" //I] copy of script in: vbs_0_3_1208001934.vbs

001934.63 0 Run Script waiting. iRunWait=1 (shellid=-1939375, process=292)

001934.63 0 timer set 1 EV_TIMEOUT_CHECKONSTATE

001934.69 0 cl Vm_VmbConfig_Get 0001, MsgLenMin

001934.69 0 vm RecLen100ms=31, MinLength for VMB0001=0

001934.74 0 cl Vm_Event 0, FORWARD, 0001, C:\PROGRAM FILES\VOICEGUIDE\data\VmSave\0001_1208001922_1_0_6127890299_.wav, ,

001934.74 0 vm frwrd vmb 0001

001934.74 0 rv lg add [VoicemailMessage0001]{C:\PROGRAM FILES\VOICEGUIDE\data\VmSave\0001_1208001922_1_0_6127890299_.wav}

001934.74 0 rv ns add [VoicemailMessage]{C:\PROGRAM FILES\VOICEGUIDE\data\VmSave\0001_1208001922_1_0_6127890299_.wav}

001934.80 0 vm frwrd vmb 0001 end

001934.80 0 cl Vm_Event 0, MSG_NEW, 0001, , ,

001934.80 0 vm MsgLamp control set to [DISABLE]

001934.80 0 cl Run_ResultReturn >>success<<

001934.85 0 rv lg add [VmLmHangup_ForwardLastMsg_ResultReturn]{success}

001934.85 0 path {success} not found

001934.85 0 cl module's runwait=1, WavPlayHasNowFinished=0

001934.85 0 rv lg add [Hangup Time]{12/8/2006 12:19:34 AM}

001934.91 0 state Hanging up call... [Run_ResultReturn - no path match (same vgm)]

001934.91 0 HangupCall_Common Mode=AfterHangupRun

001934.91 0 WriteToLogFiles_CurrScriptOnly start

001934.91 WriteToLogFiles_DoWrite start (C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLmHangup)

001934.96 0 ReinitTelephony due to IDLE

001934.96 0 tapic lineDeallocateCall(MainCall:4343296) 0

001941.66 0 lineOpen(0)=>

001941.66 0 state Waiting for a call...

001941.72 0 LineHandle=4342880

001941.72 0 ClearCallHandle called from ReinitAtIdle

001941.72 0 amchk set AMdet=False in Reinit@idle

001941.72 0 timer set 3 EV_TIMEOUT_ATERIDLE_ALLOWOUT

001942.05 dial start any summary:|0:rdy=0|

001944.96 0 timer fired EV_TIMEOUT_ATERIDLE_ALLOWOUT

001945.01 0 ScriptEventCode 9013 iLineState=900

001945.23 dial start any summary:|0:idx=0|

[SupportTeam]

I'd try reinstalling VoiceGuide. Did you edit the Voicemail scripts at all?

 

Are you sure you have included to complete trace? Bits seem to be missing...

 

When posting traces/scripts please .ZIP them up and post them as attachments.

 

001918.92 0 state [VmLmStart] Running vb script:[VmLmHangup.vgs]

001934.47 0 LoadedVgs_Find C:\PROGRAM FILES\VOICEGUIDE\system\vm\VmLmHangup.vgs at idx=3